builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0055 starttime: 1492517564.85 results: success (0) buildid: 20170418030220 builduid: 56e9293c91ec40e8837adfe7d092657e revision: bb38d935d699e0529f9e0bb35578d381026415c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:44.852301) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:44.852762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:44.853047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:44.895447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:44.895838) ========= 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.ieGa23kApP/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.rYbCMuMXbC/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-18 05:12:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.5M=0s 2017-04-18 05:12:45 (28.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.521221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.442000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.442429) ========= 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.ieGa23kApP/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.rYbCMuMXbC/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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.034281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.502154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 05:12:45.502822) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb38d935d699e0529f9e0bb35578d381026415c4 --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 bb38d935d699e0529f9e0bb35578d381026415c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ieGa23kApP/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.rYbCMuMXbC/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-18 05:12:45,649 truncating revision to first 12 chars 2017-04-18 05:12:45,650 Setting DEBUG logging. 2017-04-18 05:12:45,650 attempt 1/10 2017-04-18 05:12:45,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb38d935d699?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 05:12:46,720 unpacking tar archive at: mozilla-central-bb38d935d699/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346758 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 05:12:46.926236) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:46.926652) ========= script_repo_revision: bb38d935d699e0529f9e0bb35578d381026415c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:46.927110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:46.927396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:46.965310) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-18 05:12:46.965779) ========= /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.ieGa23kApP/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.rYbCMuMXbC/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:12:47 INFO - MultiFileLogger online at 20170418 05:12:47 in /builds/slave/test 05:12:47 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 05:12:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:47 INFO - {'append_to_log': False, 05:12:47 INFO - 'base_work_dir': '/builds/slave/test', 05:12:47 INFO - 'blob_upload_branch': 'Firefox', 05:12:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:47 INFO - 'branch': 'Firefox', 05:12:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:47 INFO - 'config_files': ('talos/mac_config.py',), 05:12:47 INFO - 'default_actions': ('clobber', 05:12:47 INFO - 'read-buildbot-config', 05:12:47 INFO - 'download-and-extract', 05:12:47 INFO - 'populate-webroot', 05:12:47 INFO - 'create-virtualenv', 05:12:47 INFO - 'install', 05:12:47 INFO - 'run-tests'), 05:12:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:47 INFO - 'download_minidump_stackwalk': True, 05:12:47 INFO - 'download_symbols': 'ondemand', 05:12:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:47 INFO - 'gecko_profile': False, 05:12:47 INFO - 'gecko_profile_interval': 0, 05:12:47 INFO - 'installer_path': 'installer.exe', 05:12:47 INFO - 'log_level': 'info', 05:12:47 INFO - 'log_name': 'talos', 05:12:47 INFO - 'log_to_console': True, 05:12:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:12:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:12:47 INFO - 'opt_config_files': (), 05:12:47 INFO - 'pip_index': False, 05:12:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:47 INFO - 'cmd': ('bash', 05:12:47 INFO - '-c', 05:12:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:47 INFO - 'enabled': True, 05:12:47 INFO - 'halt_on_failure': False, 05:12:47 INFO - 'name': 'check_screen_resolution'},), 05:12:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:47 INFO - 'cmd': ('bash', 05:12:47 INFO - '-c', 05:12:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:47 INFO - 'enabled': True, 05:12:47 INFO - 'halt_on_failure': False, 05:12:47 INFO - 'name': 'check_screen_resolution'},), 05:12:47 INFO - 'run_cmd_checks_enabled': True, 05:12:47 INFO - 'suite': 'dromaeojs-e10s', 05:12:47 INFO - 'system_bits': '32', 05:12:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:47 INFO - 'title': 't-yosemite-r7-0055', 05:12:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:47 INFO - 'use_talos_json': True, 05:12:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:47 INFO - 'work_dir': 'build'} 05:12:47 INFO - [mozharness: 2017-04-18 12:12:47.181197Z] Running clobber step. 05:12:47 INFO - Running pre-action listener: _resource_record_pre_action 05:12:47 INFO - Running main action method: clobber 05:12:47 INFO - rmtree: /builds/slave/test/build 05:12:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:49 INFO - Running post-action listener: _resource_record_post_action 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.727488Z] Finished clobber step (success) 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.727686Z] Running read-buildbot-config step. 05:12:49 INFO - Running pre-action listener: _resource_record_pre_action 05:12:49 INFO - Running main action method: read_buildbot_config 05:12:49 INFO - Using buildbot properties: 05:12:49 INFO - { 05:12:49 INFO - "project": "", 05:12:49 INFO - "product": "firefox", 05:12:49 INFO - "script_repo_revision": "production", 05:12:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:12:49 INFO - "repository": "", 05:12:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:12:49 INFO - "buildid": "20170418030220", 05:12:49 INFO - "stage_platform": "macosx64", 05:12:49 INFO - "basedir": "/builds/slave/test", 05:12:49 INFO - "nightly_build": "True", 05:12:49 INFO - "buildnumber": 122, 05:12:49 INFO - "slavename": "t-yosemite-r7-0055", 05:12:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:12:49 INFO - "platform": "yosemite_r7", 05:12:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:12:49 INFO - "branch": "mozilla-central", 05:12:49 INFO - "repo_path": "mozilla-central", 05:12:49 INFO - "revision": "bb38d935d699e0529f9e0bb35578d381026415c4", 05:12:49 INFO - "pgo_build": "False", 05:12:49 INFO - "builduid": "56e9293c91ec40e8837adfe7d092657e", 05:12:49 INFO - "slavebuilddir": "test" 05:12:49 INFO - } 05:12:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:12:49 INFO - Running post-action listener: _resource_record_post_action 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.731115Z] Finished read-buildbot-config step (success) 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.731257Z] Running download-and-extract step. 05:12:49 INFO - Running pre-action listener: _resource_record_pre_action 05:12:49 INFO - Running main action method: download_and_extract 05:12:49 INFO - mkdir: /builds/slave/test/build/tests 05:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:49 INFO - trying https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:12:49 INFO - Downloading https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/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 05:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/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 05:12:50 INFO - Downloaded 1325 bytes. 05:12:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:12:50 INFO - Using the following test package requirements: 05:12:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:12:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:12:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:12:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:12:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'jsshell-mac.zip'], 05:12:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:12:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:12:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:12:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:12:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:12:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:12:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:12:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:12:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:12:50 INFO - Fetch https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:12:53 INFO - Expected file size: 52629179 05:12:53 INFO - Obtained file size: 52629179 05:13:09 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 05:13:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:13:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:09 INFO - Fetch https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:13:10 INFO - Expected file size: 52629179 05:13:10 INFO - Obtained file size: 52629179 05:13:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:13:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:13:26 INFO - Fetch https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:13:27 INFO - Expected file size: 14408802 05:13:27 INFO - Obtained file size: 14408802 05:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:27 INFO - trying https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:13:27 INFO - Downloading https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/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 05:13:29 INFO - Downloaded 71438005 bytes. 05:13:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:13:29 INFO - mkdir: /builds/slave/test/properties 05:13:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:29 INFO - Contents: 05:13:29 INFO - build_url:https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:13:30 INFO - Running post-action listener: _resource_record_post_action 05:13:30 INFO - Running post-action listener: set_extra_try_arguments 05:13:30 INFO - [mozharness: 2017-04-18 12:13:30.207570Z] Finished download-and-extract step (success) 05:13:30 INFO - [mozharness: 2017-04-18 12:13:30.207715Z] Running populate-webroot step. 05:13:30 INFO - Running pre-action listener: _resource_record_pre_action 05:13:30 INFO - Running main action method: populate_webroot 05:13:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:30 INFO - '--tppagecycles', 05:13:30 INFO - '7'], 05:13:30 INFO - 'tests': ['tsvgm']}}, 05:13:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:13:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:13:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['damp', 'tps']}, 05:13:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'tests': ['damp', 'tps']}, 05:13:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['dromaeo_dom']}, 05:13:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:13:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:13:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['a11yr', 05:13:30 INFO - 'ts_paint', 05:13:30 INFO - 'tpaint', 05:13:30 INFO - 'sessionrestore', 05:13:30 INFO - 'sessionrestore_no_auto_restore', 05:13:30 INFO - 'tabpaint']}, 05:13:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:13:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:13:30 INFO - 'bloom_basic_ref']}, 05:13:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tsvgx', 05:13:30 INFO - 'tsvgr_opacity', 05:13:30 INFO - 'tart', 05:13:30 INFO - 'tscrollx', 05:13:30 INFO - 'cart', 05:13:30 INFO - 'tsvg_static']}, 05:13:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:13:30 INFO - 'tsvgr_opacity', 05:13:30 INFO - 'tart', 05:13:30 INFO - 'tscrollx', 05:13:30 INFO - 'cart', 05:13:30 INFO - 'tsvg_static']}, 05:13:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s'], 05:13:30 INFO - 'tests': ['tp5o']}, 05:13:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:13:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'talos_options': ['--disable-e10s', 05:13:30 INFO - '--xperf_path', 05:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:30 INFO - 'tests': ['tp5n']}, 05:13:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:13:30 INFO - 'talos_options': ['--xperf_path', 05:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:30 INFO - 'tests': ['tp5n']}}, 05:13:30 INFO - 'talos.zip': {'path': '', 05:13:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:30 INFO - Running post-action listener: _resource_record_post_action 05:13:30 INFO - [mozharness: 2017-04-18 12:13:30.226776Z] Finished populate-webroot step (success) 05:13:30 INFO - [mozharness: 2017-04-18 12:13:30.226908Z] Running create-virtualenv step. 05:13:30 INFO - Running pre-action listener: _resource_record_pre_action 05:13:30 INFO - Running main action method: create_virtualenv 05:13:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13:30 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 05:13:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:30 INFO - Using real prefix '/tools/python27' 05:13:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:33 INFO - Installing pip.................done. 05:13:33 INFO - Return code: 0 05:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:13:34 INFO - Reading from file tmpfile_stdout 05:13:34 INFO - Output received: 05:13:34 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) 05:13:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13: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', 'pip>=1.5'] in /builds/slave/test/build 05:13: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 pip>=1.5 05:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:34 INFO - 'HOME': '/Users/cltbld', 05:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:34 INFO - 'LOGNAME': 'cltbld', 05:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:34 INFO - 'MOZ_NO_REMOTE': '1', 05:13:34 INFO - 'NO_EM_RESTART': '1', 05:13:34 INFO - 'PAGER': '/bin/cat', 05:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:34 INFO - 'PWD': '/builds/slave/test', 05:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:34 INFO - 'SHELL': '/bin/bash', 05:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:34 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:34 INFO - 'USER': 'cltbld', 05:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:34 INFO - 'XPC_FLAGS': '0x0', 05:13:34 INFO - 'XPC_SERVICE_NAME': '0', 05:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:34 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 05:13:34 INFO - Cleaning up... 05:13:34 INFO - Return code: 0 05:13:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', '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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:13: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 psutil>=3.1.1 05:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:34 INFO - 'HOME': '/Users/cltbld', 05:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:34 INFO - 'LOGNAME': 'cltbld', 05:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:34 INFO - 'MOZ_NO_REMOTE': '1', 05:13:34 INFO - 'NO_EM_RESTART': '1', 05:13:34 INFO - 'PAGER': '/bin/cat', 05:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:34 INFO - 'PWD': '/builds/slave/test', 05:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:34 INFO - 'SHELL': '/bin/bash', 05:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:34 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:34 INFO - 'USER': 'cltbld', 05:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:34 INFO - 'XPC_FLAGS': '0x0', 05:13:34 INFO - 'XPC_SERVICE_NAME': '0', 05:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:34 INFO - Downloading/unpacking psutil>=3.1.1 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:38 INFO - Installing collected packages: psutil 05:13:38 INFO - Running setup.py install for psutil 05:13:38 INFO - building 'psutil._psutil_osx' extension 05:13:38 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 05:13:39 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 05:13:39 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 05:13:39 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 05:13:39 INFO - building 'psutil._psutil_posix' extension 05:13:39 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 05:13:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:13:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:13:39 INFO - ^ 05:13:39 INFO - 1 warning generated. 05:13:39 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 05:13:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:39 INFO - Successfully installed psutil 05:13:39 INFO - Cleaning up... 05:13:40 INFO - Return code: 0 05:13:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:13:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:40 INFO - 'HOME': '/Users/cltbld', 05:13:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:40 INFO - 'LOGNAME': 'cltbld', 05:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:40 INFO - 'MOZ_NO_REMOTE': '1', 05:13:40 INFO - 'NO_EM_RESTART': '1', 05:13:40 INFO - 'PAGER': '/bin/cat', 05:13:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:40 INFO - 'PWD': '/builds/slave/test', 05:13:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:40 INFO - 'SHELL': '/bin/bash', 05:13:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:40 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:40 INFO - 'USER': 'cltbld', 05:13:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:40 INFO - 'XPC_FLAGS': '0x0', 05:13:40 INFO - 'XPC_SERVICE_NAME': '0', 05:13:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:13:42 INFO - Installing collected packages: mozsystemmonitor 05:13:42 INFO - Running setup.py install for mozsystemmonitor 05:13:43 INFO - Successfully installed mozsystemmonitor 05:13:43 INFO - Cleaning up... 05:13:43 INFO - Return code: 0 05:13:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:43 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13:43 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 05:13:43 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 05:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:43 INFO - 'HOME': '/Users/cltbld', 05:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:43 INFO - 'LOGNAME': 'cltbld', 05:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:43 INFO - 'MOZ_NO_REMOTE': '1', 05:13:43 INFO - 'NO_EM_RESTART': '1', 05:13:43 INFO - 'PAGER': '/bin/cat', 05:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:43 INFO - 'PWD': '/builds/slave/test', 05:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:43 INFO - 'SHELL': '/bin/bash', 05:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:43 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:43 INFO - 'USER': 'cltbld', 05:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:43 INFO - 'XPC_FLAGS': '0x0', 05:13:43 INFO - 'XPC_SERVICE_NAME': '0', 05:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:43 INFO - Downloading/unpacking jsonschema==2.5.1 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:46 INFO - warning: no files found matching '*.txt' 05:13:46 INFO - no previously-included directories found matching 'build' 05:13:46 INFO - no previously-included directories found matching 'dist' 05:13:46 INFO - no previously-included directories found matching '.git*' 05:13:46 INFO - Installing collected packages: jsonschema, functools32 05:13:46 INFO - Running setup.py install for functools32 05:13:46 INFO - warning: no files found matching '*.txt' 05:13:46 INFO - no previously-included directories found matching 'build' 05:13:46 INFO - no previously-included directories found matching 'dist' 05:13:46 INFO - no previously-included directories found matching '.git*' 05:13:46 INFO - Successfully installed jsonschema functools32 05:13:46 INFO - Cleaning up... 05:13:46 INFO - Return code: 0 05:13:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:46 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13:46 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 05:13:46 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 05:13:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:46 INFO - 'HOME': '/Users/cltbld', 05:13:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:46 INFO - 'LOGNAME': 'cltbld', 05:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:46 INFO - 'MOZ_NO_REMOTE': '1', 05:13:46 INFO - 'NO_EM_RESTART': '1', 05:13:46 INFO - 'PAGER': '/bin/cat', 05:13:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:46 INFO - 'PWD': '/builds/slave/test', 05:13:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:46 INFO - 'SHELL': '/bin/bash', 05:13:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:46 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:46 INFO - 'USER': 'cltbld', 05:13:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:46 INFO - 'XPC_FLAGS': '0x0', 05:13:46 INFO - 'XPC_SERVICE_NAME': '0', 05:13:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:13:47 INFO - Cleaning up... 05:13:47 INFO - Return code: 0 05:13:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13:47 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')]} 05:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:47 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')]} 05:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:47 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13:47 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 05:13:47 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 05:13:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:47 INFO - 'HOME': '/Users/cltbld', 05:13:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:47 INFO - 'LOGNAME': 'cltbld', 05:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:47 INFO - 'MOZ_NO_REMOTE': '1', 05:13:47 INFO - 'NO_EM_RESTART': '1', 05:13:47 INFO - 'PAGER': '/bin/cat', 05:13:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:47 INFO - 'PWD': '/builds/slave/test', 05:13:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:47 INFO - 'SHELL': '/bin/bash', 05:13:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:47 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:47 INFO - 'USER': 'cltbld', 05:13:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:47 INFO - 'XPC_FLAGS': '0x0', 05:13:47 INFO - 'XPC_SERVICE_NAME': '0', 05:13:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 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 05:13:50 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 05:13:51 INFO - Downloading docopt-0.6.1.tar.gz 05:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:51 INFO - Running setup.py install for blobuploader 05:13:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:51 INFO - Running setup.py install for requests 05:13:51 INFO - Running setup.py install for docopt 05:13:52 INFO - Successfully installed blobuploader requests docopt 05:13:52 INFO - Cleaning up... 05:13:52 INFO - Return code: 0 05:13:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:52 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')]} 05:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:52 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')]} 05:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:52 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13:52 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 05:13:52 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 05:13:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:52 INFO - 'HOME': '/Users/cltbld', 05:13:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:52 INFO - 'LOGNAME': 'cltbld', 05:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:52 INFO - 'MOZ_NO_REMOTE': '1', 05:13:52 INFO - 'NO_EM_RESTART': '1', 05:13:52 INFO - 'PAGER': '/bin/cat', 05:13:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:52 INFO - 'PWD': '/builds/slave/test', 05:13:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:52 INFO - 'SHELL': '/bin/bash', 05:13:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:52 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:52 INFO - 'USER': 'cltbld', 05:13:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:52 INFO - 'XPC_FLAGS': '0x0', 05:13:52 INFO - 'XPC_SERVICE_NAME': '0', 05:13:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:52 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-SQQPAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:52 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-7se0jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:52 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-20D2IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:52 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-HnSZQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:52 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-3VNXXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:52 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-_F5PIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-etEgsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-pfYqUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-vSYii5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-AQ1FLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-wJpZ28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-9Nstu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-okrmvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-fBdaQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:53 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-qkqUGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:54 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-jjiOLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:54 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-LqGL38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:54 INFO - Running setup.py install for manifestparser 05:13:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:54 INFO - Running setup.py install for mozcrash 05:13:54 INFO - Running setup.py install for mozdebug 05:13:54 INFO - Running setup.py install for mozdevice 05:13:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:54 INFO - Running setup.py install for mozfile 05:13:54 INFO - Running setup.py install for mozhttpd 05:13:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Running setup.py install for mozinfo 05:13:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Running setup.py install for mozInstall 05:13:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Running setup.py install for mozleak 05:13:55 INFO - Running setup.py install for mozlog 05:13:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Running setup.py install for moznetwork 05:13:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Running setup.py install for mozprocess 05:13:55 INFO - Running setup.py install for mozprofile 05:13:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Running setup.py install for mozrunner 05:13:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Running setup.py install for mozscreenshot 05:13:56 INFO - Running setup.py install for moztest 05:13:56 INFO - Running setup.py install for mozversion 05:13:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:56 INFO - Cleaning up... 05:13:56 INFO - Return code: 0 05:13:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:56 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:13:56 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 05:13:56 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 05:13:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:13:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:56 INFO - 'HOME': '/Users/cltbld', 05:13:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:56 INFO - 'LOGNAME': 'cltbld', 05:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:56 INFO - 'MOZ_NO_REMOTE': '1', 05:13:56 INFO - 'NO_EM_RESTART': '1', 05:13:56 INFO - 'PAGER': '/bin/cat', 05:13:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:56 INFO - 'PWD': '/builds/slave/test', 05:13:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:56 INFO - 'SHELL': '/bin/bash', 05:13:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:13:56 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:13:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:56 INFO - 'USER': 'cltbld', 05:13:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:56 INFO - 'XPC_FLAGS': '0x0', 05:13:56 INFO - 'XPC_SERVICE_NAME': '0', 05:13:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-pnoGev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Q5c9is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Uq0dBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-AWDoFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Q1PIfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-sbfwZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-dSWoJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Bogv19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-4kjiWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:57 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)) 05:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:57 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-DYqe9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-cNm3jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-Ge8XxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-lZNeQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-MSZ7v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-8iEa_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-bbTGA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:58 INFO - Running setup.py (path:/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/pip-7pUgoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:58 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)) 05:13:58 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)) 05:13:58 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)) 05:13:58 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)) 05:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13:58 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 05:13:58 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 05:13:58 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 05:13:58 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 05:13:58 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 05:13:58 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 05:14:01 INFO - Downloading blessings-1.6.tar.gz 05:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:01 INFO - Installing collected packages: blessings 05:14:01 INFO - Running setup.py install for blessings 05:14:01 INFO - Successfully installed blessings 05:14:01 INFO - Cleaning up... 05:14:01 INFO - Return code: 0 05:14:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:02 INFO - Reading from file tmpfile_stdout 05:14:02 INFO - Current package versions: 05:14:02 INFO - blessings == 1.6 05:14:02 INFO - blobuploader == 1.2.4 05:14:02 INFO - docopt == 0.6.1 05:14:02 INFO - functools32 == 3.2.3-2 05:14:02 INFO - jsonschema == 2.5.1 05:14:02 INFO - manifestparser == 1.1 05:14:02 INFO - mozInstall == 1.12 05:14:02 INFO - mozcrash == 1.0 05:14:02 INFO - mozdebug == 0.1 05:14:02 INFO - mozdevice == 0.50 05:14:02 INFO - mozfile == 1.2 05:14:02 INFO - mozhttpd == 0.7 05:14:02 INFO - mozinfo == 0.9 05:14:02 INFO - mozleak == 0.1 05:14:02 INFO - mozlog == 3.4 05:14:02 INFO - moznetwork == 0.27 05:14:02 INFO - mozprocess == 0.25 05:14:02 INFO - mozprofile == 0.28 05:14:02 INFO - mozrunner == 6.13 05:14:02 INFO - mozscreenshot == 0.1 05:14:02 INFO - mozsystemmonitor == 0.3 05:14:02 INFO - moztest == 0.8 05:14:02 INFO - mozversion == 1.4 05:14:02 INFO - psutil == 3.1.1 05:14:02 INFO - requests == 1.2.3 05:14:02 INFO - wsgiref == 0.1.2 05:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:02 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')]} 05:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:02 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')]} 05:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:02 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:14:02 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 05:14:02 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 05:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:02 INFO - 'HOME': '/Users/cltbld', 05:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:02 INFO - 'LOGNAME': 'cltbld', 05:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:02 INFO - 'MOZ_NO_REMOTE': '1', 05:14:02 INFO - 'NO_EM_RESTART': '1', 05:14:02 INFO - 'PAGER': '/bin/cat', 05:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:02 INFO - 'PWD': '/builds/slave/test', 05:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:02 INFO - 'SHELL': '/bin/bash', 05:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:14:02 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:02 INFO - 'USER': 'cltbld', 05:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:02 INFO - 'XPC_FLAGS': '0x0', 05:14:02 INFO - 'XPC_SERVICE_NAME': '0', 05:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 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)) 05:14:02 INFO - Cleaning up... 05:14:02 INFO - Return code: 0 05:14:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:02 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')]} 05:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:02 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')]} 05:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:02 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 0x1075f7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae634bdb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, '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.ieGa23kApP/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.rYbCMuMXbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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 05:14:02 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 05:14:02 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 05:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:02 INFO - 'HOME': '/Users/cltbld', 05:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:02 INFO - 'LOGNAME': 'cltbld', 05:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:02 INFO - 'MOZ_NO_REMOTE': '1', 05:14:02 INFO - 'NO_EM_RESTART': '1', 05:14:02 INFO - 'PAGER': '/bin/cat', 05:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:02 INFO - 'PWD': '/builds/slave/test', 05:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:02 INFO - 'SHELL': '/bin/bash', 05:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:14:02 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:02 INFO - 'USER': 'cltbld', 05:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:02 INFO - 'XPC_FLAGS': '0x0', 05:14:02 INFO - 'XPC_SERVICE_NAME': '0', 05:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:14:02 INFO - Cleaning up... 05:14:02 INFO - Return code: 0 05:14:02 INFO - Running post-action listener: _resource_record_post_action 05:14:02 INFO - Running post-action listener: _start_resource_monitoring 05:14:02 INFO - Starting resource monitoring. 05:14:02 INFO - [mozharness: 2017-04-18 12:14:02.629828Z] Finished create-virtualenv step (success) 05:14:02 INFO - [mozharness: 2017-04-18 12:14:02.630799Z] Running install step. 05:14:02 INFO - Running pre-action listener: _resource_record_pre_action 05:14:02 INFO - Running main action method: install 05:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:02 INFO - Reading from file tmpfile_stdout 05:14:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:02 INFO - Reading from file tmpfile_stdout 05:14:02 INFO - Output received: 05:14:02 INFO - Usage: mozinstall [options] installer 05:14:02 INFO - Options: 05:14:02 INFO - -h, --help show this help message and exit 05:14:02 INFO - -d DEST, --destination=DEST 05:14:02 INFO - Directory to install application into. [default: 05:14:02 INFO - "/builds/slave/test"] 05:14:02 INFO - --app=APP Application being installed. [default: firefox] 05:14:02 INFO - mkdir: /builds/slave/test/build/application 05:14:02 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'] 05:14:02 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 05:14:22 INFO - Reading from file tmpfile_stdout 05:14:22 INFO - Output received: 05:14:22 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:14:22 INFO - Running post-action listener: _resource_record_post_action 05:14:22 INFO - [mozharness: 2017-04-18 12:14:22.904484Z] Finished install step (success) 05:14:22 INFO - [mozharness: 2017-04-18 12:14:22.904611Z] Running run-tests step. 05:14:22 INFO - Running pre-action listener: _resource_record_pre_action 05:14:22 INFO - Running main action method: run_tests 05:14:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:22 INFO - 2017-04-18 05:14:22.919 screenresolution[1628:8489] starting screenresolution argv=screenresolution get 05:14:22 INFO - 2017-04-18 05:14:22.921 screenresolution[1628:8489] Display 0: 1600x1200x32@60 05:14:22 INFO - 2017-04-18 05:14:22.927 screenresolution[1629:8492] starting screenresolution argv=screenresolution list 05:14:22 INFO - Available Modes on Display 0 05:14:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:23 INFO - Intel Iris: 05:14:23 INFO - Chipset Model: Intel Iris 05:14:23 INFO - Type: GPU 05:14:23 INFO - Bus: Built-In 05:14:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:23 INFO - Vendor: Intel (0x8086) 05:14:23 INFO - Device ID: 0x0a2e 05:14:23 INFO - Revision ID: 0x0009 05:14:23 INFO - Displays: 05:14:23 INFO - Display: 05:14:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:23 INFO - Display Serial Number: 1600x1200 60 05:14:23 INFO - Main Display: Yes 05:14:23 INFO - Mirror: Off 05:14:23 INFO - Online: Yes 05:14:23 INFO - Rotation: Supported 05:14:23 INFO - Return code: 0 05:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:14:23 INFO - Python 2.7.3 05:14:23 INFO - Return code: 0 05:14:23 INFO - grabbing minidump binary from tooltool 05:14:23 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')]} 05:14:23 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 0x1073d5d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073cabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:14:23 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 05:14:23 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 05:14:23 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 05:14:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:14:23 INFO - Return code: 0 05:14:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:14:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:14:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:14:23 INFO - ENV: RUST_BACKTRACE is now 1 05:14:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:14:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:14:23 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--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 05:14:23 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0055 --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 05:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ieGa23kApP/Render', 05:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:23 INFO - 'HOME': '/Users/cltbld', 05:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:23 INFO - 'LOGNAME': 'cltbld', 05:14:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:14:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:23 INFO - 'MOZ_NO_REMOTE': '1', 05:14:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:14:23 INFO - 'NO_EM_RESTART': '1', 05:14:23 INFO - 'PAGER': '/bin/cat', 05:14:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:23 INFO - 'PWD': '/builds/slave/test', 05:14:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:23 INFO - 'RUST_BACKTRACE': '1', 05:14:23 INFO - 'SHELL': '/bin/bash', 05:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rYbCMuMXbC/Listeners', 05:14:23 INFO - 'TMPDIR': '/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/', 05:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:23 INFO - 'USER': 'cltbld', 05:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:23 INFO - 'XPC_FLAGS': '0x0', 05:14:23 INFO - 'XPC_SERVICE_NAME': '0', 05:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:23 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--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 05:14:23 INFO - mozversion application_buildid: 20170418030220 05:14:23 INFO - mozversion application_changeset: bb38d935d699e0529f9e0bb35578d381026415c4 05:14:23 INFO - mozversion application_display_name: Nightly 05:14:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:23 INFO - mozversion application_name: Firefox 05:14:23 INFO - mozversion application_remotingname: firefox 05:14:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:14:23 INFO - mozversion application_vendor: Mozilla 05:14:23 INFO - mozversion application_version: 55.0a1 05:14:23 INFO - mozversion platform_buildid: 20170418030220 05:14:23 INFO - mozversion platform_changeset: bb38d935d699e0529f9e0bb35578d381026415c4 05:14:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:14:23 INFO - mozversion platform_version: 55.0a1 05:14:23 INFO - using testdate: 1492517663 05:14:23 INFO - actual date: 1492517663 05:14:23 INFO - starting webserver on 'localhost:49241' 05:14:23 INFO - SUITE-START | Running 2 tests 05:14:23 INFO - TEST-START | dromaeo_css 05:14:23 INFO - operating with platform_type : mac_ 05:14:23 INFO - Initialising browser for dromaeo_css test... 05:14:23 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmpOQ0oON/profile http://localhost:49241/getInfo.html) 05:14:26 INFO - PID 1639 | 2017-04-18 05:14:26.841 plugin-container[1642:8680] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x924b, name = 'com.apple.tsm.portname' 05:14:26 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:26 INFO - PID 1639 | 2017-04-18 05:14:26.842 plugin-container[1642:8680] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d0b, name = 'com.apple.CFPasteboardClient' 05:14:26 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:26 INFO - PID 1639 | 2017-04-18 05:14:26.842 plugin-container[1642:8680] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:14:26 INFO - PID 1639 | __metrics Screen width/height:1600/1200 05:14:26 INFO - PID 1639 | colorDepth:24 05:14:26 INFO - PID 1639 | Browser inner width/height: 1024/689 05:14:26 INFO - PID 1639 | __metrics 05:14:27 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 05:14:27 INFO - TEST-INFO | 1639: exit 0 05:14:27 INFO - Browser initialized. 05:14:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:14:27 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmpOQ0oON/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:30 INFO - PID 1644 | 2017-04-18 05:14:30.284 plugin-container[1645:8814] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 05:14:30 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:30 INFO - PID 1644 | 2017-04-18 05:14:30.284 plugin-container[1645:8814] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.CFPasteboardClient' 05:14:30 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:30 INFO - PID 1644 | 2017-04-18 05:14:30.284 plugin-container[1645:8814] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:14:40 INFO - PID 1644 | RSS: Main: 236142592 05:14:40 INFO - PID 1644 | 05:17:43 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:17:45 INFO - PID 1644 | RSS: Main: 252522496 05:17:45 INFO - PID 1644 | 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:19:28 INFO - PID 1644 | 05:19:28 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:28 INFO - PID 1644 | Full stack: 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:19:28 INFO - PID 1644 | 05:19:28 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:28 INFO - PID 1644 | Full stack: 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:19:28 INFO - PID 1644 | 05:19:28 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:28 INFO - PID 1644 | Full stack: 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | ************************* 05:19:28 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:19:28 INFO - PID 1644 | 05:19:28 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:28 INFO - PID 1644 | Full stack: 05:19:28 INFO - PID 1644 | ************************* 05:20:47 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:20:47 INFO - PID 1644 | RSS: Main: 256565248 05:20:47 INFO - PID 1644 | 05:23:49 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:23:50 INFO - PID 1644 | RSS: Main: 267075584 05:23:50 INFO - PID 1644 | 05:26:51 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:26:52 INFO - PID 1644 | RSS: Main: 259739648 05:26:52 INFO - PID 1644 | 05:29:55 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:29:55 INFO - PID 1644 | RSS: Main: 268922880 05:29:55 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:32:57 INFO - PID 1644 | RSS: Main: 263532544 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | __start_tp_report 05:32:57 INFO - PID 1644 | _x_x_mozilla_page_load 05:32:57 INFO - PID 1644 | _x_x_mozilla_page_load_details 05:32:57 INFO - PID 1644 | |i|pagename|runs| 05:32:57 INFO - PID 1644 | |0;dojo.html;3026.3947210557885;3501.3172431375883;3536.946945795812;3557.7331700122495;3581.570211574611;4809.735464549449;4810.5189481051875;5979.1031345298225;6149.508039356852;6184.7526098956105;5166.767495462704;5986.2517185351835;6149.508039356852;6167.013277875541;6206.069089636557;4538.773061346936;4816.373871396713;5409.134538473845;5444.972775136139;5483.122700367942;5314.123169677018;5439.93921185369;5470.124780035195;5506;5537.612367134302;4332.220200363933;5319.760610772524;5393.1370980642905;5437.32033495813;5459.12653975364;5381.865453363697;5401.756920938528;5402.729863506848;5424.457554244584;5452.127659574449;5347.946520534783;5352.91970620441;5391.595630327741;5399.514043736043;5423.430539793304;5217.399999000126;5249.343832020997;6139.676133582418;6178.320384757673;6178.938210617926;6602.2737498875085;6610.636414997173;6614;6623.70193341296;6625.039369291426;6682.097916781221;6691.096701945224;6699.296573859723;6715.294894036154;6734.0572319875255;6168.290646575611;6216.347283535254;6273.278572964167;6278.6860656966965;6317.4946004319545;6791.626460544718;6802.965985170043;6810.9318906810295;6825.9317406826285;6853.725850965906;5881.470667639847;6309.085182648582;6349.142865713162;6399.616023038632;6517.250516190604;6564.737410503526;6640.900386494206;6658.201015878029;6660.200775906922;6706.698198581075;6320.462760665395;6380.904286435707;6522.249941256816;6548.541602087808;6564.80305590833;6519.3154718754795;6557.803265902031;6579.605223686594;6580.276169621337;6598.10925525048;5316.840494785162;5328.547073498796;5333.093374126408;5347.438518955531;5348.625596208228;4682.461516925598;4685.508021657745;4700.9059818803435;4743.454502732161;4796.304535842283;5464.972675136679;6130.111133885651;6259.6870156492905;6288.591241569375;6324.3991820776955;6702.162229721285;6718.966405168041;6723.899141512881;6725.092112564741;6754;6150.138980542728;6250.281217659936;6290.622562646256;6302.873942521215;6324.557280990379;5744.023516002206;5752.798652047159;5755.280589926259;5817.243758311477;5844.736986835603;6806.081179040766;6818.318168183142;6827.726890924308;6834.384905358542;6850.828729281709;6608.207015158019;6640.136782218281;6681.76613818514;6688.799336019927;6700.095487109178;5569.830335629563;6486.5459417842185;6550.868982620225;6693.732250709917;6811.931880681328;5042.520960508746;5405.729713514387;6486.967565162144;6502.6748662567625;6543.901841472287;6378.45783108441;6394.072859435263;6485.535496511296;6512.837179070561;6536.673166341759;6273.404026617464;6487.124238227779;6496.350364963466;6497.057926600522;6504.15445992018;6219.875602487835;6292.685365731787;6403.359664033559;6441.3880681335195;6449.419552240321;5474.671519708831;6154.261488621394;6288.182536270256;6314.273858506331;6322.715477803418;6412.39082287182;6418.775342862978;6420.711068002044;6427.550071495138;6431.163948686641;6184.196054512884;6294.527910406646;6304.369563043659;6311.337309582611;6316.021016742412 05:32:57 INFO - PID 1644 | |1;ext.html;728.2935552514061;737.0087232672054;822.0176888618101;1260.5525038611288;1280.6542233596936;38092;38679.61320386795;38734.80632596833;38817.417738733944;39009;38369.232615347675;38594.42108368377;38642.420363694495;38716.8384948452;38722.80638596803;7030.437564994801;8052.154523775007;8463.06906240313;8672.34957378196;8683.56582170892;8672.566371681422;8711.564421778918;8780.165884241018;8784.912150878505;8790.824183516326;8722.607482663296;8740.825183496327;8780.604872780741;8784.560771961409;8801.075887031866;8742.956285218565;8771.561421928878;8778.034416214212;8783.868241976343;8792.868106978369;8478.152184781535;8540.060593334729;8585.914140858575;8593.914060859373;8615.698450554262;37609.81195094034;37719;37769.81115094434;37867.24265514674;37936.43095353572;3124.4063627910623;3555.768875023115;3582.462630605404;3601.045722883438;3614.2590768892314;31080.533791993137;31246;31287.904923327573;31340.529892051636;31387.37225255505;3032.9090127296217;3102.0383681058943;3112.688731126892;3112.7821052526106;3119.906402807919;252761;255219;255365;275481.2451875476;306988;41263.793681031406;41635;47316.053678926226;51613.483865161616;52014.73992630013;53042;53490;53509.73245133827;54514.45485545094;54597.1810422844;10445.529951152217;11093.33439993603;11745.765084698429;11933.582324618597;11950.342731149696;9358.906410935939;9397.483138427315;9439.150476457015;9442.244620430487;9457.054294570626;11057.668269951915;11151.944240278908;11173.385463799406;11221.831672524919;11242.831357529643;6246.500279977591;6310.5898116622275;6310.6213627182515;6315.305316415191;6828.180618325832;1010.2978429991085;1011.959521619127;1025.3898930136556;1032.3238278927165;1060.2525219720078;23536.176233831735;24440.38899027503;24699.382515436897;24769.752302477104;24938.87530562372;982.8034393121404;1063.5373612478597;1110.4114819145866;1128.3342827731678;1154.2324354304462;12366.44351004207;12575;12604.81092783609;12648;12718.618441446772;302848;303774;303985;304648;305800;40902;55056.898862023336;55805.7209713957;55892.72053639706;55991;1467.6844478436974;1502.6468779836512;1533.5782659768654;1534.4169215698187;1549.124744519343;20988.790112099294;23998.52002959966;24073.638895416934;24075.879620601783;24348.878255608608;38438;38598.80700596479;38663.42004869985;38817.805910970266;38825;261723;262391;262421;262463;262538;35673.64326356807;35787.28425431529;36057.91826245217;36174.8191259042;36251;45954.08091838211;46120.308195377766;46160;46308.842278943295;46340.07319853517;29021.7097829019;29650.369229692573;30567.694323057374;31051.53422698616;31063.0681079568;29819.403611928075;31163.84418077986;31184.844075779474;31237.8438107808;31251.84374078115;36068;36250;36829.44755828718;36891;36976.445353319185;23017.76982230223;29199;30582.847085764428;31389.686103138676;31541.842290788398;22552.548949021257;23917.402064948514;24302.270931872074;24730.876345618875;24746 05:32:57 INFO - PID 1644 | |2;jquery.html;427.34829385187606;436.3868764386037;438.44536661123686;450.19639942702275;452.5158080853484;19605;21279.25522606709;21904.342869713895;21984.45038874025;22086.24533829249;22063.779362206373;22507.32478025658;23459.178928737496;23570.76429235707;23880.40298992526;5841.386654401291;5967.433093856099;6012.248468941382;6198.969005154991;6360.491160707133;6055.666938318413;6220.222472190976;6224.906626400608;6236.812895613116;6240.500759939194;5291.894162116755;5932.822015339525;6080.756769729228;6146.078088286748;6279;6105.8168254952425;6139.969300153493;6174.444300012976;6178.413050760216;6181.536384771161;5423.918641220345;5454.563634909197;5489.862753431156;5519.558435325204;5522.0336441123045;27719.722802771917;27777;27819.304517387023;27871.442571148462;27993;2182.4980254541388;2229.5095079082575;2243.1363924888874;2244.539869326784;2246.9662955055687;15076.170810605412;17923.910380448015;18051.729224061648;18425.723614145798;18583.53541161468;1800.2169056460482;2142.0360837623134;2178.7385513738295;2184.737831460235;2187.9015444304887;157539;157974;158179.41820581877;158721;159379;10261.435621040915;12040.21738586989;12505;12595.496180152875;12708.936455317664;16398.6720265594;16443.917780411022;16466.75299870479;16483.093429861234;16519.6696066078;8685.869711954325;9050.728478145666;9074.001859795417;9075.13786190311;9190.77023074415;8668.913310866938;8687.91312086871;8703.216710496086;8860.202581767542;8867.955660221787;7842;7913.564753938474;7991.360691144694;8010.639521221559;8033.598320083973;1819.945401637953;2153.7092492513625;2156.1052163352033;2170.8263338932848;2191.736991560991;972.003696211389;998.6554638649654;1003.7553433742253;1011.3780025284544;1037.236697614059;20418;20667.79332206689;20726.378208653765;21661.35015949524;21664.891675541836;1024.9795004099876;1034.3535290443472;1055.9260851740457;1062.8777690565685;1067.8505009298703;9221.953890230507;10837.620683276205;11104.61133860311;11112.22214444981;11315.094792416587;531320;541470;545591;552393;553654.2317288388;114235;119894;133501.99747003804;135145.324273378;137980;1002.8595996560488;1217.3487184356327;1229.4959066782756;1244.55818184545;1249.188027781931;20765.065572048992;21294.574108518053;22200.55598887981;22458.775412246323;22483.662745059166;40644.187116256915;53286.73356633192;53574.46425535695;54606.36180914579;54674.90650187054;77041.2295877034;77324;77339.61330193313;77577;78502.6074869622;9000.59497322635;9022.060257044766;9158.175764181256;9233.492157931378;9233.492157931378;14381.424743010162;14576.198309093103;14630;14860.182689952157;14883.627909302355;10688.73278168021;11904.642860714192;11959.880401195876;12145.514179433078;12282.75434491323;11277.661670149908;11481.598144064918;11511.309321440405;11782.11634127461;11856.76286474283;11026.889731102587;12315.630531084082;12430.689232768891;12468.563600273947;12514.12401131912;8925.107489251022;8940.776480587778;8952.373333866566;9025.503597302211;9144.588493517675;12064.517419303129;12153.574624888086;12156;12305.876941230474;12352.876471235531 05:32:57 INFO - PID 1644 | |3;mootools.html;1219.2501611508922;1461.5323096609086;1464.0776310924116;1465.9005745690731;1468.2511918921348;9755;11625.47685354159;11931;12003.459844307015;12196.756064878697;11910.583129590466;11965.145402462633;12101.818472722916;12102.515899364036;12115.78842115788;2496.1637851319783;2535.8858851351642;2538.504991526653;2547.5159719653298;2552.5788244939654;2260.3106052653934;2450.1669432392982;2481.4540801023745;2523.2682522068576;2556.6676332076804;2491.8754062296903;2511.4977004599064;2533.4173140177772;2540.504601602688;2548.961765573518;2439.6706444629926;2508.41052352697;2510.874456277188;2517.169334119745;2527.608220725772;1838.6782313095289;2435.427674496492;2504.035946160723;2511.2466260122073;2543.8934063682173;11969.341686207255;12034.939825300906;12039.337836418994;12060.698482538006;12081.033517318594;5788.247527821356;6385.648789316586;6662.467002639777;6926.134233220848;6951.409130223937;3523.964760352415;4356.390105385217;4381.890452738675;4457.821687132511;4460.085682435093;1237.6101528018735;1238.8823061809114;1267.8098285257286;1274.604872489522;1281.4489769399154;13603.387847546785;16083.678326433406;16752.83247167525;16838.915805421017;16877.57806054846;5655.123455864347;5696.544276457874;5790.392008839095;5811.070228763462;5866.090755932837;12457.75084498305;12477.75044499123;12483.500659973499;12512;12514.998800095971;6638.5684930479365;6662.333766623299;6704.966475167593;6729.158855143107;6736.966315168491;6070.544709146743;6151.7539298428455;6171.197744293213;6218.968905155536;6233.937660623426;4402.84590039347;4488.640908727294;4522.841700540465;4545.454545454567;4557.567031132037;1298.6104168749525;1317.7166909114587;1318.083931667501;1333.6799168199757;1338.9799153012711;761.2881955371745;791.2917938445174;795.5823192823814;799.3804801279056;800.5716941436303;6593.934060659428;6889.345512176335;6987.650617469106;6991.545549539365;7007.4394048476;897.0760117079419;940.1820416237916;941.9623215071457;943.0946291560042;944.3625552751865;3876.9806150969066;3948.881533553998;4184.832606695698;4211.852585159566;4434.312681534368;12016.459259333351;14714.632134196516;15082.849171508144;15329.233538323038;15334.463293784664;13621.931890340684;15078.396864125532;15183.240837958057;15306.387744490095;15395.307211175525;7295.671694773748;8093.150219226896;8192.467489613156;8297.502149871027;8303.169683031769;5551.195076713773;6776.627285499345;6946.895796563157;7204.351608355064;7253.492255542062;12687.682807929506;12750.426230819821;12895.290759008345;13014.674633134247;13052;13108.868911311147;13229.272390018641;13325.466981320638;13441.731165376834;13450.596482105553;8956.910430895608;8984.59569319369;8989.190972812477;9114.908850911406;9202.447853128833;10860.619878304222;10979.1216702662;11088.667339979813;11090.944545277222;11121.888781112086;7860.528368297921;9329.440233585736;9380.859287110563;9442;9536.427814331162;9135.451872887648;9220.216281615869;9238.95380523093;9263.907360926574;9339.906600934175;8093.676252949816;8264.545450000307;8376.748697539084;8383.664653413794;8403.075661677332;5124.461931497288;6048.637081775108;6119.204503414528;6123.418275263843;6270.059491076375;5000.67495612784;6078;6197.721102550306;6239.376062393724;6278.215223097113 05:32:57 INFO - PID 1644 | |4;prototype.html;392.5113234023641;409.9159672267186;411.39730295117647;416.2590588752021;419.52593569266725;4646.697964632301;4932.630052746045;6216.844578885524;6218.4092511211475;6266.498680105592;5747.885042299152;5981.312149102854;5993.46058854703;6015.849603759908;6045.455908968192;3670.724695647824;4448.911021779579;4456.484795169634;4458.375827384169;4460.5316441773475;4319.892002699926;4455.710378825366;4465.374847521333;4476;4477.977610111961;4315.935260971088;4354.325079612665;4359.041010977596;4376.956230437702;4399.164158809832;4380.540043295456;4381.18947994622;4414.3378493225955;4418.525625649647;4420.160169567788;3804.714646401531;3810.485584446092;3826.7321287509885;3838.9616103838885;3850.7304488685804;5469.671819690791;5839.6204246724255;5864.179014937869;5870.853228669274;5883.61756485827;5008.974955125201;5257.737113144366;5277.836087204266;5286.762095705702;5300.2049692546425;5582.5436807804845;6037.577369584131;6431.967840160816;6444.452221561126;6480.870382592322;3722.9441558376648;4295;4298.8393133854;4312.956870431287;4324.632406245473;6014.188084608566;6021.42796434338;6254.937450625526;6542.640154791485;6696.363845434676;4367.6287515561535;4388.253996820548;4409.162259170747;4416.690831641754;4419.094085712485;3818.217265460574;4178.895527611773;4478.9552104478535;4485.573870482299;4487.461504619467;5002.299678045077;5218.452062533379;5270.1040823060175;5292.285541451932;5306.973465132727;5040.521150490697;5579.414161512983;6101.511879049665;6429.196350456193;6483.870322593521;1382.0740104130257;1502.66190107225;1519.384649217069;1532.6972073737456;1541.845815418449;993.2500961773815;1011.8886922438526;1014.2849291249652;1018.3024628129755;1025.3386565665105;6086.113304875503;6089.969550152221;6111.174991376196;6126.938730612636;6131.712340408475;5766.942330576724;6659.533832631766;6702.0282059101155;6717.865642687118;6753.8649227015185;5177.637565370388;5253.23828044939;5319;6125;6145.170401995673;3473.8263086846064;3496.667816557423;3501.336864989161;3510.438329867209;3515.4902539132195;6217.937820621826;6566.638834864033;6785;6817.522773405814;6828.5220034597105;5738.368779434259;6317.526185536103;6816.863662726718;6848.417884479775;6934.965325173443;6595.878700620906;6816.556923799937;6830.8633827324165;6834.692438840165;6852.554583952027;5196.9740151299;6638.402543770891;6653.336665833542;6693;6773.966130169318;5495.53287970511;5711.371749107512;6573.769918052845;6577.309382514958;6592.868142637216;5664.291963504562;6694.732210711517;6756.729730810909;6783.59298442095;6862.759803406857;3860.131470419133;4341.413909122228;4370.781460927004;4393.0774537347515;4401.801918913592;5550.639208451437;5832.650040997553;6570.145881035435;6685.665716714047;6699.229588597179;5551.500364967173;5942.168096466585;6383.265924418565;6480.935190648033;6493.577917435352;5010.5240002199735;5057.822976195963;5935.228420305332;6272.87088324106;6430;5335.493128152819;5377.8924421510565;5392.568594512508;6004.159417681441;6324.367563243639;6035.921679943172;6402.487800975818;6463;6470.35296470368;6474.643894585843;5883.411658834082;6204.627722336674;6204.751809927733;6211.223597050369;6279.811605651837 05:32:57 INFO - PID 1644 | |5;yui.html;837.6565608100673;844.1221130024778;862.9611667474965;871.3334299261062;879.5778026547257;15500.53498395047;16049.518514444557;16339.428120015802;17038.06290654012;17118.743218851727;16577.751333729975;16733.497995060137;18276.817231827677;18364;18450.81549184508;1006.9697909062739;1012.4836333469909;1029.1149611334247;1034.3586976074807;1035.9689209323694;956.1346980982188;993.3245393132703;1015.1878497202246;1016.6695823857239;1022;1052.6947185316249;1057.3867157048894;1063.7925604507125;1070.9036186743192;1076.2950267574752;1042.4579218806177;1058.7988282226352;1062.3041907550567;1065.978680426391;1066.3655125200494;577.3533642320585;771.8379140380526;792.5007245435396;792.9762107136795;802.4423025996934;16849.241784119746;17002.659946800995;17318;17535.5616109597;17540.824591754048;16768.66462670752;17124;17270.913645431818;17391;17518;13405.329733513285;13841.861581384159;13972.650683732887;14021.369038393297;14035.789463157958;3456.5679290088738;3487.616362200156;3534.4521599151917;3545.5213546171194;3546.982265088684;126394;127564;128998;129210;130617.34691326483;12086;12449.128561000824;12511.874881251253;12626.936865315798;12761.617151485285;24997.625035624482;25199.87400062988;25380.619290710652;25487.36281592975;25543.105991290216;6784.864302713918;6895.724171033203;6896.241413444517;6897.55165914214;6900.758473453405;3676.7058635309113;3710.1837595729435;3716.8141592920247;3742.5321834770652;3778.962210377861;4108.465899433114;4458.7324760514475;4465.866024019285;4468.776561171929;4473.2842745160615;893.1559676106017;893.1782759860944;900.8243392538392;910.6220918318955;911.977200569991;604.3110853626869;641.7144370755062;641.9407976838161;662.9635370054693;675.2100042949761;10915.563377464812;11118.499667514981;11589.130815188895;11620.6513804586;11771.587994420153;618.3445547719432;638.8594509207967;642.6080091144398;659.6635715784985;668.4919461209515;5184.222366644958;5197.194434862527;5230.843074707765;5286.048511267932;5305.124654432053;94353;94707;95189;95776.04223957671;95913;91413;91869.08130918739;92481.53759231161;92594.53702731578;94903;80510.59744701239;82192.58903705563;82529.58735206406;82628;83232.58383708163;8608.880845490046;10212.642557510451;10262.948685256526;10508.369497829848;10524;41130.79434602927;41153.79423102985;41689;41804.95487612834;41813.79093104515;52178.695532611986;53274;53415;53503.46496534985;53547.732261338446;13202.735945280849;13453.394597242952;13459.192448453125;13546.59360219195;13558.661033474242;12865.549705760253;14846.85153148498;15058.171800551076;15191.772123417937;15369.769453457984;13443.663908402368;13483.797743033667;13682.589522314347;13730;13790.65523361924;12943.805842912176;13287.402066907205;13675.384607692478;13742.793858091936;13818.654533636338;15637.84362156364;16045.919770401073;16080.839191608402;16516.926399783977;16594.58513537171;10266.332688375232;11646.650600481998;12187.87812121903;12223.205491643015;12226.449809758404;12100.697482562655;12578;13149.802752958522;13230.007749419025;13299.867001329863 05:32:57 INFO - PID 1644 | __end_tp_report 05:32:57 INFO - PID 1644 | __start_cc_report 05:32:57 INFO - PID 1644 | _x_x_mozilla_cycle_collect,422 05:32:57 INFO - PID 1644 | __end_cc_report 05:32:57 INFO - PID 1644 | __startTimestamp1492518777782__endTimestamp 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | ------- Summary: start ------- 05:32:57 INFO - PID 1644 | Number of tests: 6 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6018.54 Median:6294.53 stddev:755.90 (12.0%) stddev-sans-first:720.85 05:32:57 INFO - PID 1644 | Values: 3026.4 3501.3 3536.9 3557.7 3581.6 4809.7 4810.5 5979.1 6149.5 6184.8 5166.8 5986.3 6149.5 6167.0 6206.1 4538.8 4816.4 5409.1 5445.0 5483.1 5314.1 5439.9 5470.1 5506.0 5537.6 4332.2 5319.8 5393.1 5437.3 5459.1 5381.9 5401.8 5402.7 5424.5 5452.1 5347.9 5352.9 5391.6 5399.5 5423.4 5217.4 5249.3 6139.7 6178.3 6178.9 6602.3 6610.6 6614.0 6623.7 6625.0 6682.1 6691.1 6699.3 6715.3 6734.1 6168.3 6216.3 6273.3 6278.7 6317.5 6791.6 6803.0 6810.9 6825.9 6853.7 5881.5 6309.1 6349.1 6399.6 6517.3 6564.7 6640.9 6658.2 6660.2 6706.7 6320.5 6380.9 6522.2 6548.5 6564.8 6519.3 6557.8 6579.6 6580.3 6598.1 5316.8 5328.5 5333.1 5347.4 5348.6 4682.5 4685.5 4700.9 4743.5 4796.3 5465.0 6130.1 6259.7 6288.6 6324.4 6702.2 6719.0 6723.9 6725.1 6754.0 6150.1 6250.3 6290.6 6302.9 6324.6 5744.0 5752.8 5755.3 5817.2 5844.7 6806.1 6818.3 6827.7 6834.4 6850.8 6608.2 6640.1 6681.8 6688.8 6700.1 5569.8 6486.5 6550.9 6693.7 6811.9 5042.5 5405.7 6487.0 6502.7 6543.9 6378.5 6394.1 6485.5 6512.8 6536.7 6273.4 6487.1 6496.4 6497.1 6504.2 6219.9 6292.7 6403.4 6441.4 6449.4 5474.7 6154.3 6288.2 6314.3 6322.7 6412.4 6418.8 6420.7 6427.6 6431.2 6184.2 6294.5 6304.4 6311.3 6316.0 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:43343.69 Median:3591.75 stddev:73152.47 (2036.7%) stddev-sans-first:73287.70 05:32:57 INFO - PID 1644 | Values: 728.3 737.0 822.0 1260.6 1280.7 38092.0 38679.6 38734.8 38817.4 39009.0 38369.2 38594.4 38642.4 38716.8 38722.8 7030.4 8052.2 8463.1 8672.3 8683.6 8672.6 8711.6 8780.2 8784.9 8790.8 8722.6 8740.8 8780.6 8784.6 8801.1 8743.0 8771.6 8778.0 8783.9 8792.9 8478.2 8540.1 8585.9 8593.9 8615.7 37609.8 37719.0 37769.8 37867.2 37936.4 3124.4 3555.8 3582.5 3601.0 3614.3 31080.5 31246.0 31287.9 31340.5 31387.4 3032.9 3102.0 3112.7 3112.8 3119.9 252761.0 255219.0 255365.0 275481.2 306988.0 41263.8 41635.0 47316.1 51613.5 52014.7 53042.0 53490.0 53509.7 54514.5 54597.2 10445.5 11093.3 11745.8 11933.6 11950.3 9358.9 9397.5 9439.2 9442.2 9457.1 11057.7 11151.9 11173.4 11221.8 11242.8 6246.5 6310.6 6310.6 6315.3 6828.2 1010.3 1012.0 1025.4 1032.3 1060.3 23536.2 24440.4 24699.4 24769.8 24938.9 982.8 1063.5 1110.4 1128.3 1154.2 12366.4 12575.0 12604.8 12648.0 12718.6 302848.0 303774.0 303985.0 304648.0 305800.0 40902.0 55056.9 55805.7 55892.7 55991.0 1467.7 1502.6 1533.6 1534.4 1549.1 20988.8 23998.5 24073.6 24075.9 24348.9 38438.0 38598.8 38663.4 38817.8 38825.0 261723.0 262391.0 262421.0 262463.0 262538.0 35673.6 35787.3 36057.9 36174.8 36251.0 45954.1 46120.3 46160.0 46308.8 46340.1 29021.7 29650.4 30567.7 31051.5 31063.1 29819.4 31163.8 31184.8 31237.8 31251.8 36068.0 36250.0 36829.4 36891.0 36976.4 23017.8 29199.0 30582.8 31389.7 31541.8 22552.5 23917.4 24302.3 24730.9 24746.0 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:35514.55 Median:22143.40 stddev:92562.45 (418.0%) stddev-sans-first:92784.62 05:32:57 INFO - PID 1644 | Values: 427.3 436.4 438.4 450.2 452.5 19605.0 21279.3 21904.3 21984.5 22086.2 22063.8 22507.3 23459.2 23570.8 23880.4 5841.4 5967.4 6012.2 6199.0 6360.5 6055.7 6220.2 6224.9 6236.8 6240.5 5291.9 5932.8 6080.8 6146.1 6279.0 6105.8 6140.0 6174.4 6178.4 6181.5 5423.9 5454.6 5489.9 5519.6 5522.0 27719.7 27777.0 27819.3 27871.4 27993.0 2182.5 2229.5 2243.1 2244.5 2247.0 15076.2 17923.9 18051.7 18425.7 18583.5 1800.2 2142.0 2178.7 2184.7 2187.9 157539.0 157974.0 158179.4 158721.0 159379.0 10261.4 12040.2 12505.0 12595.5 12708.9 16398.7 16443.9 16466.8 16483.1 16519.7 8685.9 9050.7 9074.0 9075.1 9190.8 8668.9 8687.9 8703.2 8860.2 8868.0 7842.0 7913.6 7991.4 8010.6 8033.6 1819.9 2153.7 2156.1 2170.8 2191.7 972.0 998.7 1003.8 1011.4 1037.2 20418.0 20667.8 20726.4 21661.4 21664.9 1025.0 1034.4 1055.9 1062.9 1067.9 9222.0 10837.6 11104.6 11112.2 11315.1 531320.0 541470.0 545591.0 552393.0 553654.2 114235.0 119894.0 133502.0 135145.3 137980.0 1002.9 1217.3 1229.5 1244.6 1249.2 20765.1 21294.6 22200.6 22458.8 22483.7 40644.2 53286.7 53574.5 54606.4 54674.9 77041.2 77324.0 77339.6 77577.0 78502.6 9000.6 9022.1 9158.2 9233.5 9233.5 14381.4 14576.2 14630.0 14860.2 14883.6 10688.7 11904.6 11959.9 12145.5 12282.8 11277.7 11481.6 11511.3 11782.1 11856.8 11026.9 12315.6 12430.7 12468.6 12514.1 8925.1 8940.8 8952.4 9025.5 9144.6 12064.5 12153.6 12156.0 12305.9 12352.9 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:7115.28 Median:3912.93 stddev:4470.46 (114.2%) stddev-sans-first:4461.04 05:32:57 INFO - PID 1644 | Values: 1219.3 1461.5 1464.1 1465.9 1468.3 9755.0 11625.5 11931.0 12003.5 12196.8 11910.6 11965.1 12101.8 12102.5 12115.8 2496.2 2535.9 2538.5 2547.5 2552.6 2260.3 2450.2 2481.5 2523.3 2556.7 2491.9 2511.5 2533.4 2540.5 2549.0 2439.7 2508.4 2510.9 2517.2 2527.6 1838.7 2435.4 2504.0 2511.2 2543.9 11969.3 12034.9 12039.3 12060.7 12081.0 5788.2 6385.6 6662.5 6926.1 6951.4 3524.0 4356.4 4381.9 4457.8 4460.1 1237.6 1238.9 1267.8 1274.6 1281.4 13603.4 16083.7 16752.8 16838.9 16877.6 5655.1 5696.5 5790.4 5811.1 5866.1 12457.8 12477.8 12483.5 12512.0 12515.0 6638.6 6662.3 6705.0 6729.2 6737.0 6070.5 6151.8 6171.2 6219.0 6233.9 4402.8 4488.6 4522.8 4545.5 4557.6 1298.6 1317.7 1318.1 1333.7 1339.0 761.3 791.3 795.6 799.4 800.6 6593.9 6889.3 6987.7 6991.5 7007.4 897.1 940.2 942.0 943.1 944.4 3877.0 3948.9 4184.8 4211.9 4434.3 12016.5 14714.6 15082.8 15329.2 15334.5 13621.9 15078.4 15183.2 15306.4 15395.3 7295.7 8093.2 8192.5 8297.5 8303.2 5551.2 6776.6 6946.9 7204.4 7253.5 12687.7 12750.4 12895.3 13014.7 13052.0 13108.9 13229.3 13325.5 13441.7 13450.6 8956.9 8984.6 8989.2 9114.9 9202.4 10860.6 10979.1 11088.7 11090.9 11121.9 7860.5 9329.4 9380.9 9442.0 9536.4 9135.5 9220.2 9239.0 9263.9 9339.9 8093.7 8264.5 8376.7 8383.7 8403.1 5124.5 6048.6 6119.2 6123.4 6270.1 5000.7 6078.0 6197.7 6239.4 6278.2 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5135.87 Median:5580.98 stddev:1591.44 (28.5%) stddev-sans-first:1555.57 05:32:57 INFO - PID 1644 | Values: 392.5 409.9 411.4 416.3 419.5 4646.7 4932.6 6216.8 6218.4 6266.5 5747.9 5981.3 5993.5 6015.8 6045.5 3670.7 4448.9 4456.5 4458.4 4460.5 4319.9 4455.7 4465.4 4476.0 4478.0 4315.9 4354.3 4359.0 4377.0 4399.2 4380.5 4381.2 4414.3 4418.5 4420.2 3804.7 3810.5 3826.7 3839.0 3850.7 5469.7 5839.6 5864.2 5870.9 5883.6 5009.0 5257.7 5277.8 5286.8 5300.2 5582.5 6037.6 6432.0 6444.5 6480.9 3722.9 4295.0 4298.8 4313.0 4324.6 6014.2 6021.4 6254.9 6542.6 6696.4 4367.6 4388.3 4409.2 4416.7 4419.1 3818.2 4178.9 4479.0 4485.6 4487.5 5002.3 5218.5 5270.1 5292.3 5307.0 5040.5 5579.4 6101.5 6429.2 6483.9 1382.1 1502.7 1519.4 1532.7 1541.8 993.3 1011.9 1014.3 1018.3 1025.3 6086.1 6090.0 6111.2 6126.9 6131.7 5766.9 6659.5 6702.0 6717.9 6753.9 5177.6 5253.2 5319.0 6125.0 6145.2 3473.8 3496.7 3501.3 3510.4 3515.5 6217.9 6566.6 6785.0 6817.5 6828.5 5738.4 6317.5 6816.9 6848.4 6935.0 6595.9 6816.6 6830.9 6834.7 6852.6 5197.0 6638.4 6653.3 6693.0 6774.0 5495.5 5711.4 6573.8 6577.3 6592.9 5664.3 6694.7 6756.7 6783.6 6862.8 3860.1 4341.4 4370.8 4393.1 4401.8 5550.6 5832.7 6570.1 6685.7 6699.2 5551.5 5942.2 6383.3 6480.9 6493.6 5010.5 5057.8 5935.2 6272.9 6430.0 5335.5 5377.9 5392.6 6004.2 6324.4 6035.9 6402.5 6463.0 6470.4 6474.6 5883.4 6204.6 6204.8 6211.2 6279.8 05:32:57 INFO - PID 1644 | 05:32:57 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21184.62 Median:17454.50 stddev:30447.18 (174.4%) stddev-sans-first:30494.26 05:32:57 INFO - PID 1644 | Values: 837.7 844.1 863.0 871.3 879.6 15500.5 16049.5 16339.4 17038.1 17118.7 16577.8 16733.5 18276.8 18364.0 18450.8 1007.0 1012.5 1029.1 1034.4 1036.0 956.1 993.3 1015.2 1016.7 1022.0 1052.7 1057.4 1063.8 1070.9 1076.3 1042.5 1058.8 1062.3 1066.0 1066.4 577.4 771.8 792.5 793.0 802.4 16849.2 17002.7 17318.0 17535.6 17540.8 16768.7 17124.0 17270.9 17391.0 17518.0 13405.3 13841.9 13972.7 14021.4 14035.8 3456.6 3487.6 3534.5 3545.5 3547.0 126394.0 127564.0 128998.0 129210.0 130617.3 12086.0 12449.1 12511.9 12626.9 12761.6 24997.6 25199.9 25380.6 25487.4 25543.1 6784.9 6895.7 6896.2 6897.6 6900.8 3676.7 3710.2 3716.8 3742.5 3779.0 4108.5 4458.7 4465.9 4468.8 4473.3 893.2 893.2 900.8 910.6 912.0 604.3 641.7 641.9 663.0 675.2 10915.6 11118.5 11589.1 11620.7 11771.6 618.3 638.9 642.6 659.7 668.5 5184.2 5197.2 5230.8 5286.0 5305.1 94353.0 94707.0 95189.0 95776.0 95913.0 91413.0 91869.1 92481.5 92594.5 94903.0 80510.6 82192.6 82529.6 82628.0 83232.6 8608.9 10212.6 10262.9 10508.4 10524.0 41130.8 41153.8 41689.0 41805.0 41813.8 52178.7 53274.0 53415.0 53503.5 53547.7 13202.7 13453.4 13459.2 13546.6 13558.7 12865.5 14846.9 15058.2 15191.8 15369.8 13443.7 13483.8 13682.6 13730.0 13790.7 12943.8 13287.4 13675.4 13742.8 13818.7 15637.8 16045.9 16080.8 16516.9 16594.6 10266.3 11646.7 12187.9 12223.2 12226.4 12100.7 12578.0 13149.8 13230.0 13299.9 05:32:57 INFO - PID 1644 | -------- Summary: end -------- 05:32:57 INFO - PID 1644 | 05:32:58 INFO - TEST-INFO | 1644: exit 0 05:32:58 INFO - TEST-OK | dromaeo_css | took 1115014ms 05:32:58 INFO - TEST-START | kraken 05:32:58 INFO - operating with platform_type : mac_ 05:32:58 INFO - Initialising browser for kraken test... 05:32:58 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmp7iBsYv/profile http://localhost:49241/getInfo.html) 05:33:01 INFO - PID 1657 | 2017-04-18 05:33:01.461 plugin-container[1658:11288] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:33:01 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:01 INFO - PID 1657 | 2017-04-18 05:33:01.462 plugin-container[1658:11288] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 05:33:01 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:01 INFO - PID 1657 | 2017-04-18 05:33:01.462 plugin-container[1658:11288] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:01 INFO - PID 1657 | __metrics Screen width/height:1600/1200 05:33:01 INFO - PID 1657 | colorDepth:24 05:33:01 INFO - PID 1657 | Browser inner width/height: 1024/689 05:33:01 INFO - PID 1657 | __metrics 05:33:01 ERROR - PID 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 05:33:02 INFO - TEST-INFO | 1657: exit 0 05:33:02 INFO - Browser initialized. 05:33:02 INFO - Running cycle 1/1 for kraken test... 05:33:02 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/T/tmp7iBsYv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:05 INFO - PID 1659 | 2017-04-18 05:33:05.124 plugin-container[1660:11419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444f, name = 'com.apple.tsm.portname' 05:33:05 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:05 INFO - PID 1659 | 2017-04-18 05:33:05.125 plugin-container[1660:11419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 05:33:05 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:05 INFO - PID 1659 | 2017-04-18 05:33:05.125 plugin-container[1660:11419] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:15 INFO - PID 1659 | RSS: Main: 236523520 05:33:15 INFO - PID 1659 | 05:33:17 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:18 INFO - PID 1659 | RSS: Main: 248467456 05:33:18 INFO - PID 1659 | 05:33:21 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:33:21 INFO - PID 1659 | RSS: Main: 257097728 05:33:21 INFO - PID 1659 | 05:33:25 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:33:25 INFO - PID 1659 | RSS: Main: 258957312 05:33:25 INFO - PID 1659 | 05:33:27 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:33:28 INFO - PID 1659 | RSS: Main: 261341184 05:33:28 INFO - PID 1659 | 05:33:30 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:31 INFO - PID 1659 | RSS: Main: 261750784 05:33:31 INFO - PID 1659 | 05:33:33 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:34 INFO - PID 1659 | RSS: Main: 267870208 05:33:34 INFO - PID 1659 | 05:33:37 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:38 INFO - PID 1659 | RSS: Main: 269705216 05:33:38 INFO - PID 1659 | 05:33:41 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:33:41 INFO - PID 1659 | RSS: Main: 269115392 05:33:41 INFO - PID 1659 | 05:33:43 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:44 INFO - PID 1659 | RSS: Main: 268279808 05:33:44 INFO - PID 1659 | 05:33:46 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:46 INFO - PID 1659 | RSS: Main: 268214272 05:33:46 INFO - PID 1659 | 05:33:48 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:49 INFO - PID 1659 | RSS: Main: 267841536 05:33:49 INFO - PID 1659 | 05:33:52 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:53 INFO - PID 1659 | RSS: Main: 268226560 05:33:53 INFO - PID 1659 | 05:33:56 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:57 INFO - PID 1659 | RSS: Main: 268226560 05:33:57 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:33:58 INFO - PID 1659 | RSS: Main: 269979648 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | __start_tp_report 05:33:58 INFO - PID 1659 | _x_x_mozilla_page_load 05:33:58 INFO - PID 1659 | _x_x_mozilla_page_load_details 05:33:58 INFO - PID 1659 | |i|pagename|runs| 05:33:58 INFO - PID 1659 | |0;ai-astar;104;166;137;115;124;117;117;117;118;117 05:33:58 INFO - PID 1659 | |1;audio-beat-detection;148;110;113;153;114;112;114;110;135;111 05:33:58 INFO - PID 1659 | |2;audio-dft;197;199;198;215;218;220;199;199;239;208 05:33:58 INFO - PID 1659 | |3;audio-fft;80;49;85;116;57;58;57;58;84;88 05:33:58 INFO - PID 1659 | |4;audio-oscillator;84;71;84;72;70;73;95;105;103;104 05:33:58 INFO - PID 1659 | |5;imaging-gaussian-blur;94;90;90;90;90;89;90;103;88;89 05:33:58 INFO - PID 1659 | |6;imaging-darkroom;97;97;96;97;98;116;157;96;96;97 05:33:58 INFO - PID 1659 | |7;imaging-desaturate;92;93;102;149;135;91;91;90;91;90 05:33:58 INFO - PID 1659 | |8;json-parse-financial;50;51;50;60;63;50;52;54;49;46 05:33:58 INFO - PID 1659 | |9;json-stringify-tinderbox;51;90;85;87;91;69;58;58;57;57 05:33:58 INFO - PID 1659 | |10;stanford-crypto-aes;83;84;83;85;86;83;87;87;84;82 05:33:58 INFO - PID 1659 | |11;stanford-crypto-ccm;137;140;137;157;153;140;151;157;205;143 05:33:58 INFO - PID 1659 | |12;stanford-crypto-pbkdf2;188;179;239;194;180;183;189;182;211;233 05:33:58 INFO - PID 1659 | |13;stanford-crypto-sha256-iterative;71;72;68;70;70;66;69;70;69;72 05:33:58 INFO - PID 1659 | __end_tp_report 05:33:58 INFO - PID 1659 | __start_cc_report 05:33:58 INFO - PID 1659 | _x_x_mozilla_cycle_collect,984 05:33:58 INFO - PID 1659 | __end_cc_report 05:33:58 INFO - PID 1659 | __startTimestamp1492518838982__endTimestamp 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | ------- Summary: start ------- 05:33:58 INFO - PID 1659 | Number of tests: 14 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#0] ai-astar Cycles:10 Average:123.20 Median:117.50 stddev:17.13 (14.6%) stddev-sans-first:16.70 05:33:58 INFO - PID 1659 | Values: 104.0 166.0 137.0 115.0 124.0 117.0 117.0 117.0 118.0 117.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:114.00 stddev:16.75 (14.7%) stddev-sans-first:14.89 05:33:58 INFO - PID 1659 | Values: 148.0 110.0 113.0 153.0 114.0 112.0 114.0 110.0 135.0 111.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#2] audio-dft Cycles:10 Average:209.20 Median:211.50 stddev:13.76 (6.5%) stddev-sans-first:13.87 05:33:58 INFO - PID 1659 | Values: 197.0 199.0 198.0 215.0 218.0 220.0 199.0 199.0 239.0 208.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#3] audio-fft Cycles:10 Average:73.20 Median:69.00 stddev:20.88 (30.3%) stddev-sans-first:22.01 05:33:58 INFO - PID 1659 | Values: 80.0 49.0 85.0 116.0 57.0 58.0 57.0 58.0 84.0 88.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:72.50 stddev:14.56 (20.1%) stddev-sans-first:15.43 05:33:58 INFO - PID 1659 | Values: 84.0 71.0 84.0 72.0 70.0 73.0 95.0 105.0 103.0 104.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:90.00 stddev:4.40 (4.9%) stddev-sans-first:4.56 05:33:58 INFO - PID 1659 | Values: 94.0 90.0 90.0 90.0 90.0 89.0 90.0 103.0 88.0 89.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:97.00 stddev:19.36 (20.0%) stddev-sans-first:20.33 05:33:58 INFO - PID 1659 | Values: 97.0 97.0 96.0 97.0 98.0 116.0 157.0 96.0 96.0 97.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:91.00 stddev:21.42 (23.5%) stddev-sans-first:22.38 05:33:58 INFO - PID 1659 | Values: 92.0 93.0 102.0 149.0 135.0 91.0 91.0 90.0 91.0 90.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:51.50 stddev:5.21 (10.1%) stddev-sans-first:5.45 05:33:58 INFO - PID 1659 | Values: 50.0 51.0 50.0 60.0 63.0 50.0 52.0 54.0 49.0 46.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:77.00 stddev:16.13 (21.0%) stddev-sans-first:15.53 05:33:58 INFO - PID 1659 | Values: 51.0 90.0 85.0 87.0 91.0 69.0 58.0 58.0 57.0 57.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.78 (2.1%) stddev-sans-first:1.81 05:33:58 INFO - PID 1659 | Values: 83.0 84.0 83.0 85.0 86.0 83.0 87.0 87.0 84.0 82.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:152.00 stddev:20.22 (13.3%) stddev-sans-first:20.71 05:33:58 INFO - PID 1659 | Values: 137.0 140.0 137.0 157.0 153.0 140.0 151.0 157.0 205.0 143.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:191.50 stddev:22.21 (11.6%) stddev-sans-first:23.27 05:33:58 INFO - PID 1659 | Values: 188.0 179.0 239.0 194.0 180.0 183.0 189.0 182.0 211.0 233.0 05:33:58 INFO - PID 1659 | 05:33:58 INFO - PID 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.88 05:33:58 INFO - PID 1659 | Values: 71.0 72.0 68.0 70.0 70.0 66.0 69.0 70.0 69.0 72.0 05:33:58 INFO - PID 1659 | -------- Summary: end -------- 05:33:58 INFO - PID 1659 | 05:34:00 INFO - TEST-INFO | 1659: exit 0 05:34:00 INFO - TEST-OK | kraken | took 61550ms 05:34:00 INFO - SUITE-END | took 1176s 05:34:00 INFO - Completed test suite (00:19:36) 05:34:00 INFO - javascript benchmark 05:34:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7772.146238176664, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.3947210557885, 3501.3172431375883, 3536.946945795812, 3557.7331700122495, 3581.570211574611, 4809.735464549449, 4810.5189481051875, 5979.1031345298225, 6149.508039356852, 6184.7526098956105, 5166.767495462704, 5986.2517185351835, 6149.508039356852, 6167.013277875541, 6206.069089636557, 4538.773061346936, 4816.373871396713, 5409.134538473845, 5444.972775136139, 5483.122700367942, 5314.123169677018, 5439.93921185369, 5470.124780035195, 5506.0, 5537.612367134302, 4332.220200363933, 5319.760610772524, 5393.1370980642905, 5437.32033495813, 5459.12653975364, 5381.865453363697, 5401.756920938528, 5402.729863506848, 5424.457554244584, 5452.127659574449, 5347.946520534783, 5352.91970620441, 5391.595630327741, 5399.514043736043, 5423.430539793304, 5217.399999000126, 5249.343832020997, 6139.676133582418, 6178.320384757673, 6178.938210617926, 6602.2737498875085, 6610.636414997173, 6614.0, 6623.70193341296, 6625.039369291426, 6682.097916781221, 6691.096701945224, 6699.296573859723, 6715.294894036154, 6734.0572319875255, 6168.290646575611, 6216.347283535254, 6273.278572964167, 6278.6860656966965, 6317.4946004319545, 6791.626460544718, 6802.965985170043, 6810.9318906810295, 6825.9317406826285, 6853.725850965906, 5881.470667639847, 6309.085182648582, 6349.142865713162, 6399.616023038632, 6517.250516190604, 6564.737410503526, 6640.900386494206, 6658.201015878029, 6660.200775906922, 6706.698198581075, 6320.462760665395, 6380.904286435707, 6522.249941256816, 6548.541602087808, 6564.80305590833, 6519.3154718754795, 6557.803265902031, 6579.605223686594, 6580.276169621337, 6598.10925525048, 5316.840494785162, 5328.547073498796, 5333.093374126408, 5347.438518955531, 5348.625596208228, 4682.461516925598, 4685.508021657745, 4700.9059818803435, 4743.454502732161, 4796.304535842283, 5464.972675136679, 6130.111133885651, 6259.6870156492905, 6288.591241569375, 6324.3991820776955, 6702.162229721285, 6718.966405168041, 6723.899141512881, 6725.092112564741, 6754.0, 6150.138980542728, 6250.281217659936, 6290.622562646256, 6302.873942521215, 6324.557280990379, 5744.023516002206, 5752.798652047159, 5755.280589926259, 5817.243758311477, 5844.736986835603, 6806.081179040766, 6818.318168183142, 6827.726890924308, 6834.384905358542, 6850.828729281709, 6608.207015158019, 6640.136782218281, 6681.76613818514, 6688.799336019927, 6700.095487109178, 5569.830335629563, 6486.5459417842185, 6550.868982620225, 6693.732250709917, 6811.931880681328, 5042.520960508746, 5405.729713514387, 6486.967565162144, 6502.6748662567625, 6543.901841472287, 6378.45783108441, 6394.072859435263, 6485.535496511296, 6512.837179070561, 6536.673166341759, 6273.404026617464, 6487.124238227779, 6496.350364963466, 6497.057926600522, 6504.15445992018, 6219.875602487835, 6292.685365731787, 6403.359664033559, 6441.3880681335195, 6449.419552240321, 5474.671519708831, 6154.261488621394, 6288.182536270256, 6314.273858506331, 6322.715477803418, 6412.39082287182, 6418.775342862978, 6420.711068002044, 6427.550071495138, 6431.163948686641, 6184.196054512884, 6294.527910406646, 6304.369563043659, 6311.337309582611, 6316.021016742412], "value": 5968.990734653311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.2935552514061, 737.0087232672054, 822.0176888618101, 1260.5525038611288, 1280.6542233596936, 38092.0, 38679.61320386795, 38734.80632596833, 38817.417738733944, 39009.0, 38369.232615347675, 38594.42108368377, 38642.420363694495, 38716.8384948452, 38722.80638596803, 7030.437564994801, 8052.154523775007, 8463.06906240313, 8672.34957378196, 8683.56582170892, 8672.566371681422, 8711.564421778918, 8780.165884241018, 8784.912150878505, 8790.824183516326, 8722.607482663296, 8740.825183496327, 8780.604872780741, 8784.560771961409, 8801.075887031866, 8742.956285218565, 8771.561421928878, 8778.034416214212, 8783.868241976343, 8792.868106978369, 8478.152184781535, 8540.060593334729, 8585.914140858575, 8593.914060859373, 8615.698450554262, 37609.81195094034, 37719.0, 37769.81115094434, 37867.24265514674, 37936.43095353572, 3124.4063627910623, 3555.768875023115, 3582.462630605404, 3601.045722883438, 3614.2590768892314, 31080.533791993137, 31246.0, 31287.904923327573, 31340.529892051636, 31387.37225255505, 3032.9090127296217, 3102.0383681058943, 3112.688731126892, 3112.7821052526106, 3119.906402807919, 252761.0, 255219.0, 255365.0, 275481.2451875476, 306988.0, 41263.793681031406, 41635.0, 47316.053678926226, 51613.483865161616, 52014.73992630013, 53042.0, 53490.0, 53509.73245133827, 54514.45485545094, 54597.1810422844, 10445.529951152217, 11093.33439993603, 11745.765084698429, 11933.582324618597, 11950.342731149696, 9358.906410935939, 9397.483138427315, 9439.150476457015, 9442.244620430487, 9457.054294570626, 11057.668269951915, 11151.944240278908, 11173.385463799406, 11221.831672524919, 11242.831357529643, 6246.500279977591, 6310.5898116622275, 6310.6213627182515, 6315.305316415191, 6828.180618325832, 1010.2978429991085, 1011.959521619127, 1025.3898930136556, 1032.3238278927165, 1060.2525219720078, 23536.176233831735, 24440.38899027503, 24699.382515436897, 24769.752302477104, 24938.87530562372, 982.8034393121404, 1063.5373612478597, 1110.4114819145866, 1128.3342827731678, 1154.2324354304462, 12366.44351004207, 12575.0, 12604.81092783609, 12648.0, 12718.618441446772, 302848.0, 303774.0, 303985.0, 304648.0, 305800.0, 40902.0, 55056.898862023336, 55805.7209713957, 55892.72053639706, 55991.0, 1467.6844478436974, 1502.6468779836512, 1533.5782659768654, 1534.4169215698187, 1549.124744519343, 20988.790112099294, 23998.52002959966, 24073.638895416934, 24075.879620601783, 24348.878255608608, 38438.0, 38598.80700596479, 38663.42004869985, 38817.805910970266, 38825.0, 261723.0, 262391.0, 262421.0, 262463.0, 262538.0, 35673.64326356807, 35787.28425431529, 36057.91826245217, 36174.8191259042, 36251.0, 45954.08091838211, 46120.308195377766, 46160.0, 46308.842278943295, 46340.07319853517, 29021.7097829019, 29650.369229692573, 30567.694323057374, 31051.53422698616, 31063.0681079568, 29819.403611928075, 31163.84418077986, 31184.844075779474, 31237.8438107808, 31251.84374078115, 36068.0, 36250.0, 36829.44755828718, 36891.0, 36976.445353319185, 23017.76982230223, 29199.0, 30582.847085764428, 31389.686103138676, 31541.842290788398, 22552.548949021257, 23917.402064948514, 24302.270931872074, 24730.876345618875, 24746.0], "value": 17289.213967920343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.34829385187606, 436.3868764386037, 438.44536661123686, 450.19639942702275, 452.5158080853484, 19605.0, 21279.25522606709, 21904.342869713895, 21984.45038874025, 22086.24533829249, 22063.779362206373, 22507.32478025658, 23459.178928737496, 23570.76429235707, 23880.40298992526, 5841.386654401291, 5967.433093856099, 6012.248468941382, 6198.969005154991, 6360.491160707133, 6055.666938318413, 6220.222472190976, 6224.906626400608, 6236.812895613116, 6240.500759939194, 5291.894162116755, 5932.822015339525, 6080.756769729228, 6146.078088286748, 6279.0, 6105.8168254952425, 6139.969300153493, 6174.444300012976, 6178.413050760216, 6181.536384771161, 5423.918641220345, 5454.563634909197, 5489.862753431156, 5519.558435325204, 5522.0336441123045, 27719.722802771917, 27777.0, 27819.304517387023, 27871.442571148462, 27993.0, 2182.4980254541388, 2229.5095079082575, 2243.1363924888874, 2244.539869326784, 2246.9662955055687, 15076.170810605412, 17923.910380448015, 18051.729224061648, 18425.723614145798, 18583.53541161468, 1800.2169056460482, 2142.0360837623134, 2178.7385513738295, 2184.737831460235, 2187.9015444304887, 157539.0, 157974.0, 158179.41820581877, 158721.0, 159379.0, 10261.435621040915, 12040.21738586989, 12505.0, 12595.496180152875, 12708.936455317664, 16398.6720265594, 16443.917780411022, 16466.75299870479, 16483.093429861234, 16519.6696066078, 8685.869711954325, 9050.728478145666, 9074.001859795417, 9075.13786190311, 9190.77023074415, 8668.913310866938, 8687.91312086871, 8703.216710496086, 8860.202581767542, 8867.955660221787, 7842.0, 7913.564753938474, 7991.360691144694, 8010.639521221559, 8033.598320083973, 1819.945401637953, 2153.7092492513625, 2156.1052163352033, 2170.8263338932848, 2191.736991560991, 972.003696211389, 998.6554638649654, 1003.7553433742253, 1011.3780025284544, 1037.236697614059, 20418.0, 20667.79332206689, 20726.378208653765, 21661.35015949524, 21664.891675541836, 1024.9795004099876, 1034.3535290443472, 1055.9260851740457, 1062.8777690565685, 1067.8505009298703, 9221.953890230507, 10837.620683276205, 11104.61133860311, 11112.22214444981, 11315.094792416587, 531320.0, 541470.0, 545591.0, 552393.0, 553654.2317288388, 114235.0, 119894.0, 133501.99747003804, 135145.324273378, 137980.0, 1002.8595996560488, 1217.3487184356327, 1229.4959066782756, 1244.55818184545, 1249.188027781931, 20765.065572048992, 21294.574108518053, 22200.55598887981, 22458.775412246323, 22483.662745059166, 40644.187116256915, 53286.73356633192, 53574.46425535695, 54606.36180914579, 54674.90650187054, 77041.2295877034, 77324.0, 77339.61330193313, 77577.0, 78502.6074869622, 9000.59497322635, 9022.060257044766, 9158.175764181256, 9233.492157931378, 9233.492157931378, 14381.424743010162, 14576.198309093103, 14630.0, 14860.182689952157, 14883.627909302355, 10688.73278168021, 11904.642860714192, 11959.880401195876, 12145.514179433078, 12282.75434491323, 11277.661670149908, 11481.598144064918, 11511.309321440405, 11782.11634127461, 11856.76286474283, 11026.889731102587, 12315.630531084082, 12430.689232768891, 12468.563600273947, 12514.12401131912, 8925.107489251022, 8940.776480587778, 8952.373333866566, 9025.503597302211, 9144.588493517675, 12064.517419303129, 12153.574624888086, 12156.0, 12305.876941230474, 12352.876471235531], "value": 10536.509860803439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.2501611508922, 1461.5323096609086, 1464.0776310924116, 1465.9005745690731, 1468.2511918921348, 9755.0, 11625.47685354159, 11931.0, 12003.459844307015, 12196.756064878697, 11910.583129590466, 11965.145402462633, 12101.818472722916, 12102.515899364036, 12115.78842115788, 2496.1637851319783, 2535.8858851351642, 2538.504991526653, 2547.5159719653298, 2552.5788244939654, 2260.3106052653934, 2450.1669432392982, 2481.4540801023745, 2523.2682522068576, 2556.6676332076804, 2491.8754062296903, 2511.4977004599064, 2533.4173140177772, 2540.504601602688, 2548.961765573518, 2439.6706444629926, 2508.41052352697, 2510.874456277188, 2517.169334119745, 2527.608220725772, 1838.6782313095289, 2435.427674496492, 2504.035946160723, 2511.2466260122073, 2543.8934063682173, 11969.341686207255, 12034.939825300906, 12039.337836418994, 12060.698482538006, 12081.033517318594, 5788.247527821356, 6385.648789316586, 6662.467002639777, 6926.134233220848, 6951.409130223937, 3523.964760352415, 4356.390105385217, 4381.890452738675, 4457.821687132511, 4460.085682435093, 1237.6101528018735, 1238.8823061809114, 1267.8098285257286, 1274.604872489522, 1281.4489769399154, 13603.387847546785, 16083.678326433406, 16752.83247167525, 16838.915805421017, 16877.57806054846, 5655.123455864347, 5696.544276457874, 5790.392008839095, 5811.070228763462, 5866.090755932837, 12457.75084498305, 12477.75044499123, 12483.500659973499, 12512.0, 12514.998800095971, 6638.5684930479365, 6662.333766623299, 6704.966475167593, 6729.158855143107, 6736.966315168491, 6070.544709146743, 6151.7539298428455, 6171.197744293213, 6218.968905155536, 6233.937660623426, 4402.84590039347, 4488.640908727294, 4522.841700540465, 4545.454545454567, 4557.567031132037, 1298.6104168749525, 1317.7166909114587, 1318.083931667501, 1333.6799168199757, 1338.9799153012711, 761.2881955371745, 791.2917938445174, 795.5823192823814, 799.3804801279056, 800.5716941436303, 6593.934060659428, 6889.345512176335, 6987.650617469106, 6991.545549539365, 7007.4394048476, 897.0760117079419, 940.1820416237916, 941.9623215071457, 943.0946291560042, 944.3625552751865, 3876.9806150969066, 3948.881533553998, 4184.832606695698, 4211.852585159566, 4434.312681534368, 12016.459259333351, 14714.632134196516, 15082.849171508144, 15329.233538323038, 15334.463293784664, 13621.931890340684, 15078.396864125532, 15183.240837958057, 15306.387744490095, 15395.307211175525, 7295.671694773748, 8093.150219226896, 8192.467489613156, 8297.502149871027, 8303.169683031769, 5551.195076713773, 6776.627285499345, 6946.895796563157, 7204.351608355064, 7253.492255542062, 12687.682807929506, 12750.426230819821, 12895.290759008345, 13014.674633134247, 13052.0, 13108.868911311147, 13229.272390018641, 13325.466981320638, 13441.731165376834, 13450.596482105553, 8956.910430895608, 8984.59569319369, 8989.190972812477, 9114.908850911406, 9202.447853128833, 10860.619878304222, 10979.1216702662, 11088.667339979813, 11090.944545277222, 11121.888781112086, 7860.528368297921, 9329.440233585736, 9380.859287110563, 9442.0, 9536.427814331162, 9135.451872887648, 9220.216281615869, 9238.95380523093, 9263.907360926574, 9339.906600934175, 8093.676252949816, 8264.545450000307, 8376.748697539084, 8383.664653413794, 8403.075661677332, 5124.461931497288, 6048.637081775108, 6119.204503414528, 6123.418275263843, 6270.059491076375, 5000.67495612784, 6078.0, 6197.721102550306, 6239.376062393724, 6278.215223097113], "value": 5396.494945688565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5113234023641, 409.9159672267186, 411.39730295117647, 416.2590588752021, 419.52593569266725, 4646.697964632301, 4932.630052746045, 6216.844578885524, 6218.4092511211475, 6266.498680105592, 5747.885042299152, 5981.312149102854, 5993.46058854703, 6015.849603759908, 6045.455908968192, 3670.724695647824, 4448.911021779579, 4456.484795169634, 4458.375827384169, 4460.5316441773475, 4319.892002699926, 4455.710378825366, 4465.374847521333, 4476.0, 4477.977610111961, 4315.935260971088, 4354.325079612665, 4359.041010977596, 4376.956230437702, 4399.164158809832, 4380.540043295456, 4381.18947994622, 4414.3378493225955, 4418.525625649647, 4420.160169567788, 3804.714646401531, 3810.485584446092, 3826.7321287509885, 3838.9616103838885, 3850.7304488685804, 5469.671819690791, 5839.6204246724255, 5864.179014937869, 5870.853228669274, 5883.61756485827, 5008.974955125201, 5257.737113144366, 5277.836087204266, 5286.762095705702, 5300.2049692546425, 5582.5436807804845, 6037.577369584131, 6431.967840160816, 6444.452221561126, 6480.870382592322, 3722.9441558376648, 4295.0, 4298.8393133854, 4312.956870431287, 4324.632406245473, 6014.188084608566, 6021.42796434338, 6254.937450625526, 6542.640154791485, 6696.363845434676, 4367.6287515561535, 4388.253996820548, 4409.162259170747, 4416.690831641754, 4419.094085712485, 3818.217265460574, 4178.895527611773, 4478.9552104478535, 4485.573870482299, 4487.461504619467, 5002.299678045077, 5218.452062533379, 5270.1040823060175, 5292.285541451932, 5306.973465132727, 5040.521150490697, 5579.414161512983, 6101.511879049665, 6429.196350456193, 6483.870322593521, 1382.0740104130257, 1502.66190107225, 1519.384649217069, 1532.6972073737456, 1541.845815418449, 993.2500961773815, 1011.8886922438526, 1014.2849291249652, 1018.3024628129755, 1025.3386565665105, 6086.113304875503, 6089.969550152221, 6111.174991376196, 6126.938730612636, 6131.712340408475, 5766.942330576724, 6659.533832631766, 6702.0282059101155, 6717.865642687118, 6753.8649227015185, 5177.637565370388, 5253.23828044939, 5319.0, 6125.0, 6145.170401995673, 3473.8263086846064, 3496.667816557423, 3501.336864989161, 3510.438329867209, 3515.4902539132195, 6217.937820621826, 6566.638834864033, 6785.0, 6817.522773405814, 6828.5220034597105, 5738.368779434259, 6317.526185536103, 6816.863662726718, 6848.417884479775, 6934.965325173443, 6595.878700620906, 6816.556923799937, 6830.8633827324165, 6834.692438840165, 6852.554583952027, 5196.9740151299, 6638.402543770891, 6653.336665833542, 6693.0, 6773.966130169318, 5495.53287970511, 5711.371749107512, 6573.769918052845, 6577.309382514958, 6592.868142637216, 5664.291963504562, 6694.732210711517, 6756.729730810909, 6783.59298442095, 6862.759803406857, 3860.131470419133, 4341.413909122228, 4370.781460927004, 4393.0774537347515, 4401.801918913592, 5550.639208451437, 5832.650040997553, 6570.145881035435, 6685.665716714047, 6699.229588597179, 5551.500364967173, 5942.168096466585, 6383.265924418565, 6480.935190648033, 6493.577917435352, 5010.5240002199735, 5057.822976195963, 5935.228420305332, 6272.87088324106, 6430.0, 5335.493128152819, 5377.8924421510565, 5392.568594512508, 6004.159417681441, 6324.367563243639, 6035.921679943172, 6402.487800975818, 6463.0, 6470.35296470368, 6474.643894585843, 5883.411658834082, 6204.627722336674, 6204.751809927733, 6211.223597050369, 6279.811605651837], "value": 4650.5805593006235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.6565608100673, 844.1221130024778, 862.9611667474965, 871.3334299261062, 879.5778026547257, 15500.53498395047, 16049.518514444557, 16339.428120015802, 17038.06290654012, 17118.743218851727, 16577.751333729975, 16733.497995060137, 18276.817231827677, 18364.0, 18450.81549184508, 1006.9697909062739, 1012.4836333469909, 1029.1149611334247, 1034.3586976074807, 1035.9689209323694, 956.1346980982188, 993.3245393132703, 1015.1878497202246, 1016.6695823857239, 1022.0, 1052.6947185316249, 1057.3867157048894, 1063.7925604507125, 1070.9036186743192, 1076.2950267574752, 1042.4579218806177, 1058.7988282226352, 1062.3041907550567, 1065.978680426391, 1066.3655125200494, 577.3533642320585, 771.8379140380526, 792.5007245435396, 792.9762107136795, 802.4423025996934, 16849.241784119746, 17002.659946800995, 17318.0, 17535.5616109597, 17540.824591754048, 16768.66462670752, 17124.0, 17270.913645431818, 17391.0, 17518.0, 13405.329733513285, 13841.861581384159, 13972.650683732887, 14021.369038393297, 14035.789463157958, 3456.5679290088738, 3487.616362200156, 3534.4521599151917, 3545.5213546171194, 3546.982265088684, 126394.0, 127564.0, 128998.0, 129210.0, 130617.34691326483, 12086.0, 12449.128561000824, 12511.874881251253, 12626.936865315798, 12761.617151485285, 24997.625035624482, 25199.87400062988, 25380.619290710652, 25487.36281592975, 25543.105991290216, 6784.864302713918, 6895.724171033203, 6896.241413444517, 6897.55165914214, 6900.758473453405, 3676.7058635309113, 3710.1837595729435, 3716.8141592920247, 3742.5321834770652, 3778.962210377861, 4108.465899433114, 4458.7324760514475, 4465.866024019285, 4468.776561171929, 4473.2842745160615, 893.1559676106017, 893.1782759860944, 900.8243392538392, 910.6220918318955, 911.977200569991, 604.3110853626869, 641.7144370755062, 641.9407976838161, 662.9635370054693, 675.2100042949761, 10915.563377464812, 11118.499667514981, 11589.130815188895, 11620.6513804586, 11771.587994420153, 618.3445547719432, 638.8594509207967, 642.6080091144398, 659.6635715784985, 668.4919461209515, 5184.222366644958, 5197.194434862527, 5230.843074707765, 5286.048511267932, 5305.124654432053, 94353.0, 94707.0, 95189.0, 95776.04223957671, 95913.0, 91413.0, 91869.08130918739, 92481.53759231161, 92594.53702731578, 94903.0, 80510.59744701239, 82192.58903705563, 82529.58735206406, 82628.0, 83232.58383708163, 8608.880845490046, 10212.642557510451, 10262.948685256526, 10508.369497829848, 10524.0, 41130.79434602927, 41153.79423102985, 41689.0, 41804.95487612834, 41813.79093104515, 52178.695532611986, 53274.0, 53415.0, 53503.46496534985, 53547.732261338446, 13202.735945280849, 13453.394597242952, 13459.192448453125, 13546.59360219195, 13558.661033474242, 12865.549705760253, 14846.85153148498, 15058.171800551076, 15191.772123417937, 15369.769453457984, 13443.663908402368, 13483.797743033667, 13682.589522314347, 13730.0, 13790.65523361924, 12943.805842912176, 13287.402066907205, 13675.384607692478, 13742.793858091936, 13818.654533636338, 15637.84362156364, 16045.919770401073, 16080.839191608402, 16516.926399783977, 16594.58513537171, 10266.332688375232, 11646.650600481998, 12187.87812121903, 12223.205491643015, 12226.449809758404, 12100.697482562655, 12578.0, 13149.802752958522, 13230.007749419025, 13299.867001329863], "value": 8076.486105995572, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 166.0, 137.0, 115.0, 124.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 113.0, 153.0, 114.0, 112.0, 114.0, 110.0, 135.0, 111.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 198.0, 215.0, 218.0, 220.0, 199.0, 199.0, 239.0, 208.0], "value": 209.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 49.0, 85.0, 116.0, 57.0, 58.0, 57.0, 58.0, 84.0, 88.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 84.0, 72.0, 70.0, 73.0, 95.0, 105.0, 103.0, 104.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 90.0, 90.0, 90.0, 89.0, 90.0, 103.0, 88.0, 89.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 98.0, 116.0, 157.0, 96.0, 96.0, 97.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 102.0, 149.0, 135.0, 91.0, 91.0, 90.0, 91.0, 90.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 60.0, 63.0, 50.0, 52.0, 54.0, 49.0, 46.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 90.0, 85.0, 87.0, 91.0, 69.0, 58.0, 58.0, 57.0, 57.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 85.0, 86.0, 83.0, 87.0, 87.0, 84.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 137.0, 157.0, 153.0, 140.0, 151.0, 157.0, 205.0, 143.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 179.0, 239.0, 194.0, 180.0, 183.0, 189.0, 182.0, 211.0, 233.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 68.0, 70.0, 70.0, 66.0, 69.0, 70.0, 69.0, 72.0], "value": 69.7, "unit": "score"}]}]} 05:34:00 INFO - Return code: 0 05:34:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:34:00 ERROR - # TBPL SUCCESS # 05:34:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:00 INFO - 2017-04-18 05:34:00.291 screenresolution[1665:11836] starting screenresolution argv=screenresolution get 05:34:00 INFO - 2017-04-18 05:34:00.294 screenresolution[1665:11836] Display 0: 1600x1200x32@60 05:34:00 INFO - 2017-04-18 05:34:00.300 screenresolution[1666:11839] starting screenresolution argv=screenresolution list 05:34:00 INFO - Available Modes on Display 0 05:34:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:00 INFO - Intel Iris: 05:34:00 INFO - Chipset Model: Intel Iris 05:34:00 INFO - Type: GPU 05:34:00 INFO - Bus: Built-In 05:34:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:00 INFO - Vendor: Intel (0x8086) 05:34:00 INFO - Device ID: 0x0a2e 05:34:00 INFO - Revision ID: 0x0009 05:34:00 INFO - Displays: 05:34:00 INFO - Display: 05:34:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:00 INFO - Display Serial Number: 1600x1200 60 05:34:00 INFO - Main Display: Yes 05:34:00 INFO - Mirror: Off 05:34:00 INFO - Online: Yes 05:34:00 INFO - Rotation: Supported 05:34:00 INFO - Return code: 0 05:34:00 INFO - Running post-action listener: _resource_record_post_action 05:34:00 INFO - [mozharness: 2017-04-18 12:34:00.550217Z] Finished run-tests step (success) 05:34:00 INFO - Running post-run listener: _resource_record_post_run 05:34:00 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 33022464; Write bytes: 520233984; Read time: 330; Write time: 1631 05:34:00 INFO - TinderboxPrint: CPU usage
54.1% 05:34:00 INFO - TinderboxPrint: I/O read bytes / time
33,022,464 / 330 05:34:00 INFO - TinderboxPrint: I/O write bytes / time
520,233,984 / 1,631 05:34:00 INFO - TinderboxPrint: CPU idle
2,199.4 (45.9%) 05:34:00 INFO - TinderboxPrint: CPU system
964.7 (20.1%) 05:34:00 INFO - TinderboxPrint: CPU user
1,625.7 (33.9%) 05:34:00 INFO - TinderboxPrint: Swap in / out
238,346,240 / 0 05:34:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205916672; Write bytes: 204061696; Read time: 15928; Write time: 368 05:34:00 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30941696; Write bytes: 309118976; Read time: 308; Write time: 1235 05:34:01 INFO - Running post-run listener: _upload_blobber_files 05:34:01 INFO - Blob upload gear active. 05:34:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:01 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 05:34:01 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'] 05:34:01 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 05:34:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:34:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:34:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:02 INFO - (blobuploader) - INFO - Done attempting. 05:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:03 INFO - (blobuploader) - INFO - Done attempting. 05:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:34:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:04 INFO - (blobuploader) - INFO - Done attempting. 05:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:06 INFO - (blobuploader) - INFO - Done attempting. 05:34:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:06 INFO - Return code: 0 05:34:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/842fea67ad2e4a9e9cf57e3a97b2b3817586ef0c430fb5a771d954084108061148a12651450f2999e33e40c2181b612343823e093e3fb3112c6c5ee3ed444c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cff271d95146e98bf462fab78837e2eee61e329d772e8a4482324b787b69e520370efb9597d5e4fe321d69fa9b1f266add48c627934bf001c8fd45ec43ea93e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10db3a426f4e59797a29d3365d975e8b14770e1e7b6cf204a8ef7a29a85aed66947cfb118d34f160ec46c262882c0bb99fdd9447d8e1fe72440c0d98f0b2dd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadbbaded5a7e9abce908623899464d4b96b88b25e29ae98fe3fc783ea0c6a08b88ad99e91b1714f10b2440d5b92429624e990fb2887d71d874482d7ad0564d8"} 05:34:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:06 INFO - Contents: 05:34:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/842fea67ad2e4a9e9cf57e3a97b2b3817586ef0c430fb5a771d954084108061148a12651450f2999e33e40c2181b612343823e093e3fb3112c6c5ee3ed444c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cff271d95146e98bf462fab78837e2eee61e329d772e8a4482324b787b69e520370efb9597d5e4fe321d69fa9b1f266add48c627934bf001c8fd45ec43ea93e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10db3a426f4e59797a29d3365d975e8b14770e1e7b6cf204a8ef7a29a85aed66947cfb118d34f160ec46c262882c0bb99fdd9447d8e1fe72440c0d98f0b2dd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadbbaded5a7e9abce908623899464d4b96b88b25e29ae98fe3fc783ea0c6a08b88ad99e91b1714f10b2440d5b92429624e990fb2887d71d874482d7ad0564d8"} 05:34:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:06 INFO - Copying logs to upload dir... 05:34:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.697905 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-18 05:34:06.812392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:06.816099) ========= 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.ieGa23kApP/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.rYbCMuMXbC/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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/842fea67ad2e4a9e9cf57e3a97b2b3817586ef0c430fb5a771d954084108061148a12651450f2999e33e40c2181b612343823e093e3fb3112c6c5ee3ed444c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cff271d95146e98bf462fab78837e2eee61e329d772e8a4482324b787b69e520370efb9597d5e4fe321d69fa9b1f266add48c627934bf001c8fd45ec43ea93e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10db3a426f4e59797a29d3365d975e8b14770e1e7b6cf204a8ef7a29a85aed66947cfb118d34f160ec46c262882c0bb99fdd9447d8e1fe72440c0d98f0b2dd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadbbaded5a7e9abce908623899464d4b96b88b25e29ae98fe3fc783ea0c6a08b88ad99e91b1714f10b2440d5b92429624e990fb2887d71d874482d7ad0564d8"} build_url:https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010989 build_url: 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/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/842fea67ad2e4a9e9cf57e3a97b2b3817586ef0c430fb5a771d954084108061148a12651450f2999e33e40c2181b612343823e093e3fb3112c6c5ee3ed444c5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cff271d95146e98bf462fab78837e2eee61e329d772e8a4482324b787b69e520370efb9597d5e4fe321d69fa9b1f266add48c627934bf001c8fd45ec43ea93e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10db3a426f4e59797a29d3365d975e8b14770e1e7b6cf204a8ef7a29a85aed66947cfb118d34f160ec46c262882c0bb99fdd9447d8e1fe72440c0d98f0b2dd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadbbaded5a7e9abce908623899464d4b96b88b25e29ae98fe3fc783ea0c6a08b88ad99e91b1714f10b2440d5b92429624e990fb2887d71d874482d7ad0564d8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:06.854612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:06.854985) ========= 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.ieGa23kApP/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.rYbCMuMXbC/Listeners TMPDIR=/var/folders/w5/3mbll1bn30g5ys4sq237f8fc00000w/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.005391 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:06.903833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 05:34:06.904235) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 05:34:06.904622) ========= ========= Total master_lag: 0.35 =========