builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0169 starttime: 1491011952.95 results: success (0) buildid: 20170331174923 builduid: 0ff69621b353414cad14b576d6b2c39e revision: 00a166a8640dffa2e0f48650f966d75ca3c1836e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:12.952289) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:12.952726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:12.953003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:12.978998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:12.979572) ========= 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.LnR97GVD4f/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.cFyFFcYQPD/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-03-31 18:59:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.7M=0s 2017-03-31 18:59:13 (24.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166298 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:13.171402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:13.171742) ========= 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.LnR97GVD4f/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.cFyFFcYQPD/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.029003 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:13.222137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-31 18:59:13.222527) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00a166a8640dffa2e0f48650f966d75ca3c1836e --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 00a166a8640dffa2e0f48650f966d75ca3c1836e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LnR97GVD4f/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.cFyFFcYQPD/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-03-31 18:59:13,234 truncating revision to first 12 chars 2017-03-31 18:59:13,234 Setting DEBUG logging. 2017-03-31 18:59:13,234 attempt 1/10 2017-03-31 18:59:13,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00a166a8640d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 18:59:15,381 unpacking tar archive at: mozilla-central-00a166a8640d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.425027 ========= master_lag: 2.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-31 18:59:17.659187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:17.663539) ========= script_repo_revision: 00a166a8640dffa2e0f48650f966d75ca3c1836e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:17.663961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:17.664232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:17.775328) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-31 18:59:17.775774) ========= /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.LnR97GVD4f/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.cFyFFcYQPD/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 18:59:17 INFO - MultiFileLogger online at 20170331 18:59:17 in /builds/slave/test 18:59:17 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 18:59:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:17 INFO - {'append_to_log': False, 18:59:17 INFO - 'base_work_dir': '/builds/slave/test', 18:59:17 INFO - 'blob_upload_branch': 'Firefox', 18:59:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:17 INFO - 'branch': 'Firefox', 18:59:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:17 INFO - 'config_files': ('talos/mac_config.py',), 18:59:17 INFO - 'default_actions': ('clobber', 18:59:17 INFO - 'read-buildbot-config', 18:59:17 INFO - 'download-and-extract', 18:59:17 INFO - 'populate-webroot', 18:59:17 INFO - 'create-virtualenv', 18:59:17 INFO - 'install', 18:59:17 INFO - 'run-tests'), 18:59:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:17 INFO - 'download_minidump_stackwalk': True, 18:59:17 INFO - 'download_symbols': 'ondemand', 18:59:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:17 INFO - 'gecko_profile': False, 18:59:17 INFO - 'gecko_profile_interval': 0, 18:59:17 INFO - 'installer_path': 'installer.exe', 18:59:17 INFO - 'log_level': 'info', 18:59:17 INFO - 'log_name': 'talos', 18:59:17 INFO - 'log_to_console': True, 18:59:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:59:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:59:17 INFO - 'opt_config_files': (), 18:59:17 INFO - 'pip_index': False, 18:59:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:17 INFO - 'cmd': ('bash', 18:59:17 INFO - '-c', 18:59:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:17 INFO - 'enabled': True, 18:59:17 INFO - 'halt_on_failure': False, 18:59:17 INFO - 'name': 'check_screen_resolution'},), 18:59:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:17 INFO - 'cmd': ('bash', 18:59:17 INFO - '-c', 18:59:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:17 INFO - 'enabled': True, 18:59:17 INFO - 'halt_on_failure': False, 18:59:17 INFO - 'name': 'check_screen_resolution'},), 18:59:17 INFO - 'run_cmd_checks_enabled': True, 18:59:17 INFO - 'suite': 'dromaeojs-e10s', 18:59:17 INFO - 'system_bits': '32', 18:59:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:17 INFO - 'title': 't-yosemite-r7-0169', 18:59:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:17 INFO - 'use_talos_json': True, 18:59:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:17 INFO - 'work_dir': 'build'} 18:59:17 INFO - [mozharness: 2017-04-01 01:59:17.899197Z] Running clobber step. 18:59:17 INFO - Running pre-action listener: _resource_record_pre_action 18:59:17 INFO - Running main action method: clobber 18:59:17 INFO - rmtree: /builds/slave/test/build 18:59:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:20 INFO - Running post-action listener: _resource_record_post_action 18:59:20 INFO - [mozharness: 2017-04-01 01:59:20.383702Z] Finished clobber step (success) 18:59:20 INFO - [mozharness: 2017-04-01 01:59:20.383824Z] Running read-buildbot-config step. 18:59:20 INFO - Running pre-action listener: _resource_record_pre_action 18:59:20 INFO - Running main action method: read_buildbot_config 18:59:20 INFO - Using buildbot properties: 18:59:20 INFO - { 18:59:20 INFO - "project": "", 18:59:20 INFO - "product": "firefox", 18:59:20 INFO - "script_repo_revision": "production", 18:59:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:59:20 INFO - "repository": "", 18:59:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:59:20 INFO - "buildid": "20170331174923", 18:59:20 INFO - "pgo_build": "False", 18:59:20 INFO - "basedir": "/builds/slave/test", 18:59:20 INFO - "buildnumber": 32, 18:59:20 INFO - "slavename": "t-yosemite-r7-0169", 18:59:20 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:59:20 INFO - "platform": "yosemite_r7", 18:59:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:59:20 INFO - "branch": "mozilla-central", 18:59:20 INFO - "repo_path": "mozilla-central", 18:59:20 INFO - "revision": "00a166a8640dffa2e0f48650f966d75ca3c1836e", 18:59:20 INFO - "stage_platform": "macosx64", 18:59:20 INFO - "builduid": "0ff69621b353414cad14b576d6b2c39e", 18:59:20 INFO - "slavebuilddir": "test" 18:59:20 INFO - } 18:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:59:20 INFO - Running post-action listener: _resource_record_post_action 18:59:20 INFO - [mozharness: 2017-04-01 01:59:20.386994Z] Finished read-buildbot-config step (success) 18:59:20 INFO - [mozharness: 2017-04-01 01:59:20.387100Z] Running download-and-extract step. 18:59:20 INFO - Running pre-action listener: _resource_record_pre_action 18:59:20 INFO - Running main action method: download_and_extract 18:59:20 INFO - mkdir: /builds/slave/test/build/tests 18:59:20 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')]} 18:59:20 INFO - trying https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:59:20 INFO - Downloading https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 18:59:21 INFO - Downloaded 1325 bytes. 18:59:21 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:59:21 INFO - Using the following test package requirements: 18:59:21 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:59:21 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:59:21 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:59:21 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:59:21 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'jsshell-mac.zip'], 18:59:21 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:59:21 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:59:21 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:59:21 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:59:21 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:59:21 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:21 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:59:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:59:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:59:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:21 INFO - Fetch https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:59:23 INFO - Expected file size: 52507896 18:59:23 INFO - Obtained file size: 52507896 18:59:40 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:59:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:59:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:40 INFO - Fetch https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:59:41 INFO - Expected file size: 52507896 18:59:41 INFO - Obtained file size: 52507896 18:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:59:58 INFO - Expected file size: 14404152 18:59:58 INFO - Obtained file size: 14404152 18:59:58 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')]} 18:59:58 INFO - trying https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:59:58 INFO - Downloading https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:59:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 19:00:00 INFO - Downloaded 75623805 bytes. 19:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:00:00 INFO - mkdir: /builds/slave/test/properties 19:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:00 INFO - Contents: 19:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:00:01 INFO - Running post-action listener: _resource_record_post_action 19:00:01 INFO - Running post-action listener: set_extra_try_arguments 19:00:01 INFO - [mozharness: 2017-04-01 02:00:01.670183Z] Finished download-and-extract step (success) 19:00:01 INFO - [mozharness: 2017-04-01 02:00:01.670313Z] Running populate-webroot step. 19:00:01 INFO - Running pre-action listener: _resource_record_pre_action 19:00:01 INFO - Running main action method: populate_webroot 19:00:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:01 INFO - '--tppagecycles', 19:00:01 INFO - '7'], 19:00:01 INFO - 'tests': ['tsvgm']}}, 19:00:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['damp', 'tps']}, 19:00:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'tests': ['damp', 'tps']}, 19:00:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['dromaeo_dom']}, 19:00:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['basic_compositor_video']}, 19:00:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:00:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['a11yr', 19:00:01 INFO - 'ts_paint', 19:00:01 INFO - 'tpaint', 19:00:01 INFO - 'sessionrestore', 19:00:01 INFO - 'sessionrestore_no_auto_restore', 19:00:01 INFO - 'tabpaint']}, 19:00:01 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:01 INFO - 'ts_paint', 19:00:01 INFO - 'tpaint', 19:00:01 INFO - 'sessionrestore', 19:00:01 INFO - 'sessionrestore_no_auto_restore', 19:00:01 INFO - 'tabpaint']}, 19:00:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:00:01 INFO - 'ts_paint', 19:00:01 INFO - 'tpaint', 19:00:01 INFO - 'sessionrestore', 19:00:01 INFO - 'sessionrestore_no_auto_restore', 19:00:01 INFO - 'tabpaint']}, 19:00:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:00:01 INFO - 'ts_paint', 19:00:01 INFO - 'tpaint', 19:00:01 INFO - 'sessionrestore', 19:00:01 INFO - 'sessionrestore_no_auto_restore', 19:00:01 INFO - 'tabpaint']}, 19:00:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['a11yr', 19:00:01 INFO - 'ts_paint', 19:00:01 INFO - 'tpaint', 19:00:01 INFO - 'sessionrestore', 19:00:01 INFO - 'sessionrestore_no_auto_restore', 19:00:01 INFO - 'tabpaint']}, 19:00:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['a11yr', 19:00:01 INFO - 'ts_paint', 19:00:01 INFO - 'tpaint', 19:00:01 INFO - 'sessionrestore', 19:00:01 INFO - 'sessionrestore_no_auto_restore', 19:00:01 INFO - 'tabpaint']}, 19:00:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['tsvgx', 19:00:01 INFO - 'tsvgr_opacity', 19:00:01 INFO - 'tart', 19:00:01 INFO - 'tscrollx', 19:00:01 INFO - 'cart', 19:00:01 INFO - 'tsvg_static']}, 19:00:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:01 INFO - 'tsvgr_opacity', 19:00:01 INFO - 'tart', 19:00:01 INFO - 'tscrollx', 19:00:01 INFO - 'cart', 19:00:01 INFO - 'tsvg_static']}, 19:00:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'talos_options': ['--disable-e10s'], 19:00:01 INFO - 'tests': ['tp5o']}, 19:00:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:00:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'talos_options': ['--disable-e10s', 19:00:01 INFO - '--xperf_path', 19:00:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:01 INFO - 'tests': ['tp5n']}, 19:00:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:00:01 INFO - 'talos_options': ['--xperf_path', 19:00:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:01 INFO - 'tests': ['tp5n']}}, 19:00:01 INFO - 'talos.zip': {'path': '', 19:00:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:01 INFO - Running post-action listener: _resource_record_post_action 19:00:01 INFO - [mozharness: 2017-04-01 02:00:01.688738Z] Finished populate-webroot step (success) 19:00:01 INFO - [mozharness: 2017-04-01 02:00:01.688872Z] Running create-virtualenv step. 19:00:01 INFO - Running pre-action listener: _resource_record_pre_action 19:00:01 INFO - Running main action method: create_virtualenv 19:00:01 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:01 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:00:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:01 INFO - Using real prefix '/tools/python27' 19:00:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:02 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:05 INFO - Installing pip.................done. 19:00:05 INFO - Return code: 0 19:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:00:05 INFO - Reading from file tmpfile_stdout 19:00:05 INFO - Output received: 19:00:05 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:00:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:05 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:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:05 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:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:05 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:05 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:00:05 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:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:05 INFO - 'HOME': '/Users/cltbld', 19:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:05 INFO - 'LOGNAME': 'cltbld', 19:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:05 INFO - 'MOZ_NO_REMOTE': '1', 19:00:05 INFO - 'NO_EM_RESTART': '1', 19:00:05 INFO - 'PAGER': '/bin/cat', 19:00:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:05 INFO - 'PWD': '/builds/slave/test', 19:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:05 INFO - 'SHELL': '/bin/bash', 19:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:05 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:05 INFO - 'USER': 'cltbld', 19:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:05 INFO - 'XPC_FLAGS': '0x0', 19:00:05 INFO - 'XPC_SERVICE_NAME': '0', 19:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:05 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:00:05 INFO - Cleaning up... 19:00:06 INFO - Return code: 0 19:00:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:06 INFO - 'HOME': '/Users/cltbld', 19:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:06 INFO - 'LOGNAME': 'cltbld', 19:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:06 INFO - 'MOZ_NO_REMOTE': '1', 19:00:06 INFO - 'NO_EM_RESTART': '1', 19:00:06 INFO - 'PAGER': '/bin/cat', 19:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:06 INFO - 'PWD': '/builds/slave/test', 19:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:06 INFO - 'SHELL': '/bin/bash', 19:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:06 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:06 INFO - 'USER': 'cltbld', 19:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:06 INFO - 'XPC_FLAGS': '0x0', 19:00:06 INFO - 'XPC_SERVICE_NAME': '0', 19:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:06 INFO - Downloading/unpacking psutil>=3.1.1 19:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:09 INFO - Installing collected packages: psutil 19:00:09 INFO - Running setup.py install for psutil 19:00:09 INFO - building 'psutil._psutil_osx' extension 19:00:09 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:00:10 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:00:10 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:00:10 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:00:10 INFO - building 'psutil._psutil_posix' extension 19:00:10 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:00:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:00:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:00:10 INFO - ^ 19:00:10 INFO - 1 warning generated. 19:00:10 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:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:10 INFO - Successfully installed psutil 19:00:10 INFO - Cleaning up... 19:00:10 INFO - Return code: 0 19:00:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:10 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:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:11 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:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:11 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:11 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:00:11 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:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:11 INFO - 'HOME': '/Users/cltbld', 19:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:11 INFO - 'LOGNAME': 'cltbld', 19:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:11 INFO - 'MOZ_NO_REMOTE': '1', 19:00:11 INFO - 'NO_EM_RESTART': '1', 19:00:11 INFO - 'PAGER': '/bin/cat', 19:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:11 INFO - 'PWD': '/builds/slave/test', 19:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:11 INFO - 'SHELL': '/bin/bash', 19:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:11 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:11 INFO - 'USER': 'cltbld', 19:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:11 INFO - 'XPC_FLAGS': '0x0', 19:00:11 INFO - 'XPC_SERVICE_NAME': '0', 19:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:15 INFO - Installing collected packages: mozsystemmonitor 19:00:15 INFO - Running setup.py install for mozsystemmonitor 19:00:15 INFO - Successfully installed mozsystemmonitor 19:00:15 INFO - Cleaning up... 19:00:15 INFO - Return code: 0 19:00:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00: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:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:15 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:15 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:00:15 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:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:15 INFO - 'HOME': '/Users/cltbld', 19:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:15 INFO - 'LOGNAME': 'cltbld', 19:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:15 INFO - 'MOZ_NO_REMOTE': '1', 19:00:15 INFO - 'NO_EM_RESTART': '1', 19:00:15 INFO - 'PAGER': '/bin/cat', 19:00:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:15 INFO - 'PWD': '/builds/slave/test', 19:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:15 INFO - 'SHELL': '/bin/bash', 19:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:15 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:15 INFO - 'USER': 'cltbld', 19:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:15 INFO - 'XPC_FLAGS': '0x0', 19:00:15 INFO - 'XPC_SERVICE_NAME': '0', 19:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:15 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:00:15 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:00:15 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:00:15 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:00:15 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:00:15 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:00:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:18 INFO - warning: no files found matching '*.txt' 19:00:18 INFO - no previously-included directories found matching 'build' 19:00:18 INFO - no previously-included directories found matching 'dist' 19:00:18 INFO - no previously-included directories found matching '.git*' 19:00:18 INFO - Installing collected packages: jsonschema, functools32 19:00:18 INFO - Running setup.py install for functools32 19:00:18 INFO - warning: no files found matching '*.txt' 19:00:18 INFO - no previously-included directories found matching 'build' 19:00:18 INFO - no previously-included directories found matching 'dist' 19:00:18 INFO - no previously-included directories found matching '.git*' 19:00:18 INFO - Successfully installed jsonschema functools32 19:00:18 INFO - Cleaning up... 19:00:18 INFO - Return code: 0 19:00:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00:18 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:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 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:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:18 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:00:18 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:00:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:18 INFO - 'HOME': '/Users/cltbld', 19:00:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:18 INFO - 'LOGNAME': 'cltbld', 19:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:18 INFO - 'MOZ_NO_REMOTE': '1', 19:00:18 INFO - 'NO_EM_RESTART': '1', 19:00:18 INFO - 'PAGER': '/bin/cat', 19:00:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:18 INFO - 'PWD': '/builds/slave/test', 19:00:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:18 INFO - 'SHELL': '/bin/bash', 19:00:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:18 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:18 INFO - 'USER': 'cltbld', 19:00:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:18 INFO - 'XPC_FLAGS': '0x0', 19:00:18 INFO - 'XPC_SERVICE_NAME': '0', 19:00:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:19 INFO - Cleaning up... 19:00:19 INFO - Return code: 0 19:00:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:19 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:19 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:00:19 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:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:19 INFO - 'HOME': '/Users/cltbld', 19:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:19 INFO - 'LOGNAME': 'cltbld', 19:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:19 INFO - 'MOZ_NO_REMOTE': '1', 19:00:19 INFO - 'NO_EM_RESTART': '1', 19:00:19 INFO - 'PAGER': '/bin/cat', 19:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:19 INFO - 'PWD': '/builds/slave/test', 19:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:19 INFO - 'SHELL': '/bin/bash', 19:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:19 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:19 INFO - 'USER': 'cltbld', 19:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:19 INFO - 'XPC_FLAGS': '0x0', 19:00:19 INFO - 'XPC_SERVICE_NAME': '0', 19:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00: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:00: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:00: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:00: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:00: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:00: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:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00: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:00: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:00: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:00: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:00: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:00: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:00:23 INFO - Downloading docopt-0.6.1.tar.gz 19:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:23 INFO - Running setup.py install for blobuploader 19:00:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:23 INFO - Running setup.py install for requests 19:00:23 INFO - Running setup.py install for docopt 19:00:24 INFO - Successfully installed blobuploader requests docopt 19:00:24 INFO - Cleaning up... 19:00:24 INFO - Return code: 0 19:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:24 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:00:24 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:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:24 INFO - 'HOME': '/Users/cltbld', 19:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:24 INFO - 'LOGNAME': 'cltbld', 19:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:24 INFO - 'MOZ_NO_REMOTE': '1', 19:00:24 INFO - 'NO_EM_RESTART': '1', 19:00:24 INFO - 'PAGER': '/bin/cat', 19:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:24 INFO - 'PWD': '/builds/slave/test', 19:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:24 INFO - 'SHELL': '/bin/bash', 19:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:24 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:24 INFO - 'USER': 'cltbld', 19:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:24 INFO - 'XPC_FLAGS': '0x0', 19:00:24 INFO - 'XPC_SERVICE_NAME': '0', 19:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:24 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ZPGsrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:24 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-t7Ng3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:24 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-GAiVL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:24 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-toJkHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:24 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vXX4YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-IpxP3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6bco7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6CKGKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ZpKqSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-O09IJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ktpcpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-BSDgOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-K3EwkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:25 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-J5Rbtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:26 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-DiEdzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:26 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-106XTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:26 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4I7ytM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:26 INFO - Running setup.py install for manifestparser 19:00:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:26 INFO - Running setup.py install for mozcrash 19:00:26 INFO - Running setup.py install for mozdebug 19:00:26 INFO - Running setup.py install for mozdevice 19:00:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozfile 19:00:27 INFO - Running setup.py install for mozhttpd 19:00:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozinfo 19:00:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozInstall 19:00:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for mozleak 19:00:27 INFO - Running setup.py install for mozlog 19:00:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:27 INFO - Running setup.py install for moznetwork 19:00:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Running setup.py install for mozprocess 19:00:28 INFO - Running setup.py install for mozprofile 19:00:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Running setup.py install for mozrunner 19:00:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Running setup.py install for mozscreenshot 19:00:28 INFO - Running setup.py install for moztest 19:00:28 INFO - Running setup.py install for mozversion 19:00:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:28 INFO - Cleaning up... 19:00:29 INFO - Return code: 0 19:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:29 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:00:29 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:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:29 INFO - 'HOME': '/Users/cltbld', 19:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:29 INFO - 'LOGNAME': 'cltbld', 19:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:29 INFO - 'MOZ_NO_REMOTE': '1', 19:00:29 INFO - 'NO_EM_RESTART': '1', 19:00:29 INFO - 'PAGER': '/bin/cat', 19:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:29 INFO - 'PWD': '/builds/slave/test', 19:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:29 INFO - 'SHELL': '/bin/bash', 19:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:29 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:29 INFO - 'USER': 'cltbld', 19:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:29 INFO - 'XPC_FLAGS': '0x0', 19:00:29 INFO - 'XPC_SERVICE_NAME': '0', 19:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ze_Exo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:29 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:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-UlPNFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:29 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:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-TgbQHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:29 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:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KZW1JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:29 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:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vpuxxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:29 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:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-f3xZUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:29 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:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:29 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-egQ47S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-__VF_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-7lDkub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-mIczei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-s3Ul7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6SNH75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-mVlRFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-awqqxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-A0pDcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:30 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:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:30 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-x9TFUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:31 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:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:31 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vKny95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:31 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:00:31 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:00:31 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:00:31 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:00:31 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:00:31 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:00:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:33 INFO - Downloading blessings-1.6.tar.gz 19:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:33 INFO - Installing collected packages: blessings 19:00:33 INFO - Running setup.py install for blessings 19:00:33 INFO - Successfully installed blessings 19:00:33 INFO - Cleaning up... 19:00:34 INFO - Return code: 0 19:00:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:34 INFO - Reading from file tmpfile_stdout 19:00:34 INFO - Current package versions: 19:00:34 INFO - blessings == 1.6 19:00:34 INFO - blobuploader == 1.2.4 19:00:34 INFO - docopt == 0.6.1 19:00:34 INFO - functools32 == 3.2.3-2 19:00:34 INFO - jsonschema == 2.5.1 19:00:34 INFO - manifestparser == 1.1 19:00:34 INFO - mozInstall == 1.12 19:00:34 INFO - mozcrash == 1.0 19:00:34 INFO - mozdebug == 0.1 19:00:34 INFO - mozdevice == 0.49 19:00:34 INFO - mozfile == 1.2 19:00:34 INFO - mozhttpd == 0.7 19:00:34 INFO - mozinfo == 0.9 19:00:34 INFO - mozleak == 0.1 19:00:34 INFO - mozlog == 3.4 19:00:34 INFO - moznetwork == 0.27 19:00:34 INFO - mozprocess == 0.25 19:00:34 INFO - mozprofile == 0.28 19:00:34 INFO - mozrunner == 6.13 19:00:34 INFO - mozscreenshot == 0.1 19:00:34 INFO - mozsystemmonitor == 0.3 19:00:34 INFO - moztest == 0.8 19:00:34 INFO - mozversion == 1.4 19:00:34 INFO - psutil == 3.1.1 19:00:34 INFO - requests == 1.2.3 19:00:34 INFO - wsgiref == 0.1.2 19:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 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 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00:34 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:00:34 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:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:34 INFO - 'HOME': '/Users/cltbld', 19:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:34 INFO - 'LOGNAME': 'cltbld', 19:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:34 INFO - 'MOZ_NO_REMOTE': '1', 19:00:34 INFO - 'NO_EM_RESTART': '1', 19:00:34 INFO - 'PAGER': '/bin/cat', 19:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:34 INFO - 'PWD': '/builds/slave/test', 19:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:34 INFO - 'SHELL': '/bin/bash', 19:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:34 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:34 INFO - 'USER': 'cltbld', 19:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:34 INFO - 'XPC_FLAGS': '0x0', 19:00:34 INFO - 'XPC_SERVICE_NAME': '0', 19:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 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:00:34 INFO - Cleaning up... 19:00:34 INFO - Return code: 0 19:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00: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:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11590890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, '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.LnR97GVD4f/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.cFyFFcYQPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:00: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', 'jsonschema'] in /builds/slave/test/build 19:00: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 jsonschema 19:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:34 INFO - 'HOME': '/Users/cltbld', 19:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:34 INFO - 'LOGNAME': 'cltbld', 19:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:34 INFO - 'MOZ_NO_REMOTE': '1', 19:00:34 INFO - 'NO_EM_RESTART': '1', 19:00:34 INFO - 'PAGER': '/bin/cat', 19:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:34 INFO - 'PWD': '/builds/slave/test', 19:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:34 INFO - 'SHELL': '/bin/bash', 19:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:34 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:34 INFO - 'USER': 'cltbld', 19:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:34 INFO - 'XPC_FLAGS': '0x0', 19:00:34 INFO - 'XPC_SERVICE_NAME': '0', 19:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:34 INFO - Cleaning up... 19:00:34 INFO - Return code: 0 19:00:34 INFO - Running post-action listener: _resource_record_post_action 19:00:34 INFO - Running post-action listener: _start_resource_monitoring 19:00:34 INFO - Starting resource monitoring. 19:00:34 INFO - [mozharness: 2017-04-01 02:00:34.907930Z] Finished create-virtualenv step (success) 19:00:34 INFO - [mozharness: 2017-04-01 02:00:34.908922Z] Running install step. 19:00:34 INFO - Running pre-action listener: _resource_record_pre_action 19:00:34 INFO - Running main action method: install 19:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:35 INFO - Reading from file tmpfile_stdout 19:00:35 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:35 INFO - Reading from file tmpfile_stdout 19:00:35 INFO - Output received: 19:00:35 INFO - Usage: mozinstall [options] installer 19:00:35 INFO - Options: 19:00:35 INFO - -h, --help show this help message and exit 19:00:35 INFO - -d DEST, --destination=DEST 19:00:35 INFO - Directory to install application into. [default: 19:00:35 INFO - "/builds/slave/test"] 19:00:35 INFO - --app=APP Application being installed. [default: firefox] 19:00:35 INFO - mkdir: /builds/slave/test/build/application 19:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:00:55 INFO - Reading from file tmpfile_stdout 19:00:55 INFO - Output received: 19:00:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:00:55 INFO - Running post-action listener: _resource_record_post_action 19:00:55 INFO - [mozharness: 2017-04-01 02:00:55.421471Z] Finished install step (success) 19:00:55 INFO - [mozharness: 2017-04-01 02:00:55.421593Z] Running run-tests step. 19:00:55 INFO - Running pre-action listener: _resource_record_pre_action 19:00:55 INFO - Running main action method: run_tests 19:00:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:00:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:00:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:00:55 INFO - 2017-03-31 19:00:55.435 screenresolution[1623:7535] starting screenresolution argv=screenresolution get 19:00:55 INFO - 2017-03-31 19:00:55.438 screenresolution[1623:7535] Display 0: 1600x1200x32@60 19:00:55 INFO - 2017-03-31 19:00:55.443 screenresolution[1624:7537] starting screenresolution argv=screenresolution list 19:00:55 INFO - Available Modes on Display 0 19:00:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:00:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:00:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:00:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:00:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:00:55 INFO - Intel Iris: 19:00:55 INFO - Chipset Model: Intel Iris 19:00:55 INFO - Type: GPU 19:00:55 INFO - Bus: Built-In 19:00:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:00:55 INFO - Vendor: Intel (0x8086) 19:00:55 INFO - Device ID: 0x0a2e 19:00:55 INFO - Revision ID: 0x0009 19:00:55 INFO - Displays: 19:00:55 INFO - Display: 19:00:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:00:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:00:55 INFO - Display Serial Number: 1600x1200 60 19:00:55 INFO - Main Display: Yes 19:00:55 INFO - Mirror: Off 19:00:55 INFO - Online: Yes 19:00:55 INFO - Rotation: Supported 19:00:55 INFO - Return code: 0 19:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:55 INFO - Python 2.7.3 19:00:55 INFO - Return code: 0 19:00:55 INFO - grabbing minidump binary from tooltool 19:00:55 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:00:55 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 0x1077a8d30>, '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 0x1076cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10779dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:55 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:00:55 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:00:55 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:00:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:55 INFO - Return code: 0 19:00:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:00:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:55 INFO - ENV: RUST_BACKTRACE is now 1 19:00:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:00:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:55 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/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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:00:55 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/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --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:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LnR97GVD4f/Render', 19:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:55 INFO - 'HOME': '/Users/cltbld', 19:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:55 INFO - 'LOGNAME': 'cltbld', 19:00:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:55 INFO - 'MOZ_NO_REMOTE': '1', 19:00:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:55 INFO - 'NO_EM_RESTART': '1', 19:00:55 INFO - 'PAGER': '/bin/cat', 19:00:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:55 INFO - 'PWD': '/builds/slave/test', 19:00:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:55 INFO - 'RUST_BACKTRACE': '1', 19:00:55 INFO - 'SHELL': '/bin/bash', 19:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cFyFFcYQPD/Listeners', 19:00:55 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 19:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:55 INFO - 'USER': 'cltbld', 19:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:55 INFO - 'XPC_FLAGS': '0x0', 19:00:55 INFO - 'XPC_SERVICE_NAME': '0', 19:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:55 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/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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:00:56 INFO - mozversion application_buildid: 20170331174923 19:00:56 INFO - mozversion application_changeset: 00a166a8640dffa2e0f48650f966d75ca3c1836e 19:00:56 INFO - mozversion application_display_name: Nightly 19:00:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:56 INFO - mozversion application_name: Firefox 19:00:56 INFO - mozversion application_remotingname: firefox 19:00:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:56 INFO - mozversion application_vendor: Mozilla 19:00:56 INFO - mozversion application_version: 55.0a1 19:00:56 INFO - mozversion platform_buildid: 20170331174923 19:00:56 INFO - mozversion platform_changeset: 00a166a8640dffa2e0f48650f966d75ca3c1836e 19:00:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:56 INFO - mozversion platform_version: 55.0a1 19:00:56 INFO - using testdate: 1491012056 19:00:56 INFO - actual date: 1491012056 19:00:56 INFO - starting webserver on 'localhost:49250' 19:00:56 INFO - SUITE-START | Running 2 tests 19:00:56 INFO - TEST-START | dromaeo_css 19:00:56 INFO - operating with platform_type : mac_ 19:00:56 INFO - Initialising browser for dromaeo_css test... 19:00:56 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp_6pnIT/profile http://localhost:49250/getInfo.html) 19:00:58 INFO - PID 1634 | 2017-03-31 19:00:58.976 plugin-container[1636:7717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 19:00:58 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:00:58 INFO - PID 1634 | 2017-03-31 19:00:58.981 plugin-container[1636:7717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d1f, name = 'com.apple.CFPasteboardClient' 19:00:58 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:00:58 INFO - PID 1634 | 2017-03-31 19:00:58.981 plugin-container[1636:7717] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:00:59 INFO - PID 1634 | __metrics Screen width/height:1600/1200 19:00:59 INFO - PID 1634 | colorDepth:24 19:00:59 INFO - PID 1634 | Browser inner width/height: 1024/689 19:00:59 INFO - PID 1634 | __metrics 19:00:59 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 19:00:59 INFO - TEST-INFO | 1634: exit 0 19:00:59 INFO - Browser initialized. 19:00:59 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:59 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp_6pnIT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:02 INFO - PID 1637 | 2017-03-31 19:01:02.450 plugin-container[1638:7854] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 19:01:02 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:01:02 INFO - PID 1637 | 2017-03-31 19:01:02.451 plugin-container[1638:7854] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 19:01:02 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:01:02 INFO - PID 1637 | 2017-03-31 19:01:02.451 plugin-container[1638:7854] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:01:12 INFO - PID 1637 | RSS: Main: 229490688 19:01:12 INFO - PID 1637 | 19:04:16 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 19:04:17 INFO - PID 1637 | RSS: Main: 257564672 19:04:17 INFO - PID 1637 | 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 19:06:00 INFO - PID 1637 | 19:06:00 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:06:00 INFO - PID 1637 | Full stack: 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 19:06:00 INFO - PID 1637 | 19:06:00 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:06:00 INFO - PID 1637 | Full stack: 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 19:06:00 INFO - PID 1637 | 19:06:00 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:06:00 INFO - PID 1637 | Full stack: 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | ************************* 19:06:00 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 19:06:00 INFO - PID 1637 | 19:06:00 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:06:00 INFO - PID 1637 | Full stack: 19:06:00 INFO - PID 1637 | ************************* 19:07:20 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 19:07:20 INFO - PID 1637 | RSS: Main: 264286208 19:07:20 INFO - PID 1637 | 19:10:22 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 19:10:23 INFO - PID 1637 | RSS: Main: 275402752 19:10:23 INFO - PID 1637 | 19:13:25 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 19:13:25 INFO - PID 1637 | RSS: Main: 268300288 19:13:25 INFO - PID 1637 | 19:16:28 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 19:16:29 INFO - PID 1637 | RSS: Main: 278720512 19:16:29 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 19:19:32 INFO - PID 1637 | RSS: Main: 272363520 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | __start_tp_report 19:19:32 INFO - PID 1637 | _x_x_mozilla_page_load 19:19:32 INFO - PID 1637 | _x_x_mozilla_page_load_details 19:19:32 INFO - PID 1637 | |i|pagename|runs| 19:19:32 INFO - PID 1637 | |0;dojo.html;3138.795978261413;3380.3915295246848;3457.94813077804;3654.2508785698933;3665.9266814663706;6131.896637733218;6250.84372890678;6251.531135164858;6282.308946015934;6283.246010478749;5056.988602279541;5779.104238842976;6128.2281383986465;6198.194234749488;6267.185265915425;5116.309298244745;5416.620836541444;5425.647332923348;5442.210879422501;5524.8342549723575;4881.389826271716;5501.284832971728;5541.445855414447;5577.972110139443;5629.127485239795;5366.490183432567;5410.648307859977;5534.640248383842;5541.806036788734;5584.1902924075985;5424.321959755031;5458.317710286215;5459.590530710213;5515.531179849718;5569.331680198362;4107.815148318333;5381.354237491526;5446.836594902159;5448.210009548593;5513.972430137824;4541.069080838421;6051.697415129226;6132.50939924805;6268.717907694119;6285.560010799246;6396.776112836028;6459.806205813786;6599.142111525519;6672.132622759059;6689.397954184098;5621.213030175779;6761.256261811246;6791.252962174157;6795.354441328066;6802.14973128359;6183.041628547582;6335.556511044183;6342.9365706342805;6347.619142851398;6348.904766428507;6625;6760.087388202628;6906.136732908387;6937.993990871295;6962.477814163958;6313.905291420632;6369.235691717024;6426.4537514311805;6461.418472337512;6540.4767618590395;6748.156480439945;6749.392554670005;6761.290064543152;6776.186857577122;6790.830229244309;6561.179852518435;6680.064790929274;6680.665966701646;6687.531872768956;6692.0296556998965;6376.39424254695;6477.676116194266;6484.675766211671;6667.299933506912;6695.832604184837;5303.946960530422;5321.5476684482255;5330.680159190461;5338.706371149624;5351.224072509464;4734.976325118421;4782.665213435026;4809.519048095162;4815.975920120377;4847.006363695434;6330.968345158337;6383.489320854321;6389.712462939179;6392.4246817786625;6399.7440102395385;6432.035194720829;6523.64119973406;6782.728690852311;6791.117154769849;6796.898046529306;6332.746690132435;6345.777897773556;6365.427111559982;6391.904121438182;6404.647744374011;5914.733836977346;5957.4042595740075;5987.042073268256;5988.221531200916;6045.244344456943;6407.935920640921;6906.37842594169;6949.131358580177;6985.79042628722;6988.615626140408;5843.474087332161;5969.403059693996;6265.655388953652;6434.131392262172;6463.967680161569;6884.93115068863;6903.0335752993615;6918.93081069203;6928.411085057826;6928.549644273106;6542.1168142300185;6561.606303621798;6573.112629794917;6594.241662208908;6600.669966501751;6361.459275961595;6478.157839481026;6601.306862779339;6643.966780166068;6666.2333831609985;6383.648899310582;6493.8701225976165;6507.186601674791;6514.609123452608;6534.509911756542;6268.686565671607;6287.96856015717;6419.582727122722;6537.411632953057;6553.311902250386;5655.462731040545;6377.840553986188;6409.71156297977;6416.069669897932;6420.871582568229;6294.244690637152;6358.237011558643;6456.354364563506;6460.192475940507;6591.736330546724;6292.465140463112;6319.399657032574;6324.557280990287;6331.145295385064;6344.619322840645 19:19:32 INFO - PID 1637 | |1;ext.html;689.3347919257915;719.1585844561862;813.6135335715534;1030.96391626293;1281.7949128139498;39255.485619153806;39540.99999999996;39630.80184599073;39648.80175599122;39693.40459893104;39184.82445526639;39602.60397396025;39725.60274397255;39741.60258397415;39751;8111.797205069876;8683.739487815345;8902.376833621649;8939.284857211407;8959.552022398853;8871.112888711143;8925.910740892605;8943.373963822534;8962.327825413087;8976.506292153928;8906.109389061106;8960;8981.77545561363;9019.052999435064;9026.593803278869;7448.77653670388;8924.286057115416;8942.374033817636;8947;8957.686480973134;6384.265809431929;6413.967930160366;6423.325550817191;6426.260979987314;6429.8392540186405;38504.80747596272;38621.613783862085;38705.80647096775;38788.80605596954;38880.805595972124;3047.6495203051713;3056.847157642131;3070.8311042892633;3074.415860986428;3091.984540077308;27761.583576246372;27799.86100069507;28010.159695209175;28072.438551229065;28591.856325746947;2777.277907743981;2802.8738706758245;2824.002028508497;2829.5755636654667;2914.9271268218463;278273;283229;303324;306315;312150;49346.75326623344;49428;49554.50445495571;49744.50255497399;49804.75097624561;40872.59127408747;49416.752916235906;51721;52394;52398.73800631049;14290.356933937997;14337.78493322601;14361.784573231409;14399.64000899965;14415.351309191112;9851.45816980073;10414.687559373231;10427.635032773816;11600.245984011011;11808.763824723457;11284.435778211056;13725.45098196081;13781;13818.447262109605;13937.721245575032;5051.3433253676785;5988.850278743066;6000.459958603747;6004.819855404345;6021.939780602138;937.1425145991342;945.4421891084294;964.4261664309724;967.1537404770826;1014.8477728340661;17979.820201798077;22392.10431582751;23897.641535376635;24284.75715242825;24410;971.9891313034365;1051.264115119404;1067.8451624514403;1099.2525082943675;1102.1788767368362;11481.598144065085;12205.084618653636;12233.877661223452;12286.938565307295;12359.50561977511;475550;479545.02274886117;479557;481290;481466;55770;55896.44103558994;55901.88196236052;56108;56316.71841640765;1466.5233799015364;1511.4332125452954;1516.9848301517063;1521.6500204952702;1523.070926734691;18648.34730784416;23796.286111416684;23846.359557461536;24024.51950960936;24060;38878.500934915995;38910.6381276654;38968.61031389763;39080.41379379368;39228.215435691694;441413;441578;442727;443391;444518;28274.151775446768;28638.133851929724;28652;32979;33265.667343326255;34850.30299393947;34901.65098348984;35358.292834143685;35414.29171416609;35488;22626.760878537218;24274.635880461454;25238.242852714448;26312.605310919967;26618.733812661627;25678.61482077733;26298.60552091682;26983.595246071716;29095;30541.694583053886;35207.47188792221;36140.819295903355;36344.81827590845;36826.079348016516;36949.26101477902;27331.72668273292;29121.004227179386;29961;30171.396572067995;30490.237744056576;19079.427617171506;21342.270481937307;22200;23262.3021309361;24060.39849003789 19:19:32 INFO - PID 1637 | |2;jquery.html;424.97025208235436;435.6231859441582;436.69867791224056;446.2881703682626;447.93504941783465;19906.502337441572;21803.127874885005;22355.10579576815;22525.887370563145;22975;22593.887030564867;22678;23484.882575587097;23648.290551283448;23853.9265733042;6092.299385570672;6303.842403939904;6459.61242325462;6535.477161827066;6542.901856472156;6397.360263973612;6405.42351188393;6483.7082331295205;6487.253965793923;6566.015097735354;5931.228940237763;6347.523935704818;6370.331115232903;6396.5202609804455;6419.101325814389;6001.7299221534695;6285.245770507523;6286.119943207955;6336.303006669263;6351.555391122623;5377.274068000848;5559.305086864142;5580.302462192226;5603.523700485463;5605.803796867131;27178.776955037072;27689.307767305778;27972;28039.158825235274;28482;1965.1156979359346;1986.6622674145285;2028.7464066991627;2073.3365323096614;2077.1276064053136;13839.723205535933;15905.681886362323;16310.673786524321;17126.743098853527;17497.037662928535;1853.5829438376393;1868.953276168093;1907.9236830526763;1924.7706603596166;1943.9125239364262;118544;127683.08475372876;147525.2623736885;158732.99999999884;159309;12361.443735031946;12601.558945436866;12629.115961882764;12665.303408312448;12817.935910320388;16138.273777680033;16239;16419.6716065678;16445.83554164467;16477;8741.956290218508;8992.415492992934;9032.23226025782;9158.40470369424;9240.722778316527;7321.670524826395;8419;8572.442791218551;8606.13938606147;8780.341474389319;6592.571482853599;7819.843603127905;7977.800554986172;8002.319802816709;8017;1802.4682718598044;2120.4062862398555;2132.9761714376878;2143.6570148776123;2295.73599036113;820.2330820682562;881.9162179593056;915.2494954137543;943.4999450291357;965.6041023180462;18108.456746297634;19579.021048947496;19887.619104752226;20671.689924651142;20711.689324660143;924.902885197058;955.460165006769;975.3611384543135;984.9359791613522;996.2976101848179;10252.077313041862;10360.119389851796;10399.220058495643;10663.626773062906;10698.304610200312;678050.6097469481;691559.0844091595;696182;708301;710589;126354;152954.47045529625;160894;161398;161467;1123.07346439188;1148.3913525831322;1167.3696204049718;1170.9648710538697;1171.3616079236836;17621.559461013065;17902.641947160722;18001.729974050137;18109.909450452662;18123.275068997093;62024.68987655033;63755.68122159359;63827;64181.679091604245;64772.67613661902;89415.55292223497;89421;91386;91512;92439;8353.624086915981;8536.061033286458;8558.871616925875;8694.34792390586;8838.160374764388;13301.600951971457;13469.259190744604;13509.256990865597;13529.932350338186;14021.439142434188;9523.571439285388;11471.738108808191;11497.367644779617;11528.423578821194;11531.365774882463;10838.295510791773;10984.670459886216;11068.557257709923;11214.775704486028;11356.829647555129;11480.712982175179;11693.824592630946;12046.397680115784;12080.697982550506;12116.21244619097;6316.747330106744;8233.917660823554;8396.916030839613;8562.74311770648;8650.697225597074;11455.427228638702;11485.598004070152;11642.068634509389;11774.882251177378;11879 19:19:32 INFO - PID 1637 | |3;mootools.html;1286.3825363825363;1471.6541612721016;1476.564413498018;1479.4452080469823;1498.5878883307093;10655.307405018668;10744.355338679685;11008.449577521133;11064.39145846979;11117.277376970502;10692.037716605504;10802.5678972841;10839.349639021664;10839.458027098653;10880;2436.4030812450974;2455.8772061396858;2460.520198561281;2463.051725085846;2473.9010439582485;2396.641116440295;2415.7342692303832;2448.840825346356;2458.532878753031;2468.876556172193;2381.583222935988;2425.9029638814427;2441.865697386643;2464.2237695125978;2468.7778099971;2371.3715865295712;2410.1323523531514;2419.4314336131083;2426.6481360202847;2456.152627343564;1886.9528261793428;2359.0681680736184;2412.0954642009247;2428.878556072207;2456.742042085591;10946;11020.944895275472;11033.779324413546;11067.612633557867;11087.168462365275;6230.2523697156175;6442.710078046499;6464.191976003;6469.417752402306;6488.8702225955685;3372.9831350843333;3885.795403424919;3886.553046399672;4085.9795701021603;4154.646855017327;1171.7305019845483;1191.201894730524;1193.7672153929987;1216.8843959823803;1227.5028613411582;13885.722285554333;14369.425222991173;14657.780133298009;14689.338979745937;14765.704685906328;5370.248165256867;5499.367572729107;5526.143447765603;5545.611807173459;5548.0845660465575;11540.884591153981;11541.07671386287;11582.594609188638;11597.18819682631;11641.941790290994;6109.175261339662;6271.843203919939;6273.843153921189;6279.089532017923;6289.465395441347;5911.231539899872;5930.43660852227;6003.159557661931;6031.276246850406;6037.758489660452;4300.80646370914;4304.354346847936;4352.717073390219;4376.299792033259;4384.298512238027;1292.4442489729506;1298.0459362368651;1306.6798634334648;1310.1484035377082;1310.5845686658386;757.9014728085314;759.8905597827123;777.992220077792;778.381186956371;796.3390385979623;5346.91979620306;5878.676672782953;5882.176495290662;6083.9391606084255;6090.786822461193;503.2526697853684;561.5058748301468;577.6707276852238;581.9912701309484;589.5048159545917;3651.8539258429364;4046.190761847642;4074.144429669743;4192.958070419318;4265.978670106691;13443.32783360828;13851.515196968057;14055.78916316256;14075.366608502642;14089.506867259597;13820.792688109686;13985.65035874091;13989.510367137102;13999.720005599831;14011.229382383863;9009.864852027225;9058.00361960184;9711.223102151811;10123.645672401577;10230.07929286353;5075.619328550448;6615.17310336208;6704.564203326768;6799.864002719819;6859.691313890987;9739.366941148803;12327.568535101229;12456.508698260202;12612.810807838074;12613.684657883627;11879.22785018971;12246.142770006014;12461.813072803734;12470.875291246972;12590.811137832756;8993.595288212176;9107.453552786854;9277.211437027929;9294.302927280616;9296.814063718553;10230.6419275325;10263.794724105326;10265.74335641615;10363.06732394088;10364.067233948981;7357.448191385561;8588.441751286146;8787.692430764893;8793.560321983747;8889.599968001585;8451;8518.190771876662;8565.100664430394;8605.569721514024;8756.343274254328;7522.661480233293;7777.455578109478;7811.609419528887;7843.137254902071;7866.174051724715;5711.228984087095;5769.711514424346;5825.184474173704;5994.100884867305;6017.518598512196;5667.659940403589;5739.9139012915675;5925.229720136354;5946.910796337972;5993.0710739835395 19:19:32 INFO - PID 1637 | |4;prototype.html;382.31183869035766;391.2859032266115;395.2943994968981;400.90378309205784;402.9133736246707;6242.250929888414;6301.810945671631;6428.646424446653;6458.580192287498;6481.287058423582;4792.90414191716;5086.321513900413;5537.8370542186085;5925.666724986876;6206.317305096447;3424.7842016084305;4000.959990400088;4352.869413917588;4482.260427029544;4742.691725037878;4691.272852707836;4726.858194254178;4739.194336962707;4758.167320718878;4758.571728544431;3628.87298944537;4407.6722074833615;4538.319252112193;4592.150452166343;4698.224792909165;3870.4968354114067;3986.402039694069;4667.953320466786;4686.992296656218;4693.812247510095;4126.298529250034;4129.318662420697;4130.29465699967;4135.855245066438;4168.895242760671;5367.704776237305;5885.676287804169;6120;6146.723397447081;6209.223847019122;5293.729504918831;5453.563714902798;5536.723163841792;5541.473560011793;5560.471755183251;5817.38917413674;5893.5541750173625;6587.341265873422;6718.227403848571;6737.124173857367;3700.5189325387796;3734.551853777537;4452.821887124511;4629.213033784265;4683.437987441529;6146.723397447081;6174.84562885927;6453.419192272718;6852.383285504328;7079.362857342812;4482.8655140345845;4858.05267972749;4872.707637541759;4889.828855990023;4893.168161412497;3924.5290565131795;4358.106588149421;4967.186976753459;4975.353204083446;5048.899022019539;5422.783088676409;5589.80435684749;5656;5660.405657405995;5671.731307477042;6339.873202535923;6364.459020983269;6746.628935408501;6758.398016763582;6835.897461538081;1548.5044785668479;1670.2400407814416;1674.849263566285;1679.219163089145;1684.9663006740043;850.8808766772656;879.6657270237397;950.3205208275978;982.5382070426888;1025.266934142092;6450.451711604473;6461.903071453932;6473.385028422293;6494.577852439671;6509.2839787623325;6692.966535167293;6914.757983470655;7006.299370062953;7032.382552013066;7055.964720176469;6000.759969601254;6367.140436041075;6426.710798014101;6458.321876203025;6557.934420655828;2934.794564380473;3325;3510.543629328171;3561.5918888711417;3678.319510890494;6544.9672751635935;6571.3757193066585;7174.1032370953635;7189.89215161773;7221.24176961422;6175.888340098735;6778.796636100925;7191.676374563157;7193.9280607194305;7200.747973820891;6813.625250611165;7118.893216601755;7173.892391614234;7195.424366050808;7227.674754635948;5749.281339832521;6945.617991010341;6959.61722105289;6964.930350696428;6985.7205711772995;6058.606190597597;6559.8032059038305;6564.4748420127235;6794.660266986532;6869.828254293682;5691.402402747652;7001.569231076837;7108.147022357351;7259.12890453149;7274.6726397313305;4196.097629204869;4486.820527178877;4505.594496495331;4523.755967108939;4537.705049171794;6063.939360606338;6678.465722742266;6709.463242940651;6946.722131114901;7007.684654190675;5379.704116273642;5922.785828904978;6744;6753.493487988519;6760.22257440381;6456.289083392999;6682;6747.730090796314;6772.796816095525;6774.322567743384;6595.835104122435;6601.966990165019;6605.603663780189;6622.735090596515;6631.523721488073;5402.027635025576;6494.6103233806125;6791.3548212919695;6797.626130562669;6842.536686792651;5998.040313549811;6044.063170208625;6566.534756365717;6566.540342176002;6566.704498297492 19:19:32 INFO - PID 1637 | |5;yui.html;720.5676594043578;741.547655929883;741.9480636355454;746.451358251685;750.9211532789056;13575.185488870675;16066.59833504163;16437.931534450254;16451.506454806346;16457.670846583074;14901.776473352882;15004.549863504086;15036.548903532912;15037.849621503781;15059.17174555399;962.6967505235829;969.5927710361665;987.7382493639192;1019.2661283875598;1022.3099407899675;1012.691129205592;1021.2136654775818;1025.0364657222224;1025.374521541859;1025.461632642861;1038.8130136575414;1054.4674939155755;1066.0938202527827;1067.5943141606178;1071.132382769959;1038.6364772329623;1058.3596923861069;1058.915286777056;1061.9203559733012;1065.4672663668166;780.6604127204685;787.6731156570074;791.1297572670074;791.3589992106355;792.9286364227247;15844.841551584452;15948.2823272953;16121.516354509384;16528.00831950087;16573.08848013359;14799.852001479954;14803.55589332311;14845.406183752637;14925.328360223815;15769.871067405868;11425.714357141054;11778.175527713063;11782.705432364173;11958.880411195863;12299.754004919852;2476.777090061903;2634.4204275059456;2640.7755340796057;2748.8625568721486;2867.885284588614;94553;105666;107049.46475267573;112965;117542;9510.857337139949;10534.188993103855;11194.776104477865;11619.186656933933;11739.354335511629;18855.340063097727;19745.506362341057;24620.384490387885;24624.507509849704;24639.014439422222;7994.2805147537;8037.678492860337;8085;8345.95827020861;8367.246947774729;4051.2505186539993;4085.7752823594988;4160.708750387444;4185.560516145761;4282.528921818597;3431.759776815649;4250.149970006011;4250.659947204216;4251.553586873396;4258.339957306623;845.8984921809422;884.6372987075268;885.0662551008747;885.2784980241212;886.8093359927517;549.4779959038929;564.8249042796746;571.6113043130711;574.4513989140445;584.4126652713995;8979;8996.640134394682;9030.909690903138;9743.317967742332;9844.80310393788;573.1202604002835;577.5956830218863;591.3081694417542;595.6642800318183;595.85401576614;4571.531193566695;4623.9075218495445;4633.235516139799;4661.588510672105;4765.332853400527;97164;100118.49822252672;104073.47963260135;104539.95460045454;106716.46641766897;66698.03750631494;88988;89136.5543172293;90875.09124908799;93425.53287233657;74706;75730.62134689401;75775.62112189514;76608;77296;10246.846297305397;10458.529366178693;10577.100946419332;10694.358338499715;10761.784764304513;36983.63016369802;37382.25235495329;37548.62451375451;37613;38849.6115038846;37512.812435937645;48837.7790555239;49603.50396496133;49792.25311620256;50054.49945500498;9667.854982175413;12125.69685757863;12299.262044277371;12794.808077879026;13259.071864969359;13805.17168969865;13943.930280348533;13949.4420223194;14063.156210627396;14177.645558861112;10969.616063437741;13097.672558186121;13133.408996595368;13161.60515184546;13442.731145377233;10975.341479511255;12957.028222883133;13365.26491043002;13378.665533361744;13618.727625447238;12723.359627017293;12753.872461275269;12904.354782261038;12953.093283470067;13661.043726939417;9222.308326875376;9415.153848064281;9545.093216144454;9665;9676.661316853877;10716.892831071902;10740.087092597218;10888.183386245904;10892.346459212473;10927.071198948179 19:19:32 INFO - PID 1637 | __end_tp_report 19:19:32 INFO - PID 1637 | __start_cc_report 19:19:32 INFO - PID 1637 | _x_x_mozilla_cycle_collect,432 19:19:32 INFO - PID 1637 | __end_cc_report 19:19:32 INFO - PID 1637 | __startTimestamp1491013172665__endTimestamp 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | ------- Summary: start ------- 19:19:32 INFO - PID 1637 | Number of tests: 6 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:6108.20 Median:6358.24 stddev:745.09 (11.7%) stddev-sans-first:710.03 19:19:32 INFO - PID 1637 | Values: 3138.8 3380.4 3457.9 3654.3 3665.9 6131.9 6250.8 6251.5 6282.3 6283.2 5057.0 5779.1 6128.2 6198.2 6267.2 5116.3 5416.6 5425.6 5442.2 5524.8 4881.4 5501.3 5541.4 5578.0 5629.1 5366.5 5410.6 5534.6 5541.8 5584.2 5424.3 5458.3 5459.6 5515.5 5569.3 4107.8 5381.4 5446.8 5448.2 5514.0 4541.1 6051.7 6132.5 6268.7 6285.6 6396.8 6459.8 6599.1 6672.1 6689.4 5621.2 6761.3 6791.3 6795.4 6802.1 6183.0 6335.6 6342.9 6347.6 6348.9 6625.0 6760.1 6906.1 6938.0 6962.5 6313.9 6369.2 6426.5 6461.4 6540.5 6748.2 6749.4 6761.3 6776.2 6790.8 6561.2 6680.1 6680.7 6687.5 6692.0 6376.4 6477.7 6484.7 6667.3 6695.8 5303.9 5321.5 5330.7 5338.7 5351.2 4735.0 4782.7 4809.5 4816.0 4847.0 6331.0 6383.5 6389.7 6392.4 6399.7 6432.0 6523.6 6782.7 6791.1 6796.9 6332.7 6345.8 6365.4 6391.9 6404.6 5914.7 5957.4 5987.0 5988.2 6045.2 6407.9 6906.4 6949.1 6985.8 6988.6 5843.5 5969.4 6265.7 6434.1 6464.0 6884.9 6903.0 6918.9 6928.4 6928.5 6542.1 6561.6 6573.1 6594.2 6600.7 6361.5 6478.2 6601.3 6644.0 6666.2 6383.6 6493.9 6507.2 6514.6 6534.5 6268.7 6288.0 6419.6 6537.4 6553.3 5655.5 6377.8 6409.7 6416.1 6420.9 6294.2 6358.2 6456.4 6460.2 6591.7 6292.5 6319.4 6324.6 6331.1 6344.6 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:53295.23 Median:35451.15 stddev:110252.79 (311.0%) stddev-sans-first:110491.33 19:19:32 INFO - PID 1637 | Values: 689.3 719.2 813.6 1031.0 1281.8 39255.5 39541.0 39630.8 39648.8 39693.4 39184.8 39602.6 39725.6 39741.6 39751.0 8111.8 8683.7 8902.4 8939.3 8959.6 8871.1 8925.9 8943.4 8962.3 8976.5 8906.1 8960.0 8981.8 9019.1 9026.6 7448.8 8924.3 8942.4 8947.0 8957.7 6384.3 6414.0 6423.3 6426.3 6429.8 38504.8 38621.6 38705.8 38788.8 38880.8 3047.6 3056.8 3070.8 3074.4 3092.0 27761.6 27799.9 28010.2 28072.4 28591.9 2777.3 2802.9 2824.0 2829.6 2914.9 278273.0 283229.0 303324.0 306315.0 312150.0 49346.8 49428.0 49554.5 49744.5 49804.8 40872.6 49416.8 51721.0 52394.0 52398.7 14290.4 14337.8 14361.8 14399.6 14415.4 9851.5 10414.7 10427.6 11600.2 11808.8 11284.4 13725.5 13781.0 13818.4 13937.7 5051.3 5988.9 6000.5 6004.8 6021.9 937.1 945.4 964.4 967.2 1014.8 17979.8 22392.1 23897.6 24284.8 24410.0 972.0 1051.3 1067.8 1099.3 1102.2 11481.6 12205.1 12233.9 12286.9 12359.5 475550.0 479545.0 479557.0 481290.0 481466.0 55770.0 55896.4 55901.9 56108.0 56316.7 1466.5 1511.4 1517.0 1521.7 1523.1 18648.3 23796.3 23846.4 24024.5 24060.0 38878.5 38910.6 38968.6 39080.4 39228.2 441413.0 441578.0 442727.0 443391.0 444518.0 28274.2 28638.1 28652.0 32979.0 33265.7 34850.3 34901.7 35358.3 35414.3 35488.0 22626.8 24274.6 25238.2 26312.6 26618.7 25678.6 26298.6 26983.6 29095.0 30541.7 35207.5 36140.8 36344.8 36826.1 36949.3 27331.7 29121.0 29961.0 30171.4 30490.2 19079.4 21342.3 22200.0 23262.3 24060.4 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:40395.20 Median:23229.94 stddev:116755.48 (502.6%) stddev-sans-first:117044.44 19:19:32 INFO - PID 1637 | Values: 425.0 435.6 436.7 446.3 447.9 19906.5 21803.1 22355.1 22525.9 22975.0 22593.9 22678.0 23484.9 23648.3 23853.9 6092.3 6303.8 6459.6 6535.5 6542.9 6397.4 6405.4 6483.7 6487.3 6566.0 5931.2 6347.5 6370.3 6396.5 6419.1 6001.7 6285.2 6286.1 6336.3 6351.6 5377.3 5559.3 5580.3 5603.5 5605.8 27178.8 27689.3 27972.0 28039.2 28482.0 1965.1 1986.7 2028.7 2073.3 2077.1 13839.7 15905.7 16310.7 17126.7 17497.0 1853.6 1869.0 1907.9 1924.8 1943.9 118544.0 127683.1 147525.3 158733.0 159309.0 12361.4 12601.6 12629.1 12665.3 12817.9 16138.3 16239.0 16419.7 16445.8 16477.0 8742.0 8992.4 9032.2 9158.4 9240.7 7321.7 8419.0 8572.4 8606.1 8780.3 6592.6 7819.8 7977.8 8002.3 8017.0 1802.5 2120.4 2133.0 2143.7 2295.7 820.2 881.9 915.2 943.5 965.6 18108.5 19579.0 19887.6 20671.7 20711.7 924.9 955.5 975.4 984.9 996.3 10252.1 10360.1 10399.2 10663.6 10698.3 678050.6 691559.1 696182.0 708301.0 710589.0 126354.0 152954.5 160894.0 161398.0 161467.0 1123.1 1148.4 1167.4 1171.0 1171.4 17621.6 17902.6 18001.7 18109.9 18123.3 62024.7 63755.7 63827.0 64181.7 64772.7 89415.6 89421.0 91386.0 91512.0 92439.0 8353.6 8536.1 8558.9 8694.3 8838.2 13301.6 13469.3 13509.3 13529.9 14021.4 9523.6 11471.7 11497.4 11528.4 11531.4 10838.3 10984.7 11068.6 11214.8 11356.8 11480.7 11693.8 12046.4 12080.7 12116.2 6316.7 8233.9 8396.9 8562.7 8650.7 11455.4 11485.6 11642.1 11774.9 11879.0 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:6740.03 Median:2923.44 stddev:4150.64 (142.0%) stddev-sans-first:4142.05 19:19:32 INFO - PID 1637 | Values: 1286.4 1471.7 1476.6 1479.4 1498.6 10655.3 10744.4 11008.4 11064.4 11117.3 10692.0 10802.6 10839.3 10839.5 10880.0 2436.4 2455.9 2460.5 2463.1 2473.9 2396.6 2415.7 2448.8 2458.5 2468.9 2381.6 2425.9 2441.9 2464.2 2468.8 2371.4 2410.1 2419.4 2426.6 2456.2 1887.0 2359.1 2412.1 2428.9 2456.7 10946.0 11020.9 11033.8 11067.6 11087.2 6230.3 6442.7 6464.2 6469.4 6488.9 3373.0 3885.8 3886.6 4086.0 4154.6 1171.7 1191.2 1193.8 1216.9 1227.5 13885.7 14369.4 14657.8 14689.3 14765.7 5370.2 5499.4 5526.1 5545.6 5548.1 11540.9 11541.1 11582.6 11597.2 11641.9 6109.2 6271.8 6273.8 6279.1 6289.5 5911.2 5930.4 6003.2 6031.3 6037.8 4300.8 4304.4 4352.7 4376.3 4384.3 1292.4 1298.0 1306.7 1310.1 1310.6 757.9 759.9 778.0 778.4 796.3 5346.9 5878.7 5882.2 6083.9 6090.8 503.3 561.5 577.7 582.0 589.5 3651.9 4046.2 4074.1 4193.0 4266.0 13443.3 13851.5 14055.8 14075.4 14089.5 13820.8 13985.7 13989.5 13999.7 14011.2 9009.9 9058.0 9711.2 10123.6 10230.1 5075.6 6615.2 6704.6 6799.9 6859.7 9739.4 12327.6 12456.5 12612.8 12613.7 11879.2 12246.1 12461.8 12470.9 12590.8 8993.6 9107.5 9277.2 9294.3 9296.8 10230.6 10263.8 10265.7 10363.1 10364.1 7357.4 8588.4 8787.7 8793.6 8889.6 8451.0 8518.2 8565.1 8605.6 8756.3 7522.7 7777.5 7811.6 7843.1 7866.2 5711.2 5769.7 5825.2 5994.1 6017.5 5667.7 5739.9 5925.2 5946.9 5993.1 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5410.35 Median:6146.72 stddev:1714.20 (27.9%) stddev-sans-first:1676.96 19:19:32 INFO - PID 1637 | Values: 382.3 391.3 395.3 400.9 402.9 6242.3 6301.8 6428.6 6458.6 6481.3 4792.9 5086.3 5537.8 5925.7 6206.3 3424.8 4001.0 4352.9 4482.3 4742.7 4691.3 4726.9 4739.2 4758.2 4758.6 3628.9 4407.7 4538.3 4592.2 4698.2 3870.5 3986.4 4668.0 4687.0 4693.8 4126.3 4129.3 4130.3 4135.9 4168.9 5367.7 5885.7 6120.0 6146.7 6209.2 5293.7 5453.6 5536.7 5541.5 5560.5 5817.4 5893.6 6587.3 6718.2 6737.1 3700.5 3734.6 4452.8 4629.2 4683.4 6146.7 6174.8 6453.4 6852.4 7079.4 4482.9 4858.1 4872.7 4889.8 4893.2 3924.5 4358.1 4967.2 4975.4 5048.9 5422.8 5589.8 5656.0 5660.4 5671.7 6339.9 6364.5 6746.6 6758.4 6835.9 1548.5 1670.2 1674.8 1679.2 1685.0 850.9 879.7 950.3 982.5 1025.3 6450.5 6461.9 6473.4 6494.6 6509.3 6693.0 6914.8 7006.3 7032.4 7056.0 6000.8 6367.1 6426.7 6458.3 6557.9 2934.8 3325.0 3510.5 3561.6 3678.3 6545.0 6571.4 7174.1 7189.9 7221.2 6175.9 6778.8 7191.7 7193.9 7200.7 6813.6 7118.9 7173.9 7195.4 7227.7 5749.3 6945.6 6959.6 6964.9 6985.7 6058.6 6559.8 6564.5 6794.7 6869.8 5691.4 7001.6 7108.1 7259.1 7274.7 4196.1 4486.8 4505.6 4523.8 4537.7 6063.9 6678.5 6709.5 6946.7 7007.7 5379.7 5922.8 6744.0 6753.5 6760.2 6456.3 6682.0 6747.7 6772.8 6774.3 6595.8 6602.0 6605.6 6622.7 6631.5 5402.0 6494.6 6791.4 6797.6 6842.5 5998.0 6044.1 6566.5 6566.5 6566.7 19:19:32 INFO - PID 1637 | 19:19:32 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:19453.63 Median:24622.45 stddev:28242.84 (114.7%) stddev-sans-first:28287.05 19:19:32 INFO - PID 1637 | Values: 720.6 741.5 741.9 746.5 750.9 13575.2 16066.6 16437.9 16451.5 16457.7 14901.8 15004.5 15036.5 15037.8 15059.2 962.7 969.6 987.7 1019.3 1022.3 1012.7 1021.2 1025.0 1025.4 1025.5 1038.8 1054.5 1066.1 1067.6 1071.1 1038.6 1058.4 1058.9 1061.9 1065.5 780.7 787.7 791.1 791.4 792.9 15844.8 15948.3 16121.5 16528.0 16573.1 14799.9 14803.6 14845.4 14925.3 15769.9 11425.7 11778.2 11782.7 11958.9 12299.8 2476.8 2634.4 2640.8 2748.9 2867.9 94553.0 105666.0 107049.5 112965.0 117542.0 9510.9 10534.2 11194.8 11619.2 11739.4 18855.3 19745.5 24620.4 24624.5 24639.0 7994.3 8037.7 8085.0 8346.0 8367.2 4051.3 4085.8 4160.7 4185.6 4282.5 3431.8 4250.1 4250.7 4251.6 4258.3 845.9 884.6 885.1 885.3 886.8 549.5 564.8 571.6 574.5 584.4 8979.0 8996.6 9030.9 9743.3 9844.8 573.1 577.6 591.3 595.7 595.9 4571.5 4623.9 4633.2 4661.6 4765.3 97164.0 100118.5 104073.5 104540.0 106716.5 66698.0 88988.0 89136.6 90875.1 93425.5 74706.0 75730.6 75775.6 76608.0 77296.0 10246.8 10458.5 10577.1 10694.4 10761.8 36983.6 37382.3 37548.6 37613.0 38849.6 37512.8 48837.8 49603.5 49792.3 50054.5 9667.9 12125.7 12299.3 12794.8 13259.1 13805.2 13943.9 13949.4 14063.2 14177.6 10969.6 13097.7 13133.4 13161.6 13442.7 10975.3 12957.0 13365.3 13378.7 13618.7 12723.4 12753.9 12904.4 12953.1 13661.0 9222.3 9415.2 9545.1 9665.0 9676.7 10716.9 10740.1 10888.2 10892.3 10927.1 19:19:32 INFO - PID 1637 | -------- Summary: end -------- 19:19:32 INFO - PID 1637 | 19:19:33 INFO - TEST-INFO | 1637: exit 0 19:19:33 INFO - TEST-OK | dromaeo_css | took 1117301ms 19:19:33 INFO - TEST-START | kraken 19:19:33 INFO - operating with platform_type : mac_ 19:19:33 INFO - Initialising browser for kraken test... 19:19:33 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp88ScfV/profile http://localhost:49250/getInfo.html) 19:19:36 INFO - PID 1649 | 2017-03-31 19:19:35.992 plugin-container[1650:10327] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444f, name = 'com.apple.tsm.portname' 19:19:36 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:19:36 INFO - PID 1649 | 2017-03-31 19:19:35.995 plugin-container[1650:10327] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 19:19:36 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:19:36 INFO - PID 1649 | 2017-03-31 19:19:35.995 plugin-container[1650:10327] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:19:36 INFO - PID 1649 | __metrics Screen width/height:1600/1200 19:19:36 INFO - PID 1649 | colorDepth:24 19:19:36 INFO - PID 1649 | Browser inner width/height: 1024/689 19:19:36 INFO - PID 1649 | __metrics 19:19:36 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 19:19:37 INFO - TEST-INFO | 1649: exit 0 19:19:37 INFO - Browser initialized. 19:19:37 INFO - Running cycle 1/1 for kraken test... 19:19:37 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp88ScfV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:39 INFO - PID 1651 | 2017-03-31 19:19:39.338 plugin-container[1652:10453] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 19:19:39 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:19:39 INFO - PID 1651 | 2017-03-31 19:19:39.339 plugin-container[1652:10453] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 19:19:39 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:19:39 INFO - PID 1651 | 2017-03-31 19:19:39.339 plugin-container[1652:10453] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:19:49 INFO - PID 1651 | RSS: Main: 229163008 19:19:49 INFO - PID 1651 | 19:19:52 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:53 INFO - PID 1651 | RSS: Main: 244039680 19:19:53 INFO - PID 1651 | 19:19:56 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 19:19:56 INFO - PID 1651 | RSS: Main: 252342272 19:19:56 INFO - PID 1651 | 19:20:00 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 19:20:01 INFO - PID 1651 | RSS: Main: 254636032 19:20:01 INFO - PID 1651 | 19:20:03 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 19:20:03 INFO - PID 1651 | RSS: Main: 256557056 19:20:03 INFO - PID 1651 | 19:20:06 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:06 INFO - PID 1651 | RSS: Main: 256888832 19:20:06 INFO - PID 1651 | 19:20:09 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:10 INFO - PID 1651 | RSS: Main: 262594560 19:20:10 INFO - PID 1651 | 19:20:13 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:14 INFO - PID 1651 | RSS: Main: 263487488 19:20:14 INFO - PID 1651 | 19:20:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 19:20:18 INFO - PID 1651 | RSS: Main: 262889472 19:20:18 INFO - PID 1651 | 19:20:19 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:20 INFO - PID 1651 | RSS: Main: 262897664 19:20:20 INFO - PID 1651 | 19:20:22 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:23 INFO - PID 1651 | RSS: Main: 262848512 19:20:23 INFO - PID 1651 | 19:20:25 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:25 INFO - PID 1651 | RSS: Main: 262893568 19:20:25 INFO - PID 1651 | 19:20:29 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:29 INFO - PID 1651 | RSS: Main: 263294976 19:20:29 INFO - PID 1651 | 19:20:33 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:33 INFO - PID 1651 | RSS: Main: 260513792 19:20:33 INFO - PID 1651 | 19:20:35 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 19:20:36 INFO - PID 1651 | RSS: Main: 263782400 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | __start_tp_report 19:20:36 INFO - PID 1651 | _x_x_mozilla_page_load 19:20:36 INFO - PID 1651 | _x_x_mozilla_page_load_details 19:20:36 INFO - PID 1651 | |i|pagename|runs| 19:20:36 INFO - PID 1651 | |0;ai-astar;113;135;186;183;157;125;148;183;145;129 19:20:36 INFO - PID 1651 | |1;audio-beat-detection;195;117;119;175;154;113;117;118;143;105 19:20:36 INFO - PID 1651 | |2;audio-dft;223;235;219;297;307;231;211;221;219;217 19:20:36 INFO - PID 1651 | |3;audio-fft;87;61;80;126;94;72;61;60;76;66 19:20:36 INFO - PID 1651 | |4;audio-oscillator;71;92;84;114;116;113;126;80;76;87 19:20:36 INFO - PID 1651 | |5;imaging-gaussian-blur;123;97;92;83;81;134;142;92;92;98 19:20:36 INFO - PID 1651 | |6;imaging-darkroom;102;103;101;100;102;119;164;166;110;104 19:20:36 INFO - PID 1651 | |7;imaging-desaturate;103;108;105;103;102;102;101;104;103;141 19:20:36 INFO - PID 1651 | |8;json-parse-financial;51;51;49;51;52;52;53;51;51;52 19:20:36 INFO - PID 1651 | |9;json-stringify-tinderbox;60;60;66;64;104;60;65;85;91;92 19:20:36 INFO - PID 1651 | |10;stanford-crypto-aes;88;89;89;89;89;89;90;88;87;87 19:20:36 INFO - PID 1651 | |11;stanford-crypto-ccm;150;146;177;158;173;159;165;174;183;207 19:20:36 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;191;186;179;179;250;235;199;267;262;202 19:20:36 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;71;70;73;74;73;69;107;106;106;105 19:20:36 INFO - PID 1651 | __end_tp_report 19:20:36 INFO - PID 1651 | __start_cc_report 19:20:36 INFO - PID 1651 | _x_x_mozilla_cycle_collect,1026 19:20:36 INFO - PID 1651 | __end_cc_report 19:20:36 INFO - PID 1651 | __startTimestamp1491013236154__endTimestamp 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | ------- Summary: start ------- 19:20:36 INFO - PID 1651 | Number of tests: 14 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:150.40 Median:152.50 stddev:26.27 (17.2%) stddev-sans-first:24.13 19:20:36 INFO - PID 1651 | Values: 113.0 135.0 186.0 183.0 157.0 125.0 148.0 183.0 145.0 129.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:131.00 stddev:30.18 (23.0%) stddev-sans-first:23.12 19:20:36 INFO - PID 1651 | Values: 195.0 117.0 119.0 175.0 154.0 113.0 117.0 118.0 143.0 105.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:238.00 Median:227.00 stddev:34.49 (15.2%) stddev-sans-first:36.15 19:20:36 INFO - PID 1651 | Values: 223.0 235.0 219.0 297.0 307.0 231.0 211.0 221.0 219.0 217.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:78.30 Median:74.00 stddev:20.36 (27.5%) stddev-sans-first:21.35 19:20:36 INFO - PID 1651 | Values: 87.0 61.0 80.0 126.0 94.0 72.0 61.0 60.0 76.0 66.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:78.00 stddev:19.54 (25.0%) stddev-sans-first:18.53 19:20:36 INFO - PID 1651 | Values: 71.0 92.0 84.0 114.0 116.0 113.0 126.0 80.0 76.0 87.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:103.40 Median:92.00 stddev:21.57 (23.4%) stddev-sans-first:21.68 19:20:36 INFO - PID 1651 | Values: 123.0 97.0 92.0 83.0 81.0 134.0 142.0 92.0 92.0 98.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:117.10 Median:107.00 stddev:25.87 (24.2%) stddev-sans-first:26.86 19:20:36 INFO - PID 1651 | Values: 102.0 103.0 101.0 100.0 102.0 119.0 164.0 166.0 110.0 104.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:107.20 Median:103.50 stddev:12.04 (11.6%) stddev-sans-first:12.67 19:20:36 INFO - PID 1651 | Values: 103.0 108.0 105.0 103.0 102.0 102.0 101.0 104.0 103.0 141.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:1.06 (2.1%) stddev-sans-first:1.12 19:20:36 INFO - PID 1651 | Values: 51.0 51.0 49.0 51.0 52.0 52.0 53.0 51.0 51.0 52.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:65.50 stddev:16.54 (25.3%) stddev-sans-first:16.67 19:20:36 INFO - PID 1651 | Values: 60.0 60.0 66.0 64.0 104.0 60.0 65.0 85.0 91.0 92.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 19:20:36 INFO - PID 1651 | Values: 88.0 89.0 89.0 89.0 89.0 89.0 90.0 88.0 87.0 87.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:169.20 Median:173.50 stddev:17.86 (10.3%) stddev-sans-first:17.54 19:20:36 INFO - PID 1651 | Values: 150.0 146.0 177.0 158.0 173.0 159.0 165.0 174.0 183.0 207.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.00 Median:218.50 stddev:34.92 (16.0%) stddev-sans-first:35.94 19:20:36 INFO - PID 1651 | Values: 191.0 186.0 179.0 179.0 250.0 235.0 199.0 267.0 262.0 202.0 19:20:36 INFO - PID 1651 | 19:20:36 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.40 Median:70.50 stddev:17.80 (25.2%) stddev-sans-first:18.10 19:20:36 INFO - PID 1651 | Values: 71.0 70.0 73.0 74.0 73.0 69.0 107.0 106.0 106.0 105.0 19:20:36 INFO - PID 1651 | -------- Summary: end -------- 19:20:36 INFO - PID 1651 | 19:20:36 INFO - TEST-INFO | 1651: exit 0 19:20:37 INFO - TEST-OK | kraken | took 63675ms 19:20:37 INFO - SUITE-END | took 1180s 19:20:37 INFO - Completed test suite (00:19:41) 19:20:37 INFO - javascript benchmark 19:20:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7662.280717190305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.795978261413, 3380.3915295246848, 3457.94813077804, 3654.2508785698933, 3665.9266814663706, 6131.896637733218, 6250.84372890678, 6251.531135164858, 6282.308946015934, 6283.246010478749, 5056.988602279541, 5779.104238842976, 6128.2281383986465, 6198.194234749488, 6267.185265915425, 5116.309298244745, 5416.620836541444, 5425.647332923348, 5442.210879422501, 5524.8342549723575, 4881.389826271716, 5501.284832971728, 5541.445855414447, 5577.972110139443, 5629.127485239795, 5366.490183432567, 5410.648307859977, 5534.640248383842, 5541.806036788734, 5584.1902924075985, 5424.321959755031, 5458.317710286215, 5459.590530710213, 5515.531179849718, 5569.331680198362, 4107.815148318333, 5381.354237491526, 5446.836594902159, 5448.210009548593, 5513.972430137824, 4541.069080838421, 6051.697415129226, 6132.50939924805, 6268.717907694119, 6285.560010799246, 6396.776112836028, 6459.806205813786, 6599.142111525519, 6672.132622759059, 6689.397954184098, 5621.213030175779, 6761.256261811246, 6791.252962174157, 6795.354441328066, 6802.14973128359, 6183.041628547582, 6335.556511044183, 6342.9365706342805, 6347.619142851398, 6348.904766428507, 6625.0, 6760.087388202628, 6906.136732908387, 6937.993990871295, 6962.477814163958, 6313.905291420632, 6369.235691717024, 6426.4537514311805, 6461.418472337512, 6540.4767618590395, 6748.156480439945, 6749.392554670005, 6761.290064543152, 6776.186857577122, 6790.830229244309, 6561.179852518435, 6680.064790929274, 6680.665966701646, 6687.531872768956, 6692.0296556998965, 6376.39424254695, 6477.676116194266, 6484.675766211671, 6667.299933506912, 6695.832604184837, 5303.946960530422, 5321.5476684482255, 5330.680159190461, 5338.706371149624, 5351.224072509464, 4734.976325118421, 4782.665213435026, 4809.519048095162, 4815.975920120377, 4847.006363695434, 6330.968345158337, 6383.489320854321, 6389.712462939179, 6392.4246817786625, 6399.7440102395385, 6432.035194720829, 6523.64119973406, 6782.728690852311, 6791.117154769849, 6796.898046529306, 6332.746690132435, 6345.777897773556, 6365.427111559982, 6391.904121438182, 6404.647744374011, 5914.733836977346, 5957.4042595740075, 5987.042073268256, 5988.221531200916, 6045.244344456943, 6407.935920640921, 6906.37842594169, 6949.131358580177, 6985.79042628722, 6988.615626140408, 5843.474087332161, 5969.403059693996, 6265.655388953652, 6434.131392262172, 6463.967680161569, 6884.93115068863, 6903.0335752993615, 6918.93081069203, 6928.411085057826, 6928.549644273106, 6542.1168142300185, 6561.606303621798, 6573.112629794917, 6594.241662208908, 6600.669966501751, 6361.459275961595, 6478.157839481026, 6601.306862779339, 6643.966780166068, 6666.2333831609985, 6383.648899310582, 6493.8701225976165, 6507.186601674791, 6514.609123452608, 6534.509911756542, 6268.686565671607, 6287.96856015717, 6419.582727122722, 6537.411632953057, 6553.311902250386, 5655.462731040545, 6377.840553986188, 6409.71156297977, 6416.069669897932, 6420.871582568229, 6294.244690637152, 6358.237011558643, 6456.354364563506, 6460.192475940507, 6591.736330546724, 6292.465140463112, 6319.399657032574, 6324.557280990287, 6331.145295385064, 6344.619322840645], "value": 6058.882892403635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.3347919257915, 719.1585844561862, 813.6135335715534, 1030.96391626293, 1281.7949128139498, 39255.485619153806, 39540.99999999996, 39630.80184599073, 39648.80175599122, 39693.40459893104, 39184.82445526639, 39602.60397396025, 39725.60274397255, 39741.60258397415, 39751.0, 8111.797205069876, 8683.739487815345, 8902.376833621649, 8939.284857211407, 8959.552022398853, 8871.112888711143, 8925.910740892605, 8943.373963822534, 8962.327825413087, 8976.506292153928, 8906.109389061106, 8960.0, 8981.77545561363, 9019.052999435064, 9026.593803278869, 7448.77653670388, 8924.286057115416, 8942.374033817636, 8947.0, 8957.686480973134, 6384.265809431929, 6413.967930160366, 6423.325550817191, 6426.260979987314, 6429.8392540186405, 38504.80747596272, 38621.613783862085, 38705.80647096775, 38788.80605596954, 38880.805595972124, 3047.6495203051713, 3056.847157642131, 3070.8311042892633, 3074.415860986428, 3091.984540077308, 27761.583576246372, 27799.86100069507, 28010.159695209175, 28072.438551229065, 28591.856325746947, 2777.277907743981, 2802.8738706758245, 2824.002028508497, 2829.5755636654667, 2914.9271268218463, 278273.0, 283229.0, 303324.0, 306315.0, 312150.0, 49346.75326623344, 49428.0, 49554.50445495571, 49744.50255497399, 49804.75097624561, 40872.59127408747, 49416.752916235906, 51721.0, 52394.0, 52398.73800631049, 14290.356933937997, 14337.78493322601, 14361.784573231409, 14399.64000899965, 14415.351309191112, 9851.45816980073, 10414.687559373231, 10427.635032773816, 11600.245984011011, 11808.763824723457, 11284.435778211056, 13725.45098196081, 13781.0, 13818.447262109605, 13937.721245575032, 5051.3433253676785, 5988.850278743066, 6000.459958603747, 6004.819855404345, 6021.939780602138, 937.1425145991342, 945.4421891084294, 964.4261664309724, 967.1537404770826, 1014.8477728340661, 17979.820201798077, 22392.10431582751, 23897.641535376635, 24284.75715242825, 24410.0, 971.9891313034365, 1051.264115119404, 1067.8451624514403, 1099.2525082943675, 1102.1788767368362, 11481.598144065085, 12205.084618653636, 12233.877661223452, 12286.938565307295, 12359.50561977511, 475550.0, 479545.02274886117, 479557.0, 481290.0, 481466.0, 55770.0, 55896.44103558994, 55901.88196236052, 56108.0, 56316.71841640765, 1466.5233799015364, 1511.4332125452954, 1516.9848301517063, 1521.6500204952702, 1523.070926734691, 18648.34730784416, 23796.286111416684, 23846.359557461536, 24024.51950960936, 24060.0, 38878.500934915995, 38910.6381276654, 38968.61031389763, 39080.41379379368, 39228.215435691694, 441413.0, 441578.0, 442727.0, 443391.0, 444518.0, 28274.151775446768, 28638.133851929724, 28652.0, 32979.0, 33265.667343326255, 34850.30299393947, 34901.65098348984, 35358.292834143685, 35414.29171416609, 35488.0, 22626.760878537218, 24274.635880461454, 25238.242852714448, 26312.605310919967, 26618.733812661627, 25678.61482077733, 26298.60552091682, 26983.595246071716, 29095.0, 30541.694583053886, 35207.47188792221, 36140.819295903355, 36344.81827590845, 36826.079348016516, 36949.26101477902, 27331.72668273292, 29121.004227179386, 29961.0, 30171.396572067995, 30490.237744056576, 19079.427617171506, 21342.270481937307, 22200.0, 23262.3021309361, 24060.39849003789], "value": 17277.736458165236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.97025208235436, 435.6231859441582, 436.69867791224056, 446.2881703682626, 447.93504941783465, 19906.502337441572, 21803.127874885005, 22355.10579576815, 22525.887370563145, 22975.0, 22593.887030564867, 22678.0, 23484.882575587097, 23648.290551283448, 23853.9265733042, 6092.299385570672, 6303.842403939904, 6459.61242325462, 6535.477161827066, 6542.901856472156, 6397.360263973612, 6405.42351188393, 6483.7082331295205, 6487.253965793923, 6566.015097735354, 5931.228940237763, 6347.523935704818, 6370.331115232903, 6396.5202609804455, 6419.101325814389, 6001.7299221534695, 6285.245770507523, 6286.119943207955, 6336.303006669263, 6351.555391122623, 5377.274068000848, 5559.305086864142, 5580.302462192226, 5603.523700485463, 5605.803796867131, 27178.776955037072, 27689.307767305778, 27972.0, 28039.158825235274, 28482.0, 1965.1156979359346, 1986.6622674145285, 2028.7464066991627, 2073.3365323096614, 2077.1276064053136, 13839.723205535933, 15905.681886362323, 16310.673786524321, 17126.743098853527, 17497.037662928535, 1853.5829438376393, 1868.953276168093, 1907.9236830526763, 1924.7706603596166, 1943.9125239364262, 118544.0, 127683.08475372876, 147525.2623736885, 158732.99999999884, 159309.0, 12361.443735031946, 12601.558945436866, 12629.115961882764, 12665.303408312448, 12817.935910320388, 16138.273777680033, 16239.0, 16419.6716065678, 16445.83554164467, 16477.0, 8741.956290218508, 8992.415492992934, 9032.23226025782, 9158.40470369424, 9240.722778316527, 7321.670524826395, 8419.0, 8572.442791218551, 8606.13938606147, 8780.341474389319, 6592.571482853599, 7819.843603127905, 7977.800554986172, 8002.319802816709, 8017.0, 1802.4682718598044, 2120.4062862398555, 2132.9761714376878, 2143.6570148776123, 2295.73599036113, 820.2330820682562, 881.9162179593056, 915.2494954137543, 943.4999450291357, 965.6041023180462, 18108.456746297634, 19579.021048947496, 19887.619104752226, 20671.689924651142, 20711.689324660143, 924.902885197058, 955.460165006769, 975.3611384543135, 984.9359791613522, 996.2976101848179, 10252.077313041862, 10360.119389851796, 10399.220058495643, 10663.626773062906, 10698.304610200312, 678050.6097469481, 691559.0844091595, 696182.0, 708301.0, 710589.0, 126354.0, 152954.47045529625, 160894.0, 161398.0, 161467.0, 1123.07346439188, 1148.3913525831322, 1167.3696204049718, 1170.9648710538697, 1171.3616079236836, 17621.559461013065, 17902.641947160722, 18001.729974050137, 18109.909450452662, 18123.275068997093, 62024.68987655033, 63755.68122159359, 63827.0, 64181.679091604245, 64772.67613661902, 89415.55292223497, 89421.0, 91386.0, 91512.0, 92439.0, 8353.624086915981, 8536.061033286458, 8558.871616925875, 8694.34792390586, 8838.160374764388, 13301.600951971457, 13469.259190744604, 13509.256990865597, 13529.932350338186, 14021.439142434188, 9523.571439285388, 11471.738108808191, 11497.367644779617, 11528.423578821194, 11531.365774882463, 10838.295510791773, 10984.670459886216, 11068.557257709923, 11214.775704486028, 11356.829647555129, 11480.712982175179, 11693.824592630946, 12046.397680115784, 12080.697982550506, 12116.21244619097, 6316.747330106744, 8233.917660823554, 8396.916030839613, 8562.74311770648, 8650.697225597074, 11455.427228638702, 11485.598004070152, 11642.068634509389, 11774.882251177378, 11879.0], "value": 10435.015032287443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.3825363825363, 1471.6541612721016, 1476.564413498018, 1479.4452080469823, 1498.5878883307093, 10655.307405018668, 10744.355338679685, 11008.449577521133, 11064.39145846979, 11117.277376970502, 10692.037716605504, 10802.5678972841, 10839.349639021664, 10839.458027098653, 10880.0, 2436.4030812450974, 2455.8772061396858, 2460.520198561281, 2463.051725085846, 2473.9010439582485, 2396.641116440295, 2415.7342692303832, 2448.840825346356, 2458.532878753031, 2468.876556172193, 2381.583222935988, 2425.9029638814427, 2441.865697386643, 2464.2237695125978, 2468.7778099971, 2371.3715865295712, 2410.1323523531514, 2419.4314336131083, 2426.6481360202847, 2456.152627343564, 1886.9528261793428, 2359.0681680736184, 2412.0954642009247, 2428.878556072207, 2456.742042085591, 10946.0, 11020.944895275472, 11033.779324413546, 11067.612633557867, 11087.168462365275, 6230.2523697156175, 6442.710078046499, 6464.191976003, 6469.417752402306, 6488.8702225955685, 3372.9831350843333, 3885.795403424919, 3886.553046399672, 4085.9795701021603, 4154.646855017327, 1171.7305019845483, 1191.201894730524, 1193.7672153929987, 1216.8843959823803, 1227.5028613411582, 13885.722285554333, 14369.425222991173, 14657.780133298009, 14689.338979745937, 14765.704685906328, 5370.248165256867, 5499.367572729107, 5526.143447765603, 5545.611807173459, 5548.0845660465575, 11540.884591153981, 11541.07671386287, 11582.594609188638, 11597.18819682631, 11641.941790290994, 6109.175261339662, 6271.843203919939, 6273.843153921189, 6279.089532017923, 6289.465395441347, 5911.231539899872, 5930.43660852227, 6003.159557661931, 6031.276246850406, 6037.758489660452, 4300.80646370914, 4304.354346847936, 4352.717073390219, 4376.299792033259, 4384.298512238027, 1292.4442489729506, 1298.0459362368651, 1306.6798634334648, 1310.1484035377082, 1310.5845686658386, 757.9014728085314, 759.8905597827123, 777.992220077792, 778.381186956371, 796.3390385979623, 5346.91979620306, 5878.676672782953, 5882.176495290662, 6083.9391606084255, 6090.786822461193, 503.2526697853684, 561.5058748301468, 577.6707276852238, 581.9912701309484, 589.5048159545917, 3651.8539258429364, 4046.190761847642, 4074.144429669743, 4192.958070419318, 4265.978670106691, 13443.32783360828, 13851.515196968057, 14055.78916316256, 14075.366608502642, 14089.506867259597, 13820.792688109686, 13985.65035874091, 13989.510367137102, 13999.720005599831, 14011.229382383863, 9009.864852027225, 9058.00361960184, 9711.223102151811, 10123.645672401577, 10230.07929286353, 5075.619328550448, 6615.17310336208, 6704.564203326768, 6799.864002719819, 6859.691313890987, 9739.366941148803, 12327.568535101229, 12456.508698260202, 12612.810807838074, 12613.684657883627, 11879.22785018971, 12246.142770006014, 12461.813072803734, 12470.875291246972, 12590.811137832756, 8993.595288212176, 9107.453552786854, 9277.211437027929, 9294.302927280616, 9296.814063718553, 10230.6419275325, 10263.794724105326, 10265.74335641615, 10363.06732394088, 10364.067233948981, 7357.448191385561, 8588.441751286146, 8787.692430764893, 8793.560321983747, 8889.599968001585, 8451.0, 8518.190771876662, 8565.100664430394, 8605.569721514024, 8756.343274254328, 7522.661480233293, 7777.455578109478, 7811.609419528887, 7843.137254902071, 7866.174051724715, 5711.228984087095, 5769.711514424346, 5825.184474173704, 5994.100884867305, 6017.518598512196, 5667.659940403589, 5739.9139012915675, 5925.229720136354, 5946.910796337972, 5993.0710739835395], "value": 5101.163107725003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.31183869035766, 391.2859032266115, 395.2943994968981, 400.90378309205784, 402.9133736246707, 6242.250929888414, 6301.810945671631, 6428.646424446653, 6458.580192287498, 6481.287058423582, 4792.90414191716, 5086.321513900413, 5537.8370542186085, 5925.666724986876, 6206.317305096447, 3424.7842016084305, 4000.959990400088, 4352.869413917588, 4482.260427029544, 4742.691725037878, 4691.272852707836, 4726.858194254178, 4739.194336962707, 4758.167320718878, 4758.571728544431, 3628.87298944537, 4407.6722074833615, 4538.319252112193, 4592.150452166343, 4698.224792909165, 3870.4968354114067, 3986.402039694069, 4667.953320466786, 4686.992296656218, 4693.812247510095, 4126.298529250034, 4129.318662420697, 4130.29465699967, 4135.855245066438, 4168.895242760671, 5367.704776237305, 5885.676287804169, 6120.0, 6146.723397447081, 6209.223847019122, 5293.729504918831, 5453.563714902798, 5536.723163841792, 5541.473560011793, 5560.471755183251, 5817.38917413674, 5893.5541750173625, 6587.341265873422, 6718.227403848571, 6737.124173857367, 3700.5189325387796, 3734.551853777537, 4452.821887124511, 4629.213033784265, 4683.437987441529, 6146.723397447081, 6174.84562885927, 6453.419192272718, 6852.383285504328, 7079.362857342812, 4482.8655140345845, 4858.05267972749, 4872.707637541759, 4889.828855990023, 4893.168161412497, 3924.5290565131795, 4358.106588149421, 4967.186976753459, 4975.353204083446, 5048.899022019539, 5422.783088676409, 5589.80435684749, 5656.0, 5660.405657405995, 5671.731307477042, 6339.873202535923, 6364.459020983269, 6746.628935408501, 6758.398016763582, 6835.897461538081, 1548.5044785668479, 1670.2400407814416, 1674.849263566285, 1679.219163089145, 1684.9663006740043, 850.8808766772656, 879.6657270237397, 950.3205208275978, 982.5382070426888, 1025.266934142092, 6450.451711604473, 6461.903071453932, 6473.385028422293, 6494.577852439671, 6509.2839787623325, 6692.966535167293, 6914.757983470655, 7006.299370062953, 7032.382552013066, 7055.964720176469, 6000.759969601254, 6367.140436041075, 6426.710798014101, 6458.321876203025, 6557.934420655828, 2934.794564380473, 3325.0, 3510.543629328171, 3561.5918888711417, 3678.319510890494, 6544.9672751635935, 6571.3757193066585, 7174.1032370953635, 7189.89215161773, 7221.24176961422, 6175.888340098735, 6778.796636100925, 7191.676374563157, 7193.9280607194305, 7200.747973820891, 6813.625250611165, 7118.893216601755, 7173.892391614234, 7195.424366050808, 7227.674754635948, 5749.281339832521, 6945.617991010341, 6959.61722105289, 6964.930350696428, 6985.7205711772995, 6058.606190597597, 6559.8032059038305, 6564.4748420127235, 6794.660266986532, 6869.828254293682, 5691.402402747652, 7001.569231076837, 7108.147022357351, 7259.12890453149, 7274.6726397313305, 4196.097629204869, 4486.820527178877, 4505.594496495331, 4523.755967108939, 4537.705049171794, 6063.939360606338, 6678.465722742266, 6709.463242940651, 6946.722131114901, 7007.684654190675, 5379.704116273642, 5922.785828904978, 6744.0, 6753.493487988519, 6760.22257440381, 6456.289083392999, 6682.0, 6747.730090796314, 6772.796816095525, 6774.322567743384, 6595.835104122435, 6601.966990165019, 6605.603663780189, 6622.735090596515, 6631.523721488073, 5402.027635025576, 6494.6103233806125, 6791.3548212919695, 6797.626130562669, 6842.536686792651, 5998.040313549811, 6044.063170208625, 6566.534756365717, 6566.540342176002, 6566.704498297492], "value": 4867.0824666146855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5676594043578, 741.547655929883, 741.9480636355454, 746.451358251685, 750.9211532789056, 13575.185488870675, 16066.59833504163, 16437.931534450254, 16451.506454806346, 16457.670846583074, 14901.776473352882, 15004.549863504086, 15036.548903532912, 15037.849621503781, 15059.17174555399, 962.6967505235829, 969.5927710361665, 987.7382493639192, 1019.2661283875598, 1022.3099407899675, 1012.691129205592, 1021.2136654775818, 1025.0364657222224, 1025.374521541859, 1025.461632642861, 1038.8130136575414, 1054.4674939155755, 1066.0938202527827, 1067.5943141606178, 1071.132382769959, 1038.6364772329623, 1058.3596923861069, 1058.915286777056, 1061.9203559733012, 1065.4672663668166, 780.6604127204685, 787.6731156570074, 791.1297572670074, 791.3589992106355, 792.9286364227247, 15844.841551584452, 15948.2823272953, 16121.516354509384, 16528.00831950087, 16573.08848013359, 14799.852001479954, 14803.55589332311, 14845.406183752637, 14925.328360223815, 15769.871067405868, 11425.714357141054, 11778.175527713063, 11782.705432364173, 11958.880411195863, 12299.754004919852, 2476.777090061903, 2634.4204275059456, 2640.7755340796057, 2748.8625568721486, 2867.885284588614, 94553.0, 105666.0, 107049.46475267573, 112965.0, 117542.0, 9510.857337139949, 10534.188993103855, 11194.776104477865, 11619.186656933933, 11739.354335511629, 18855.340063097727, 19745.506362341057, 24620.384490387885, 24624.507509849704, 24639.014439422222, 7994.2805147537, 8037.678492860337, 8085.0, 8345.95827020861, 8367.246947774729, 4051.2505186539993, 4085.7752823594988, 4160.708750387444, 4185.560516145761, 4282.528921818597, 3431.759776815649, 4250.149970006011, 4250.659947204216, 4251.553586873396, 4258.339957306623, 845.8984921809422, 884.6372987075268, 885.0662551008747, 885.2784980241212, 886.8093359927517, 549.4779959038929, 564.8249042796746, 571.6113043130711, 574.4513989140445, 584.4126652713995, 8979.0, 8996.640134394682, 9030.909690903138, 9743.317967742332, 9844.80310393788, 573.1202604002835, 577.5956830218863, 591.3081694417542, 595.6642800318183, 595.85401576614, 4571.531193566695, 4623.9075218495445, 4633.235516139799, 4661.588510672105, 4765.332853400527, 97164.0, 100118.49822252672, 104073.47963260135, 104539.95460045454, 106716.46641766897, 66698.03750631494, 88988.0, 89136.5543172293, 90875.09124908799, 93425.53287233657, 74706.0, 75730.62134689401, 75775.62112189514, 76608.0, 77296.0, 10246.846297305397, 10458.529366178693, 10577.100946419332, 10694.358338499715, 10761.784764304513, 36983.63016369802, 37382.25235495329, 37548.62451375451, 37613.0, 38849.6115038846, 37512.812435937645, 48837.7790555239, 49603.50396496133, 49792.25311620256, 50054.49945500498, 9667.854982175413, 12125.69685757863, 12299.262044277371, 12794.808077879026, 13259.071864969359, 13805.17168969865, 13943.930280348533, 13949.4420223194, 14063.156210627396, 14177.645558861112, 10969.616063437741, 13097.672558186121, 13133.408996595368, 13161.60515184546, 13442.731145377233, 10975.341479511255, 12957.028222883133, 13365.26491043002, 13378.665533361744, 13618.727625447238, 12723.359627017293, 12753.872461275269, 12904.354782261038, 12953.093283470067, 13661.043726939417, 9222.308326875376, 9415.153848064281, 9545.093216144454, 9665.0, 9676.661316853877, 10716.892831071902, 10740.087092597218, 10888.183386245904, 10892.346459212473, 10927.071198948179], "value": 7461.171656693723, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1710.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 135.0, 186.0, 183.0, 157.0, 125.0, 148.0, 183.0, 145.0, 129.0], "value": 150.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 117.0, 119.0, 175.0, 154.0, 113.0, 117.0, 118.0, 143.0, 105.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 235.0, 219.0, 297.0, 307.0, 231.0, 211.0, 221.0, 219.0, 217.0], "value": 238.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 61.0, 80.0, 126.0, 94.0, 72.0, 61.0, 60.0, 76.0, 66.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 92.0, 84.0, 114.0, 116.0, 113.0, 126.0, 80.0, 76.0, 87.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 97.0, 92.0, 83.0, 81.0, 134.0, 142.0, 92.0, 92.0, 98.0], "value": 103.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 101.0, 100.0, 102.0, 119.0, 164.0, 166.0, 110.0, 104.0], "value": 117.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 105.0, 103.0, 102.0, 102.0, 101.0, 104.0, 103.0, 141.0], "value": 107.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 51.0, 52.0, 52.0, 53.0, 51.0, 51.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 66.0, 64.0, 104.0, 60.0, 65.0, 85.0, 91.0, 92.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 89.0, 89.0, 89.0, 90.0, 88.0, 87.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 177.0, 158.0, 173.0, 159.0, 165.0, 174.0, 183.0, 207.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 186.0, 179.0, 179.0, 250.0, 235.0, 199.0, 267.0, 262.0, 202.0], "value": 215.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 73.0, 74.0, 73.0, 69.0, 107.0, 106.0, 106.0, 105.0], "value": 85.4, "unit": "score"}]}]} 19:20:37 INFO - Return code: 0 19:20:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:37 ERROR - # TBPL SUCCESS # 19:20:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:20:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:20:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:20:37 INFO - 2017-03-31 19:20:37.450 screenresolution[1656:10838] starting screenresolution argv=screenresolution get 19:20:37 INFO - 2017-03-31 19:20:37.453 screenresolution[1656:10838] Display 0: 1600x1200x32@60 19:20:37 INFO - 2017-03-31 19:20:37.459 screenresolution[1657:10841] starting screenresolution argv=screenresolution list 19:20:37 INFO - Available Modes on Display 0 19:20:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:20:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:20:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:20:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:20:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:20:37 INFO - Intel Iris: 19:20:37 INFO - Chipset Model: Intel Iris 19:20:37 INFO - Type: GPU 19:20:37 INFO - Bus: Built-In 19:20:37 INFO - VRAM (Dynamic, Max): 1536 MB 19:20:37 INFO - Vendor: Intel (0x8086) 19:20:37 INFO - Device ID: 0x0a2e 19:20:37 INFO - Revision ID: 0x0009 19:20:37 INFO - Displays: 19:20:37 INFO - Display: 19:20:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:20:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:20:37 INFO - Display Serial Number: 1600x1200 60 19:20:37 INFO - Main Display: Yes 19:20:37 INFO - Mirror: Off 19:20:37 INFO - Online: Yes 19:20:37 INFO - Rotation: Supported 19:20:37 INFO - Return code: 0 19:20:37 INFO - Running post-action listener: _resource_record_post_action 19:20:37 INFO - [mozharness: 2017-04-01 02:20:37.695473Z] Finished run-tests step (success) 19:20:37 INFO - Running post-run listener: _resource_record_post_run 19:20:37 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37734912; Write bytes: 517309440; Read time: 384; Write time: 1696 19:20:37 INFO - TinderboxPrint: CPU usage
54.4% 19:20:37 INFO - TinderboxPrint: I/O read bytes / time
37,734,912 / 384 19:20:37 INFO - TinderboxPrint: I/O write bytes / time
517,309,440 / 1,696 19:20:37 INFO - TinderboxPrint: CPU idle
2,194.1 (45.6%) 19:20:37 INFO - TinderboxPrint: CPU system
975.0 (20.3%) 19:20:37 INFO - TinderboxPrint: CPU user
1,640.5 (34.1%) 19:20:37 INFO - TinderboxPrint: Swap in / out
249,778,176 / 0 19:20:37 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 207333888; Write bytes: 205203456; Read time: 15693; Write time: 437 19:20:37 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35723776; Write bytes: 301259776; Read time: 363; Write time: 1224 19:20:38 INFO - Running post-run listener: _upload_blobber_files 19:20:38 INFO - Blob upload gear active. 19:20:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:38 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 19:20:38 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'] 19:20:38 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 19:20:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:39 INFO - (blobuploader) - INFO - Done attempting. 19:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:40 INFO - (blobuploader) - INFO - Done attempting. 19:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:41 INFO - (blobuploader) - INFO - Done attempting. 19:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:43 INFO - (blobuploader) - INFO - Done attempting. 19:20:43 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:43 INFO - Return code: 0 19:20:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd9e39feb6ea79c6db51add3c1bb700c2d0a8a13f8721eb929a2628ff4efe92cfa798ef52966f562eaacd001a4471212a2afd816ce64778681ac48f078d8be5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9575ad3a8265963e3cdb27b664a2dec7029f3db24722637f943d19d560a910c1c86338751f5d03eae6eb43f294a657aad49ba341ec8524f390c0bbb33fb3eb1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670ce2f13900d834e73dae329adfbf7a6ea39faca678c365313926807d9c4cc8e71f261d604790ac4d7f841774166667cb1cff636510e6143a55ed66dbed8a3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96289f69af19807f51f2f0ed4c2e1aeee9c7ed1a6ee6ea60898d5ca1fbe9e60d397b7eb4b2e8b103c0137ba7a8e3909b6d6f9dfffc6b65b08cc89b5126ea78f7"} 19:20:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:43 INFO - Contents: 19:20:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd9e39feb6ea79c6db51add3c1bb700c2d0a8a13f8721eb929a2628ff4efe92cfa798ef52966f562eaacd001a4471212a2afd816ce64778681ac48f078d8be5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9575ad3a8265963e3cdb27b664a2dec7029f3db24722637f943d19d560a910c1c86338751f5d03eae6eb43f294a657aad49ba341ec8524f390c0bbb33fb3eb1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670ce2f13900d834e73dae329adfbf7a6ea39faca678c365313926807d9c4cc8e71f261d604790ac4d7f841774166667cb1cff636510e6143a55ed66dbed8a3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96289f69af19807f51f2f0ed4c2e1aeee9c7ed1a6ee6ea60898d5ca1fbe9e60d397b7eb4b2e8b103c0137ba7a8e3909b6d6f9dfffc6b65b08cc89b5126ea78f7"} 19:20:43 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:43 INFO - Copying logs to upload dir... 19:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.324296 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-31 19:20:44.129150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:44.133219) ========= 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.LnR97GVD4f/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.cFyFFcYQPD/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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/efd9e39feb6ea79c6db51add3c1bb700c2d0a8a13f8721eb929a2628ff4efe92cfa798ef52966f562eaacd001a4471212a2afd816ce64778681ac48f078d8be5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9575ad3a8265963e3cdb27b664a2dec7029f3db24722637f943d19d560a910c1c86338751f5d03eae6eb43f294a657aad49ba341ec8524f390c0bbb33fb3eb1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670ce2f13900d834e73dae329adfbf7a6ea39faca678c365313926807d9c4cc8e71f261d604790ac4d7f841774166667cb1cff636510e6143a55ed66dbed8a3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96289f69af19807f51f2f0ed4c2e1aeee9c7ed1a6ee6ea60898d5ca1fbe9e60d397b7eb4b2e8b103c0137ba7a8e3909b6d6f9dfffc6b65b08cc89b5126ea78f7"} build_url:https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efd9e39feb6ea79c6db51add3c1bb700c2d0a8a13f8721eb929a2628ff4efe92cfa798ef52966f562eaacd001a4471212a2afd816ce64778681ac48f078d8be5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9575ad3a8265963e3cdb27b664a2dec7029f3db24722637f943d19d560a910c1c86338751f5d03eae6eb43f294a657aad49ba341ec8524f390c0bbb33fb3eb1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670ce2f13900d834e73dae329adfbf7a6ea39faca678c365313926807d9c4cc8e71f261d604790ac4d7f841774166667cb1cff636510e6143a55ed66dbed8a3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96289f69af19807f51f2f0ed4c2e1aeee9c7ed1a6ee6ea60898d5ca1fbe9e60d397b7eb4b2e8b103c0137ba7a8e3909b6d6f9dfffc6b65b08cc89b5126ea78f7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:44.171220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:44.171575) ========= 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.LnR97GVD4f/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.cFyFFcYQPD/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:44.220432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 19:20:44.220762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 19:20:44.221092) ========= ========= Total master_lag: 2.16 =========