builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0199 starttime: 1491069188.65 results: success (0) buildid: 20170401101422 builduid: 679d99b4562343d29bcc876b43af76db revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:08.647910) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:08.648338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:08.648609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:08.792259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:08.792648) ========= 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.lAbfRi41bA/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.fZ7z6An3v7/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-01 10:53:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.99M=0.001s 2017-04-01 10:53:09 (7.99 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.484311 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.324313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.324590) ========= 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.lAbfRi41bA/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.fZ7z6An3v7/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.020378 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.399513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 10:53:09.399826) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --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 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lAbfRi41bA/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.fZ7z6An3v7/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-01 10:53:09,491 truncating revision to first 12 chars 2017-04-01 10:53:09,492 Setting DEBUG logging. 2017-04-01 10:53:09,492 attempt 1/10 2017-04-01 10:53:09,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a3f514cf849?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 10:53:10,477 unpacking tar archive at: mozilla-central-7a3f514cf849/testing/mozharness/ program finished with exit code 0 elapsedTime=1.301950 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 10:53:10.733324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.733636) ========= script_repo_revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.734122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.734453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.783659) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-01 10:53:10.783971) ========= /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.lAbfRi41bA/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.fZ7z6An3v7/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:53:11 INFO - MultiFileLogger online at 20170401 10:53:11 in /builds/slave/test 10:53:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:53:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:11 INFO - {'append_to_log': False, 10:53:11 INFO - 'base_work_dir': '/builds/slave/test', 10:53:11 INFO - 'blob_upload_branch': 'Firefox', 10:53:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:11 INFO - 'branch': 'Firefox', 10:53:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:11 INFO - 'config_files': ('talos/mac_config.py',), 10:53:11 INFO - 'default_actions': ('clobber', 10:53:11 INFO - 'read-buildbot-config', 10:53:11 INFO - 'download-and-extract', 10:53:11 INFO - 'populate-webroot', 10:53:11 INFO - 'create-virtualenv', 10:53:11 INFO - 'install', 10:53:11 INFO - 'run-tests'), 10:53:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:11 INFO - 'download_minidump_stackwalk': True, 10:53:11 INFO - 'download_symbols': 'ondemand', 10:53:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:11 INFO - 'gecko_profile': False, 10:53:11 INFO - 'gecko_profile_interval': 0, 10:53:11 INFO - 'installer_path': 'installer.exe', 10:53:11 INFO - 'log_level': 'info', 10:53:11 INFO - 'log_name': 'talos', 10:53:11 INFO - 'log_to_console': True, 10:53:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:53:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:53:11 INFO - 'opt_config_files': (), 10:53:11 INFO - 'pip_index': False, 10:53:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:11 INFO - 'cmd': ('bash', 10:53:11 INFO - '-c', 10:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:11 INFO - 'enabled': True, 10:53:11 INFO - 'halt_on_failure': False, 10:53:11 INFO - 'name': 'check_screen_resolution'},), 10:53:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:11 INFO - 'cmd': ('bash', 10:53:11 INFO - '-c', 10:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:11 INFO - 'enabled': True, 10:53:11 INFO - 'halt_on_failure': False, 10:53:11 INFO - 'name': 'check_screen_resolution'},), 10:53:11 INFO - 'run_cmd_checks_enabled': True, 10:53:11 INFO - 'suite': 'dromaeojs-e10s', 10:53:11 INFO - 'system_bits': '32', 10:53:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:11 INFO - 'title': 't-yosemite-r7-0199', 10:53:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:11 INFO - 'use_talos_json': True, 10:53:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:11 INFO - 'work_dir': 'build'} 10:53:11 INFO - [mozharness: 2017-04-01 17:53:11.015741Z] Running clobber step. 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: clobber 10:53:11 INFO - rmtree: /builds/slave/test/build 10:53:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:11 INFO - Running post-action listener: _resource_record_post_action 10:53:11 INFO - [mozharness: 2017-04-01 17:53:11.684304Z] Finished clobber step (success) 10:53:11 INFO - [mozharness: 2017-04-01 17:53:11.684435Z] Running read-buildbot-config step. 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: read_buildbot_config 10:53:11 INFO - Using buildbot properties: 10:53:11 INFO - { 10:53:11 INFO - "project": "", 10:53:11 INFO - "product": "firefox", 10:53:11 INFO - "script_repo_revision": "production", 10:53:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:53:11 INFO - "repository": "", 10:53:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:53:11 INFO - "buildid": "20170401101422", 10:53:11 INFO - "pgo_build": "False", 10:53:11 INFO - "basedir": "/builds/slave/test", 10:53:11 INFO - "buildnumber": 11, 10:53:11 INFO - "slavename": "t-yosemite-r7-0199", 10:53:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:53:11 INFO - "platform": "yosemite_r7", 10:53:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:53:11 INFO - "branch": "mozilla-central", 10:53:11 INFO - "repo_path": "mozilla-central", 10:53:11 INFO - "revision": "7a3f514cf8490d271ee373a1d2999e4ea4dee2d7", 10:53:11 INFO - "stage_platform": "macosx64", 10:53:11 INFO - "builduid": "679d99b4562343d29bcc876b43af76db", 10:53:11 INFO - "slavebuilddir": "test" 10:53:11 INFO - } 10:53:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:53:11 INFO - Running post-action listener: _resource_record_post_action 10:53:11 INFO - [mozharness: 2017-04-01 17:53:11.687847Z] Finished read-buildbot-config step (success) 10:53:11 INFO - [mozharness: 2017-04-01 17:53:11.687931Z] Running download-and-extract step. 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: download_and_extract 10:53:11 INFO - mkdir: /builds/slave/test/build/tests 10:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:11 INFO - trying https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:53:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/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 10:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/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 10:53:12 INFO - Downloaded 1325 bytes. 10:53:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:53:12 INFO - Using the following test package requirements: 10:53:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:53:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:53:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:53:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:53:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'jsshell-mac.zip'], 10:53:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:53:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:53:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:53:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:53:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:53:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:53:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:53:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:53:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:53:14 INFO - Expected file size: 52516226 10:53:14 INFO - Obtained file size: 52516226 10:53:31 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 10:53:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:53:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:53:32 INFO - Expected file size: 52516226 10:53:32 INFO - Obtained file size: 52516226 10:53:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:53:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:53:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:53:49 INFO - Expected file size: 14404152 10:53:49 INFO - Obtained file size: 14404152 10:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:50 INFO - trying https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:53:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/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 10:53:52 INFO - Downloaded 75593154 bytes. 10:53:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:53:52 INFO - mkdir: /builds/slave/test/properties 10:53:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:52 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:52 INFO - Contents: 10:53:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:53:53 INFO - Running post-action listener: _resource_record_post_action 10:53:53 INFO - Running post-action listener: set_extra_try_arguments 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.042518Z] Finished download-and-extract step (success) 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.042622Z] Running populate-webroot step. 10:53:53 INFO - Running pre-action listener: _resource_record_pre_action 10:53:53 INFO - Running main action method: populate_webroot 10:53:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:53 INFO - '--tppagecycles', 10:53:53 INFO - '7'], 10:53:53 INFO - 'tests': ['tsvgm']}}, 10:53:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['damp', 'tps']}, 10:53:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'tests': ['damp', 'tps']}, 10:53:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['dromaeo_dom']}, 10:53:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['basic_compositor_video']}, 10:53:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:53:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tsvgx', 10:53:53 INFO - 'tsvgr_opacity', 10:53:53 INFO - 'tart', 10:53:53 INFO - 'tscrollx', 10:53:53 INFO - 'cart', 10:53:53 INFO - 'tsvg_static']}, 10:53:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:53 INFO - 'tsvgr_opacity', 10:53:53 INFO - 'tart', 10:53:53 INFO - 'tscrollx', 10:53:53 INFO - 'cart', 10:53:53 INFO - 'tsvg_static']}, 10:53:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tp5o']}, 10:53:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:53:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s', 10:53:53 INFO - '--xperf_path', 10:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:53 INFO - 'tests': ['tp5n']}, 10:53:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--xperf_path', 10:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:53 INFO - 'tests': ['tp5n']}}, 10:53:53 INFO - 'talos.zip': {'path': '', 10:53:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:53 INFO - Running post-action listener: _resource_record_post_action 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.061118Z] Finished populate-webroot step (success) 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.061219Z] Running create-virtualenv step. 10:53:53 INFO - Running pre-action listener: _resource_record_pre_action 10:53:53 INFO - Running main action method: create_virtualenv 10:53:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:53:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:53 INFO - Using real prefix '/tools/python27' 10:53:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:56 INFO - Installing pip.................done. 10:53:56 INFO - Return code: 0 10:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:53:57 INFO - Reading from file tmpfile_stdout 10:53:57 INFO - Output received: 10:53:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:53:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:57 INFO - 'HOME': '/Users/cltbld', 10:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:57 INFO - 'LOGNAME': 'cltbld', 10:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:57 INFO - 'MOZ_NO_REMOTE': '1', 10:53:57 INFO - 'NO_EM_RESTART': '1', 10:53:57 INFO - 'PAGER': '/bin/cat', 10:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:57 INFO - 'PWD': '/builds/slave/test', 10:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:57 INFO - 'SHELL': '/bin/bash', 10:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:53:57 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:57 INFO - 'USER': 'cltbld', 10:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:57 INFO - 'XPC_FLAGS': '0x0', 10:53:57 INFO - 'XPC_SERVICE_NAME': '0', 10:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:57 INFO - Cleaning up... 10:53:57 INFO - Return code: 0 10:53:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:57 INFO - 'HOME': '/Users/cltbld', 10:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:57 INFO - 'LOGNAME': 'cltbld', 10:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:57 INFO - 'MOZ_NO_REMOTE': '1', 10:53:57 INFO - 'NO_EM_RESTART': '1', 10:53:57 INFO - 'PAGER': '/bin/cat', 10:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:57 INFO - 'PWD': '/builds/slave/test', 10:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:57 INFO - 'SHELL': '/bin/bash', 10:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:53:57 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:57 INFO - 'USER': 'cltbld', 10:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:57 INFO - 'XPC_FLAGS': '0x0', 10:53:57 INFO - 'XPC_SERVICE_NAME': '0', 10:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:57 INFO - Downloading/unpacking psutil>=3.1.1 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:01 INFO - Installing collected packages: psutil 10:54:01 INFO - Running setup.py install for psutil 10:54:01 INFO - building 'psutil._psutil_osx' extension 10:54:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:54:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:54:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:54:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:54:02 INFO - building 'psutil._psutil_posix' extension 10:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:54:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:54:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:54:02 INFO - ^ 10:54:02 INFO - 1 warning generated. 10:54:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:02 INFO - Successfully installed psutil 10:54:02 INFO - Cleaning up... 10:54:02 INFO - Return code: 0 10:54:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54: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')]} 10:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:54: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 mozsystemmonitor==0.3 10:54:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:02 INFO - 'HOME': '/Users/cltbld', 10:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:02 INFO - 'LOGNAME': 'cltbld', 10:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:02 INFO - 'MOZ_NO_REMOTE': '1', 10:54:02 INFO - 'NO_EM_RESTART': '1', 10:54:02 INFO - 'PAGER': '/bin/cat', 10:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:02 INFO - 'PWD': '/builds/slave/test', 10:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:02 INFO - 'SHELL': '/bin/bash', 10:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:02 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:02 INFO - 'USER': 'cltbld', 10:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:02 INFO - 'XPC_FLAGS': '0x0', 10:54:02 INFO - 'XPC_SERVICE_NAME': '0', 10:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:05 INFO - Installing collected packages: mozsystemmonitor 10:54:05 INFO - Running setup.py install for mozsystemmonitor 10:54:05 INFO - Successfully installed mozsystemmonitor 10:54:05 INFO - Cleaning up... 10:54:05 INFO - Return code: 0 10:54:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:54:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:05 INFO - 'HOME': '/Users/cltbld', 10:54:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:05 INFO - 'LOGNAME': 'cltbld', 10:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:05 INFO - 'MOZ_NO_REMOTE': '1', 10:54:05 INFO - 'NO_EM_RESTART': '1', 10:54:05 INFO - 'PAGER': '/bin/cat', 10:54:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:05 INFO - 'PWD': '/builds/slave/test', 10:54:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:05 INFO - 'SHELL': '/bin/bash', 10:54:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:05 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:05 INFO - 'USER': 'cltbld', 10:54:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:05 INFO - 'XPC_FLAGS': '0x0', 10:54:05 INFO - 'XPC_SERVICE_NAME': '0', 10:54:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:08 INFO - warning: no files found matching '*.txt' 10:54:08 INFO - no previously-included directories found matching 'build' 10:54:08 INFO - no previously-included directories found matching 'dist' 10:54:08 INFO - no previously-included directories found matching '.git*' 10:54:08 INFO - Installing collected packages: jsonschema, functools32 10:54:08 INFO - Running setup.py install for functools32 10:54:09 INFO - warning: no files found matching '*.txt' 10:54:09 INFO - no previously-included directories found matching 'build' 10:54:09 INFO - no previously-included directories found matching 'dist' 10:54:09 INFO - no previously-included directories found matching '.git*' 10:54:09 INFO - Successfully installed jsonschema functools32 10:54:09 INFO - Cleaning up... 10:54:09 INFO - Return code: 0 10:54:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:09 INFO - 'HOME': '/Users/cltbld', 10:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:09 INFO - 'LOGNAME': 'cltbld', 10:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:09 INFO - 'MOZ_NO_REMOTE': '1', 10:54:09 INFO - 'NO_EM_RESTART': '1', 10:54:09 INFO - 'PAGER': '/bin/cat', 10:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:09 INFO - 'PWD': '/builds/slave/test', 10:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:09 INFO - 'SHELL': '/bin/bash', 10:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:09 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:09 INFO - 'USER': 'cltbld', 10:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:09 INFO - 'XPC_FLAGS': '0x0', 10:54:09 INFO - 'XPC_SERVICE_NAME': '0', 10:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:54:09 INFO - Cleaning up... 10:54:09 INFO - Return code: 0 10:54:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:09 INFO - 'HOME': '/Users/cltbld', 10:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:09 INFO - 'LOGNAME': 'cltbld', 10:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:09 INFO - 'MOZ_NO_REMOTE': '1', 10:54:09 INFO - 'NO_EM_RESTART': '1', 10:54:09 INFO - 'PAGER': '/bin/cat', 10:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:09 INFO - 'PWD': '/builds/slave/test', 10:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:09 INFO - 'SHELL': '/bin/bash', 10:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:09 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:09 INFO - 'USER': 'cltbld', 10:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:09 INFO - 'XPC_FLAGS': '0x0', 10:54:09 INFO - 'XPC_SERVICE_NAME': '0', 10:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:09 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - Downloading docopt-0.6.1.tar.gz 10:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:13 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:13 INFO - Running setup.py install for blobuploader 10:54:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:13 INFO - Running setup.py install for requests 10:54:14 INFO - Running setup.py install for docopt 10:54:14 INFO - Successfully installed blobuploader requests docopt 10:54:14 INFO - Cleaning up... 10:54:14 INFO - Return code: 0 10:54:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:14 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:14 INFO - 'HOME': '/Users/cltbld', 10:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:14 INFO - 'LOGNAME': 'cltbld', 10:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:14 INFO - 'MOZ_NO_REMOTE': '1', 10:54:14 INFO - 'NO_EM_RESTART': '1', 10:54:14 INFO - 'PAGER': '/bin/cat', 10:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:14 INFO - 'PWD': '/builds/slave/test', 10:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:14 INFO - 'SHELL': '/bin/bash', 10:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:14 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:14 INFO - 'USER': 'cltbld', 10:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:14 INFO - 'XPC_FLAGS': '0x0', 10:54:14 INFO - 'XPC_SERVICE_NAME': '0', 10:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:14 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ys2Iiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:14 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Ke4lF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:14 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-nUpBC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-JN2zKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-QjAWPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-8in0j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-uPd2cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-MJKTBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-35BLZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ww3wZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-7ZniUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-OQbF8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:15 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-fqy9Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-yx3TfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-zgNxZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Wob0FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:16 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-dizZsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:16 INFO - Running setup.py install for manifestparser 10:54:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:16 INFO - Running setup.py install for mozcrash 10:54:16 INFO - Running setup.py install for mozdebug 10:54:16 INFO - Running setup.py install for mozdevice 10:54:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozfile 10:54:17 INFO - Running setup.py install for mozhttpd 10:54:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozinfo 10:54:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozInstall 10:54:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozleak 10:54:17 INFO - Running setup.py install for mozlog 10:54:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for moznetwork 10:54:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for mozprocess 10:54:18 INFO - Running setup.py install for mozprofile 10:54:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for mozrunner 10:54:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for mozscreenshot 10:54:18 INFO - Running setup.py install for moztest 10:54:18 INFO - Running setup.py install for mozversion 10:54:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:19 INFO - Cleaning up... 10:54:19 INFO - Return code: 0 10:54:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:19 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:19 INFO - 'HOME': '/Users/cltbld', 10:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:19 INFO - 'LOGNAME': 'cltbld', 10:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:19 INFO - 'MOZ_NO_REMOTE': '1', 10:54:19 INFO - 'NO_EM_RESTART': '1', 10:54:19 INFO - 'PAGER': '/bin/cat', 10:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:19 INFO - 'PWD': '/builds/slave/test', 10:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:19 INFO - 'SHELL': '/bin/bash', 10:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:19 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:19 INFO - 'USER': 'cltbld', 10:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:19 INFO - 'XPC_FLAGS': '0x0', 10:54:19 INFO - 'XPC_SERVICE_NAME': '0', 10:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-0mjk71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-cW3QL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-zXO7rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-XZXJJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Z7xro9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-h4MI4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-O22ubq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-RaxDjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-pIolZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-2XQPaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-0CoJi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-U_HA1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:20 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)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-SFBdp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-vBO0CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-cVrmai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-c_mihr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:21 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)) 10:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:21 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-q5HR_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:23 INFO - Downloading blessings-1.6.tar.gz 10:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:23 INFO - Installing collected packages: blessings 10:54:23 INFO - Running setup.py install for blessings 10:54:24 INFO - Successfully installed blessings 10:54:24 INFO - Cleaning up... 10:54:24 INFO - Return code: 0 10:54:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:24 INFO - Reading from file tmpfile_stdout 10:54:24 INFO - Current package versions: 10:54:24 INFO - blessings == 1.6 10:54:24 INFO - blobuploader == 1.2.4 10:54:24 INFO - docopt == 0.6.1 10:54:24 INFO - functools32 == 3.2.3-2 10:54:24 INFO - jsonschema == 2.5.1 10:54:24 INFO - manifestparser == 1.1 10:54:24 INFO - mozInstall == 1.12 10:54:24 INFO - mozcrash == 1.0 10:54:24 INFO - mozdebug == 0.1 10:54:24 INFO - mozdevice == 0.49 10:54:24 INFO - mozfile == 1.2 10:54:24 INFO - mozhttpd == 0.7 10:54:24 INFO - mozinfo == 0.9 10:54:24 INFO - mozleak == 0.1 10:54:24 INFO - mozlog == 3.4 10:54:24 INFO - moznetwork == 0.27 10:54:24 INFO - mozprocess == 0.25 10:54:24 INFO - mozprofile == 0.28 10:54:24 INFO - mozrunner == 6.13 10:54:24 INFO - mozscreenshot == 0.1 10:54:24 INFO - mozsystemmonitor == 0.3 10:54:24 INFO - moztest == 0.8 10:54:24 INFO - mozversion == 1.4 10:54:24 INFO - psutil == 3.1.1 10:54:24 INFO - requests == 1.2.3 10:54:24 INFO - wsgiref == 0.1.2 10:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:24 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 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:24 INFO - 'HOME': '/Users/cltbld', 10:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:24 INFO - 'LOGNAME': 'cltbld', 10:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:24 INFO - 'MOZ_NO_REMOTE': '1', 10:54:24 INFO - 'NO_EM_RESTART': '1', 10:54:24 INFO - 'PAGER': '/bin/cat', 10:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:24 INFO - 'PWD': '/builds/slave/test', 10:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:24 INFO - 'SHELL': '/bin/bash', 10:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:24 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:24 INFO - 'USER': 'cltbld', 10:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:24 INFO - 'XPC_FLAGS': '0x0', 10:54:24 INFO - 'XPC_SERVICE_NAME': '0', 10:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:54:24 INFO - Cleaning up... 10:54:24 INFO - Return code: 0 10:54:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ce2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9082c8eba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, '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.lAbfRi41bA/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.fZ7z6An3v7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:24 INFO - 'HOME': '/Users/cltbld', 10:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:24 INFO - 'LOGNAME': 'cltbld', 10:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:24 INFO - 'MOZ_NO_REMOTE': '1', 10:54:24 INFO - 'NO_EM_RESTART': '1', 10:54:24 INFO - 'PAGER': '/bin/cat', 10:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:24 INFO - 'PWD': '/builds/slave/test', 10:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:24 INFO - 'SHELL': '/bin/bash', 10:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:24 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:24 INFO - 'USER': 'cltbld', 10:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:24 INFO - 'XPC_FLAGS': '0x0', 10:54:24 INFO - 'XPC_SERVICE_NAME': '0', 10:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:54:25 INFO - Cleaning up... 10:54:25 INFO - Return code: 0 10:54:25 INFO - Running post-action listener: _resource_record_post_action 10:54:25 INFO - Running post-action listener: _start_resource_monitoring 10:54:25 INFO - Starting resource monitoring. 10:54:25 INFO - [mozharness: 2017-04-01 17:54:25.045692Z] Finished create-virtualenv step (success) 10:54:25 INFO - [mozharness: 2017-04-01 17:54:25.046698Z] Running install step. 10:54:25 INFO - Running pre-action listener: _resource_record_pre_action 10:54:25 INFO - Running main action method: install 10:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:25 INFO - Reading from file tmpfile_stdout 10:54:25 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:25 INFO - Reading from file tmpfile_stdout 10:54:25 INFO - Output received: 10:54:25 INFO - Usage: mozinstall [options] installer 10:54:25 INFO - Options: 10:54:25 INFO - -h, --help show this help message and exit 10:54:25 INFO - -d DEST, --destination=DEST 10:54:25 INFO - Directory to install application into. [default: 10:54:25 INFO - "/builds/slave/test"] 10:54:25 INFO - --app=APP Application being installed. [default: firefox] 10:54:25 INFO - mkdir: /builds/slave/test/build/application 10:54:25 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'] 10:54:25 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 10:54:45 INFO - Reading from file tmpfile_stdout 10:54:45 INFO - Output received: 10:54:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:54:45 INFO - Running post-action listener: _resource_record_post_action 10:54:45 INFO - [mozharness: 2017-04-01 17:54:45.443162Z] Finished install step (success) 10:54:45 INFO - [mozharness: 2017-04-01 17:54:45.443356Z] Running run-tests step. 10:54:45 INFO - Running pre-action listener: _resource_record_pre_action 10:54:45 INFO - Running main action method: run_tests 10:54:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:45 INFO - 2017-04-01 10:54:45.458 screenresolution[6592:125091] starting screenresolution argv=screenresolution get 10:54:45 INFO - 2017-04-01 10:54:45.460 screenresolution[6592:125091] Display 0: 1600x1200x32@60 10:54:45 INFO - 2017-04-01 10:54:45.466 screenresolution[6593:125094] starting screenresolution argv=screenresolution list 10:54:45 INFO - Available Modes on Display 0 10:54:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:45 INFO - Intel Iris: 10:54:45 INFO - Chipset Model: Intel Iris 10:54:45 INFO - Type: GPU 10:54:45 INFO - Bus: Built-In 10:54:45 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:45 INFO - Vendor: Intel (0x8086) 10:54:45 INFO - Device ID: 0x0a2e 10:54:45 INFO - Revision ID: 0x0009 10:54:45 INFO - Displays: 10:54:45 INFO - Display: 10:54:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:45 INFO - Display Serial Number: 1600x1200 60 10:54:45 INFO - Main Display: Yes 10:54:45 INFO - Mirror: Off 10:54:45 INFO - Online: Yes 10:54:45 INFO - Rotation: Supported 10:54:45 INFO - Return code: 0 10:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:45 INFO - Python 2.7.3 10:54:45 INFO - Return code: 0 10:54:45 INFO - grabbing minidump binary from tooltool 10:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:45 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 0x103ac0d30>, '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 0x1039e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ab5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:54:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:54:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:54:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:45 INFO - Return code: 0 10:54:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:45 INFO - ENV: RUST_BACKTRACE is now 1 10:54:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lAbfRi41bA/Render', 10:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:45 INFO - 'HOME': '/Users/cltbld', 10:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:45 INFO - 'LOGNAME': 'cltbld', 10:54:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:45 INFO - 'MOZ_NO_REMOTE': '1', 10:54:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:45 INFO - 'NO_EM_RESTART': '1', 10:54:45 INFO - 'PAGER': '/bin/cat', 10:54:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:45 INFO - 'PWD': '/builds/slave/test', 10:54:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:45 INFO - 'RUST_BACKTRACE': '1', 10:54:45 INFO - 'SHELL': '/bin/bash', 10:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fZ7z6An3v7/Listeners', 10:54:45 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 10:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:45 INFO - 'USER': 'cltbld', 10:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:45 INFO - 'XPC_FLAGS': '0x0', 10:54:45 INFO - 'XPC_SERVICE_NAME': '0', 10:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:54:46 INFO - mozversion application_buildid: 20170401101422 10:54:46 INFO - mozversion application_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 10:54:46 INFO - mozversion application_display_name: Nightly 10:54:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:46 INFO - mozversion application_name: Firefox 10:54:46 INFO - mozversion application_remotingname: firefox 10:54:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:54:46 INFO - mozversion application_vendor: Mozilla 10:54:46 INFO - mozversion application_version: 55.0a1 10:54:46 INFO - mozversion platform_buildid: 20170401101422 10:54:46 INFO - mozversion platform_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 10:54:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:54:46 INFO - mozversion platform_version: 55.0a1 10:54:46 INFO - using testdate: 1491069286 10:54:46 INFO - actual date: 1491069286 10:54:46 INFO - starting webserver on 'localhost:57399' 10:54:46 INFO - SUITE-START | Running 2 tests 10:54:46 INFO - TEST-START | dromaeo_css 10:54:46 INFO - operating with platform_type : mac_ 10:54:46 INFO - Initialising browser for dromaeo_css test... 10:54:46 INFO - TEST-INFO | started process 6603 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpKg9GN5/profile http://localhost:57399/getInfo.html) 10:54:49 INFO - PID 6603 | 2017-04-01 10:54:49.159 plugin-container[6605:125266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9147, name = 'com.apple.tsm.portname' 10:54:49 INFO - PID 6603 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:49 INFO - PID 6603 | 2017-04-01 10:54:49.162 plugin-container[6605:125266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 10:54:49 INFO - PID 6603 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:49 INFO - PID 6603 | 2017-04-01 10:54:49.162 plugin-container[6605:125266] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:54:49 INFO - PID 6603 | __metrics Screen width/height:1600/1200 10:54:49 INFO - PID 6603 | colorDepth:24 10:54:49 INFO - PID 6603 | Browser inner width/height: 1024/689 10:54:49 INFO - PID 6603 | __metrics 10:54:49 ERROR - PID 6603 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 10:54:50 INFO - TEST-INFO | 6603: exit 0 10:54:50 INFO - Browser initialized. 10:54:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:50 INFO - TEST-INFO | started process 6607 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpKg9GN5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:52 INFO - PID 6607 | 2017-04-01 10:54:52.666 plugin-container[6608:125404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:54:52 INFO - PID 6607 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:52 INFO - PID 6607 | 2017-04-01 10:54:52.667 plugin-container[6608:125404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:54:52 INFO - PID 6607 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:52 INFO - PID 6607 | 2017-04-01 10:54:52.667 plugin-container[6608:125404] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:55:02 INFO - PID 6607 | RSS: Main: 228622336 10:55:02 INFO - PID 6607 | 10:58:07 INFO - PID 6607 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57399/tests/dromaeo/cssquery-ext.html) 10:58:08 INFO - PID 6607 | RSS: Main: 252944384 10:58:08 INFO - PID 6607 | 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | A coding exception was thrown and uncaught in a Task. 10:59:50 INFO - PID 6607 | 10:59:50 ERROR - PID 6607 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:50 INFO - PID 6607 | Full stack: 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | A coding exception was thrown and uncaught in a Task. 10:59:50 INFO - PID 6607 | 10:59:50 ERROR - PID 6607 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:50 INFO - PID 6607 | Full stack: 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | A coding exception was thrown and uncaught in a Task. 10:59:50 INFO - PID 6607 | 10:59:50 ERROR - PID 6607 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:50 INFO - PID 6607 | Full stack: 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | ************************* 10:59:50 INFO - PID 6607 | A coding exception was thrown and uncaught in a Task. 10:59:50 INFO - PID 6607 | 10:59:50 ERROR - PID 6607 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:50 INFO - PID 6607 | Full stack: 10:59:50 INFO - PID 6607 | ************************* 11:01:11 INFO - PID 6607 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-ext.html (next: http://localhost:57399/tests/dromaeo/cssquery-jquery.html) 11:01:11 INFO - PID 6607 | RSS: Main: 261808128 11:01:11 INFO - PID 6607 | 11:04:13 INFO - PID 6607 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57399/tests/dromaeo/cssquery-mootools.html) 11:04:14 INFO - PID 6607 | RSS: Main: 272932864 11:04:14 INFO - PID 6607 | 11:07:15 INFO - PID 6607 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57399/tests/dromaeo/cssquery-prototype.html) 11:07:16 INFO - PID 6607 | RSS: Main: 265375744 11:07:16 INFO - PID 6607 | 11:10:19 INFO - PID 6607 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57399/tests/dromaeo/cssquery-yui.html) 11:10:20 INFO - PID 6607 | RSS: Main: 276602880 11:10:20 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | Cycle 1(1): loaded http://localhost:57399/tests/dromaeo/cssquery-yui.html (next: http://localhost:57399/tests/dromaeo/cssquery-dojo.html) 11:13:23 INFO - PID 6607 | RSS: Main: 270249984 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | __start_tp_report 11:13:23 INFO - PID 6607 | _x_x_mozilla_page_load 11:13:23 INFO - PID 6607 | _x_x_mozilla_page_load_details 11:13:23 INFO - PID 6607 | |i|pagename|runs| 11:13:23 INFO - PID 6607 | |0;dojo.html;3562.9287414251717;3608.386574282372;3621.0404242875625;3629.61889001655;3630.546181727284;5850.912236316453;6159.784407545737;6263.9060414093765;6279.277883043452;6326.652034138132;5573.972130139354;6001.87996240075;6189.381061893809;6242.344553821851;6340.809775706724;5490.6431081979745;5555.444455554452;5617.494425501704;5647.181158731982;5680.715964201794;5484.561235101202;5570.554355651539;5658.603897727161;5668.064769313059;5695.316562012544;5404.297441332602;5481.835544933659;5604.887902241932;5625.746841392106;5638.210650508932;4626.86119416418;5436.592255580847;5558.583106267046;5565.526930210937;5590.832275031756;5471.50756431923;5509.311336082989;5510.614257002011;5530.778768849241;5540.113581826889;6147.538934579924;6183.690815459209;6295.433410992987;6368.649724265164;6376.075469056961;6655.201375834931;6749.6962636681465;6825.726970921207;6831.59010459374;6854.588724676535;6898.0687607173395;6929.44564434844;6934.410575101122;6934.653267336664;6944.826379340507;6280.591761535486;6377;6383.585066970725;6385.584936979081;6387.872242555216;6819.795406137824;6912.343327383891;6976.476764242702;7018.403435708022;7054.858902822018;5613.324196287582;6448.516361272923;6530.771423000172;6609.6695165241545;6639.601623902581;6782.491313151533;6867.141607299088;6879.105716256955;6914.991978489374;6918.135233095863;6786.59280443175;6829.282925292872;6834.4874134440115;6841.965790171117;6844.8973265401055;6514.5114116441455;6567.638779867153;6586.868262634721;6717.932820671828;6752.93247067523;4822.397200349957;5456.127019676833;5462.180672899097;5464.426235245242;5478.863028424321;4298.871033868989;4658.208104622222;4789.592884604847;4816.566509014136;4824.831130910401;5706.400827913092;5898.941010589925;6238.1266622672865;6534.183227096613;6566;5761.222234998221;6872.278410766898;6901.275366086589;6934.895976560356;6972.651367431709;6441.25925518562;6459;6466.870662586722;6484.221893372825;6502.349765023459;5866.735996880236;6001.339852616209;6086.482648974798;6089.63462192261;6111.8472038198515;6913.51605387618;7053.153621565445;7117.217106118219;7144.392726618088;7159.606221657858;6919.342662447059;6922.965385173042;6938.06336144614;6942.8611427772175;6945.305469453015;6960.095187625576;7053.647317633995;7142.607156606437;7142.678579463833;7145.4998150128995;6494.545381823227;6590.275069742229;6707.1616047994;6723.7646682365885;6770.1537307836525;6845.828854278484;6853.348931851466;6866.141732283465;6883.070785444102;6889.862202756017;4993.800247990185;6386.393292637192;6416.294207637063;6622;6731.663416829237;6494.772682956074;6677.599344039373;6702.229243637044;6730.4952128589575;6731.966340168267;6320.209973753281;6390.48876089921;6421.550491465552;6452.548321617442;6485.935140648533;6640.800775976729;6678.432333251728;6698.631575263407;6703.597784132968;6709.832254193684;6529.608223506605;6548.0832683425315;6548.246951600437;6550.508711846726;6552.213734351908 11:13:23 INFO - PID 6607 | |1;ext.html;698.472653146874;754.5698951597589;823.5882058970512;1081.4808891731968;1287.9420426080826;37821.62178378215;39071.60928390715;39105.60894391055;39122;39128.80435597818;38625.61374386255;39017;39022.414663780066;39046;39083.02292442691;7974.840503189918;8148.470349427268;8499.915000850006;8751.3436492263;8786.209241168293;8618.956905215466;8729.650813967433;8736;8754.781130471725;8766.123387661246;8673.869891951626;8693.652253909868;8749.650013999433;8762.123787621218;8766.780830479225;8638.65445382184;8663.826723465558;8713.302935765123;8731.956340218321;8738.956305218497;8575.528345940971;8644.438111522732;8646.740597782076;8655.831462752574;8667.306615470747;38811.8059409704;38914.41628375577;39063.8046809767;39095.41356879649;39143.608563914284;3073.4775088235056;3082;3086.6450358208867;3108.1918701137643;3160.4153231652217;27596.724032759616;28080.997319355505;28256.293592660142;28938.71061289381;28963.56554651682;2810.690824009357;2843.24653966699;2897.724716151962;2956.822590644568;2980.5976193214074;353216;354983;355068;358610;359767;39914.80042599768;51105.488945110075;51134;51179.744101279255;51186;46357.30464043042;53188.73405633024;53422.931541368955;53698.19452708212;53740.92518149615;14806;14832;14934.775978360334;14947.626309342353;14966.176860272572;10150.340227885164;12140.69648258783;12145.757084858431;12148.696282593006;12212.57255996036;12254.509819607116;12388.876111238953;12763.106582539132;13655.317234138254;13780.310984450738;5209.791608335624;5911.940880591225;5920.934231838224;5996.700164991733;6034.969825150846;992;995.5221493683073;998.6754304850953;1000.6897861662908;1038.6364772329623;20383.286584969454;23154.884225578764;24683.50632987366;24689.62965555518;24710.752892471206;961.5480724059681;1065.808154532176;1095.189559725813;1135.6195674448986;1147.8450409194818;10287.897121028844;11862.88137118635;12090.851369119919;12412.56556020535;12491.312977786309;474182.62908685236;478317;478336;478369;478946;48771.512284877404;55893.161602575994;56487;56909;57240;1470.5808844479486;1511.9244037798067;1512.0700769026969;1517.8861585381142;1519.1948267418286;27487.86256068707;28337.433251334445;28675.426491469636;28816.42367152687;28871.711282887743;38055.429168563045;38214.80892595519;38247.23505529818;38358.6164138355;38398.62419261361;395757;397552;398947;400345;401224;32060.67939320577;32563.69745210165;32628.34743305073;32752.34495310128;32759.836200818845;41463.58536414597;41867;42126.52557160607;42600;42801.357979629705;27726;29791.702082978893;29793.553096704;29793.70206297996;29897.402051959274;29016.274593135342;29742;29955.70044299529;29961.400771984874;30174.396512069197;34468.48297275593;35116.473252900716;35136.64863351436;35347;35928.10179745423;29227.70772292335;29251.414971700873;29997.85001075068;30336.54495182618;30495.695043049287;20236.59526809485;23170.536589268457;23994.76005239995;24171;24221.394465138514 11:13:23 INFO - PID 6607 | |2;jquery.html;380.30594165647693;423.531997143157;426.46904603768314;449.72566734292076;452.86187712747613;21689.34931952042;22028.669569956444;22581.435464113405;23105.30684079476;23367.76632233677;22588.774112258874;22742.204022859205;23456.882715586442;23678.644820327667;23936.640950385758;6204.689765511729;6331.081993110996;6405.807825765211;6431.389018043278;6439.452646525051;6055.303640081403;6320.71556779946;6341.936580634181;6353.396427339396;6355.491560675158;5333.493318134771;6089.756409743627;6226.719797609118;6303.842403939915;6390.93609063908;6390.616563006211;6430.035494675789;6431.260405053432;6440.935590644081;6462.0306953956815;5598.412166722517;5740.253767010262;5815.621984570989;5816.47651711348;5828;27052.782624781932;27852.746626401862;27992.740326685143;28059.438811223663;28585.57121643177;2030.0966070098812;2056.845736569763;2097.0668052716546;2099.6955441460905;2163.7836216378396;16322.265498052617;16624.750628740578;17013;17640.823591764045;18090.276388944425;1909.493984094216;1921.4715953113007;1927.6241132979076;1931.985707503558;1932.2611842826782;152352;155858;156981;157832.99999999886;161905;10502.422366769748;12411.875881241253;12427;12559.560415385418;12643.304618246084;13885.722285554233;16319.347226110822;16348.264328105264;16358.427455039016;16419.753703694456;7444.85110297791;7761.534307941542;8942.552872356357;9164.90835091654;9302.395344302598;8834.823303533893;8851.203391694778;8852.070532594114;8921.15249051339;8998.910010899937;7902.920970790334;7985.121636619967;7986.600669966479;8032.638531266107;8056.556889371141;2227.593252435658;2229.2309153342394;2230.6727497139177;2235.9441013974456;2417.685700858877;814.9266566008969;939.5771902643837;943.5235206220815;952.3761935931838;993.8707967964118;17806.109694515224;18587;19785.50536236577;20214.29249976273;20612.896935515528;825.7192554531488;881.8765372847806;990.1039559198792;1001.62439085343;1024.5901639344172;7765.689372425039;8873.778155546162;10748.731281718019;10810.081143102767;10991.835122473169;674946;732670;763263;771501;776769;132157;134042;152589;153679.23160384127;169906;1214.423149004216;1233.5127624588238;1269.206745783885;1274.808778683205;1275.8787915147861;22215.33353999318;22223.32309521476;22302.77697223072;22309.888450558294;22672.65991010169;43387.34918976281;64421;64677.67661161664;64958.37604059936;65446.34553654593;64769.67615161894;88330.1166988322;89081;89924.6511302344;92590;7256.891146632699;8005;8204.548749818818;8657.307415406878;8771.035186129648;13789.51736689211;13799.448022079005;13824.447022119002;14247.28763561797;14263.786043209568;10228.641997530349;11462.885371146182;11680;11854.110941679237;12010;10646.574137034742;10750.946245268724;10830.133589312994;11014.39420831862;11328.263662861887;11693.532258709556;11919.284842909454;12195.695107622381;12197.69505762363;12303.384830758605;8588.055313915589;8650.697225597074;8820.25027872638;8867.290616750515;9022.909770902206;11607.6517704469;11690.064794816224;11907.16649834538;11950.641480755592;12068.879311206776 11:13:23 INFO - PID 6607 | |3;mootools.html;1383.1562746724496;1406.7608506553886;1414.589768966999;1416.0441701851248;1448.760954442517;10552.894471055288;10977.506012229449;11053.999999999989;11062.446877656115;11149.386783726892;9090.727278181648;10894.128469722424;10990.505427255772;11101.944490277558;11110.888891111086;2449.4611185539197;2484.850908945469;2490.5392502387117;2492.1152990688224;2494.9126780562683;2051.7640471345762;2410.505846301513;2431.8176136789725;2450.546648869965;2473.4311108445067;2392.1986134644917;2428.574999375111;2443.2425947956103;2470.9135180268695;2472.592022316325;2314.895829687668;2426.162973774045;2435.2937648082034;2445.730969593343;2466.136852101768;2044.570640165552;2139.871607703543;2356.3402247370764;2450.8529488230765;2455.177515532299;10929.726756831064;11020.063294619968;11043.116550675926;11058.170637202242;11066.612668556561;6193.876122477525;6392.55252132351;6430.196225471816;6436.967815160941;6453.709583068773;3862.9034274143373;3893.0729289002124;3947.8618248361167;3979.6418322350837;3994.021464741157;1152.1243854670427;1570.371851259494;1612.870970322383;1630.4212004738383;1704.1564425609279;15251.923740381228;15304.540863774104;15308.158051307173;15400.152991585346;15407.306671199824;5148.786022010497;5360.865978350573;5375.462453754593;5418.91871621926;5500.724963751796;11195;11264.380459074666;11307.773844523064;11321.433928303552;11326.943365283121;6215.160953271341;6224.906626400608;6226;6234.906476402857;6238.75044998195;5721.027425337703;5801.9129713054335;5826.475617194473;5829.941700583025;5887.5289976802605;4134.214499245134;4254.680898932531;4330.28550289205;4342;4361.5856493633055;1252.0734656354414;1271.4278574641264;1276.0157954381027;1286.8777466140702;1287.929163895976;686.8660611180771;743.4907088644296;772.1467778105225;775.4571799740204;803.2890891561011;5861.238039054895;5954.732037058343;6053.818385448443;6135.417135372132;6190;551.6827824001215;581.4563383236688;593.7803012885174;595.6098755315276;596.397638385234;3608.963910360915;3790.3177428062663;4009.5789942055662;4215.283401821697;4319.352097185448;12661.050421218446;12749.490020399266;13364.19814811095;14013.369398377097;14134.787978180335;11365.886341136484;12929.418176181905;13287.468501259842;13830.308484575731;13960.790588141186;10055.849162262572;10082.949585252174;10168.796624067478;10270.435126067989;10302.536385862653;5283.603729720209;5472.425395333433;5485.6434331768305;6444.742210311722;6614.272430032596;11253.212275140662;12209.938950305192;12335.259884406963;12439.315837628656;12538.122331436713;10550.577976881146;12906.741865162832;12947.805782913076;12970.80543791825;13022.804657930328;8094.595270236347;8149.022117345957;8244.711435099744;8329.833403331779;8343.958280208803;10071.798564028824;10181;10256.641017564349;10269.435181064815;10295.227857910837;8647.394682372425;8651.52416617092;8653.264472519906;8716.738497845075;8749.387542871938;8461;8501.489910605384;8557.57212139403;8582.184692454206;8746.956265218632;7666.9616651916385;7811.296983271533;7870.606469676379;7873.409494288066;7886.960565197137;5785.4214578541805;5821.185034095315;5971.134185543159;6029.065494848305;6032;5622.2128901954575;5899.734511946886;6077.939220607915;6148.938510615016;6197.101420294122 11:13:23 INFO - PID 6607 | |4;prototype.html;397.88393556075215;402.8549722100042;403.2177575503523;403.6689914270298;405.588327847235;5555.527780138693;6343.904841427382;6405.647689377082;6447.258565264996;6449;4766.307960673963;5913.763449462016;6053.614046206704;6154.2614886213605;6248.218972628421;4695.966887284809;4702.388689470373;4705.200115980291;4709.9058018839605;4728.787204575802;4105.111648641629;4405.691601587891;4691.9765401172945;4729.4797572267025;4734.928976065362;3840.9231815363814;4060.2894493463673;4065.4918135233097;4415.757133357664;4469.64242860572;4634.910795962946;4647.907041859161;4659.6505262105475;4668.159731248374;4698.8355407560575;3441.328940856509;4131.814068366931;4132.752034877917;4165.271077561415;4172.436721042681;5798.362180160179;5843.561732870052;5997.970010149965;6117.134274046414;6166.352532984017;4879.853604391874;5607.710226647853;5611.382747897728;5634.830955071355;5663.745131469093;5148.4851514848215;5230.764615592269;6039.912815693174;6390.616563006234;6736.360045795642;4025.8993525161814;4122.835086596562;4531.388262584542;4665.86002419928;4708.4349878014855;6204.751809927642;7085.929140708578;7114.893276600855;7135.108111486064;7138.714451421937;4598.494165641777;4616.446026476777;4739.199104340329;4873.6832105913;4889.65772395936;4965.255211718199;4969;4991.750412479361;4992.600591952635;4994.200927851526;4475.865724028285;4519.909601807945;5012.423571289275;5607.663540187602;5651.802186923438;6708.563943343667;6715.294894036154;6729.528932974743;6740.831479213059;6755.4257888080065;1341.89964229331;1564.8420169074802;1576.968460630781;1577.928993195309;1582.5806161367248;991.682661548312;1030.2479190191202;1032.5456799008412;1034.813733527972;1045.242199405425;6433.102234840733;6481.773137940149;6512.023196520465;6529.249136349285;6542.182227221598;5542.806001789999;6413.8834184718935;6756;6805.591664500047;7045.542039767399;5216.921746173734;6176.4294422127305;6395.616263024233;6436.645984470805;6496.642684652389;3206.711395974327;3479.9826000869834;3578.8031658258524;3643.8178091095338;3650.7261955352924;5863.677497737665;6161.322254551996;6266.746650669793;6800.285969973082;7192.244814294424;5905.232319798484;6578.572392794453;6759.817032019377;7208.783736487913;7282.344588987016;6170;6850.862982740417;7120.679569419285;7203.711851525985;7209.855802883913;6563.901541476786;6968.372846443642;6990.510664253454;6993.090838241677;6994.2656021117045;6557.540972131905;6707.3292670732535;6753.459723222229;6780.135462747784;6832.829179270558;6651.667416629246;7253.202147763847;7281.1262648482525;7301.744438944612;7343.522671026366;3802.619738026286;4525.63794896414;4530.889931966689;4538.2511885538515;4541.409616749801;6658.933410666025;6952.235254121942;6999.335063168991;7030.156381234285;7036.9296307036275;6238.814625221194;6486.562122075307;6679.799606011828;6687.929931210982;6778.4577233822165;5361;6402.423781859655;6688.264290928091;6763.391294783493;6814.637072585404;5135.512126347991;5998.370171131968;6538.738450462119;6560.179977502812;6584.670766461753;5905.645661260338;6439.484841212598;6716.462682985251;6748.460123190035;6787.457003439812;6488.286288508166;6561.80314590563;6579.309172536815;6584.670766461753;6590.406863382319 11:13:23 INFO - PID 6607 | |5;yui.html;615.3477314047108;725.5102805606216;737.9077615298088;741.2550386861201;741.388354607449;15758.921205393972;16452.670946581093;16590.91704541477;16620;16642.83357166428;13228.809407153378;14300.642483937907;15329.463468778567;15329.463468778595;15374.385024599003;930.1814403325064;945.3146468810127;985.1576901749008;1021.3310281765456;1027.3014350241833;995.8655581496478;1009.0162091960353;1012.2155329619567;1014.1025192704436;1016.1718199667284;1056.1550759392494;1059.3061544688242;1060.0035966191756;1068.3803394031481;1068.5138262090768;1033.7415646088477;1053.3521884041297;1054.430607471968;1057.508258659723;1059.5285098131335;771.6219052664154;782.3193821375382;784.7959530522048;788.3850596534712;789.159545084489;16621.168941552995;16821.327146914107;16967;16993.83006169947;17046.891952023077;14995.100293982396;15101.848981510155;15180.468683596131;15309.311081001382;16015.718742500572;9904.702858914245;11418.60034898783;11777.705557361049;11800.684473623867;12103.576374826927;2968.7921845470823;3015.3969206158854;3026.3493348930087;3029.1518374855077;3043.9543406848916;120472.39763801213;125846.37076814649;127563.3621831885;127769;129292;11203.831942520868;11622.70943226426;11707.941460292814;11720.941395292968;11763.823542646867;25512.23463296104;25665.743342566708;26060.60909086365;26131.477370452863;26173.73826261751;7897.091834439113;7950.960245198737;8173.305269052197;8203.343732501506;8349.666013359398;4221.071364299849;4234.894127646833;4327.978360108179;4373.278409062533;4390.1000294940095;3719.2933342664805;4092.733972291851;4163.417121602978;4258.787060646955;4276.503223871682;841.9175911252054;855.1790281329869;856.9571521423904;862.4609618988133;882.594006756899;488.274911756042;554.5341912793273;560.3499940069499;584.7544031506777;601.9548533859978;9475.763105922408;9652.469114198786;10335.844962325571;10342.37945723259;10496.370217786805;538.1174873207942;547.5975158258676;551.2227758859988;551.8565173055034;555.2670474972997;4638.782891627383;4767.046749155428;4827.517248275215;4883.975580122148;5180.948190518122;67870.66064669644;68133.65933170302;87856.12143878607;102770;106858;93870.49528231408;96821.51589242149;97568;98915;99253.50373248088;76526;77158.6142069286;77812;77966.6101669488;78396.21603784003;10172.694819155437;10793.406362649815;11137.164712646745;11186;11236.55053797839;31090.689093109686;36678.8166059168;37190.512379504515;39322.2135557293;41313;68897.31102688909;70014;71790.64104679444;72008.63995679987;73140;13592.252426116263;14047.367868446148;14352;14391.568252952427;14748.262586870827;15262.160581167698;15396.69206615839;15412.614684632974;15467.84532154709;15963.600909977344;13779.242141682304;14000.64998375008;14103.435862565382;14312;14721.779173312194;13970.650733731738;14025.789613155606;14086.929565352108;14555.41778328855;14790.408383664962;13635.454581816617;13880.444782209002;13929.25582880851;14461.566153015427;14750.409983600535;9735.264760069902;10079.798404031731;10257.846132307872;10261.076503114755;10374.844377334195;8619.569021549023;10362.533685983997;11176.482260496723;11492.885071149181;11502.42487875586 11:13:23 INFO - PID 6607 | __end_tp_report 11:13:23 INFO - PID 6607 | __start_cc_report 11:13:23 INFO - PID 6607 | _x_x_mozilla_cycle_collect,429 11:13:23 INFO - PID 6607 | __end_cc_report 11:13:23 INFO - PID 6607 | __startTimestamp1491070403473__endTimestamp 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | ------- Summary: start ------- 11:13:23 INFO - PID 6607 | Number of tests: 6 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | [#0] dojo.html Cycles:165 Average:6244.02 Median:6485.94 stddev:773.03 (11.9%) stddev-sans-first:746.24 11:13:23 INFO - PID 6607 | Values: 3562.9 3608.4 3621.0 3629.6 3630.5 5850.9 6159.8 6263.9 6279.3 6326.7 5574.0 6001.9 6189.4 6242.3 6340.8 5490.6 5555.4 5617.5 5647.2 5680.7 5484.6 5570.6 5658.6 5668.1 5695.3 5404.3 5481.8 5604.9 5625.7 5638.2 4626.9 5436.6 5558.6 5565.5 5590.8 5471.5 5509.3 5510.6 5530.8 5540.1 6147.5 6183.7 6295.4 6368.6 6376.1 6655.2 6749.7 6825.7 6831.6 6854.6 6898.1 6929.4 6934.4 6934.7 6944.8 6280.6 6377.0 6383.6 6385.6 6387.9 6819.8 6912.3 6976.5 7018.4 7054.9 5613.3 6448.5 6530.8 6609.7 6639.6 6782.5 6867.1 6879.1 6915.0 6918.1 6786.6 6829.3 6834.5 6842.0 6844.9 6514.5 6567.6 6586.9 6717.9 6752.9 4822.4 5456.1 5462.2 5464.4 5478.9 4298.9 4658.2 4789.6 4816.6 4824.8 5706.4 5898.9 6238.1 6534.2 6566.0 5761.2 6872.3 6901.3 6934.9 6972.7 6441.3 6459.0 6466.9 6484.2 6502.3 5866.7 6001.3 6086.5 6089.6 6111.8 6913.5 7053.2 7117.2 7144.4 7159.6 6919.3 6923.0 6938.1 6942.9 6945.3 6960.1 7053.6 7142.6 7142.7 7145.5 6494.5 6590.3 6707.2 6723.8 6770.2 6845.8 6853.3 6866.1 6883.1 6889.9 4993.8 6386.4 6416.3 6622.0 6731.7 6494.8 6677.6 6702.2 6730.5 6732.0 6320.2 6390.5 6421.6 6452.5 6485.9 6640.8 6678.4 6698.6 6703.6 6709.8 6529.6 6548.1 6548.2 6550.5 6552.2 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | [#1] ext.html Cycles:180 Average:54369.24 Median:197269.05 stddev:109904.50 (55.7%) stddev-sans-first:110138.94 11:13:23 INFO - PID 6607 | Values: 698.5 754.6 823.6 1081.5 1287.9 37821.6 39071.6 39105.6 39122.0 39128.8 38625.6 39017.0 39022.4 39046.0 39083.0 7974.8 8148.5 8499.9 8751.3 8786.2 8619.0 8729.7 8736.0 8754.8 8766.1 8673.9 8693.7 8749.7 8762.1 8766.8 8638.7 8663.8 8713.3 8732.0 8739.0 8575.5 8644.4 8646.7 8655.8 8667.3 38811.8 38914.4 39063.8 39095.4 39143.6 3073.5 3082.0 3086.6 3108.2 3160.4 27596.7 28081.0 28256.3 28938.7 28963.6 2810.7 2843.2 2897.7 2956.8 2980.6 353216.0 354983.0 355068.0 358610.0 359767.0 39914.8 51105.5 51134.0 51179.7 51186.0 46357.3 53188.7 53422.9 53698.2 53740.9 14806.0 14832.0 14934.8 14947.6 14966.2 10150.3 12140.7 12145.8 12148.7 12212.6 12254.5 12388.9 12763.1 13655.3 13780.3 5209.8 5911.9 5920.9 5996.7 6035.0 992.0 995.5 998.7 1000.7 1038.6 20383.3 23154.9 24683.5 24689.6 24710.8 961.5 1065.8 1095.2 1135.6 1147.8 10287.9 11862.9 12090.9 12412.6 12491.3 474182.6 478317.0 478336.0 478369.0 478946.0 48771.5 55893.2 56487.0 56909.0 57240.0 1470.6 1511.9 1512.1 1517.9 1519.2 27487.9 28337.4 28675.4 28816.4 28871.7 38055.4 38214.8 38247.2 38358.6 38398.6 395757.0 397552.0 398947.0 400345.0 401224.0 32060.7 32563.7 32628.3 32752.3 32759.8 41463.6 41867.0 42126.5 42600.0 42801.4 27726.0 29791.7 29793.6 29793.7 29897.4 29016.3 29742.0 29955.7 29961.4 30174.4 34468.5 35116.5 35136.6 35347.0 35928.1 29227.7 29251.4 29997.9 30336.5 30495.7 20236.6 23170.5 23994.8 24171.0 24221.4 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | [#2] jquery.html Cycles:180 Average:41906.15 Median:23412.32 stddev:124424.85 (531.5%) stddev-sans-first:124734.83 11:13:23 INFO - PID 6607 | Values: 380.3 423.5 426.5 449.7 452.9 21689.3 22028.7 22581.4 23105.3 23367.8 22588.8 22742.2 23456.9 23678.6 23936.6 6204.7 6331.1 6405.8 6431.4 6439.5 6055.3 6320.7 6341.9 6353.4 6355.5 5333.5 6089.8 6226.7 6303.8 6390.9 6390.6 6430.0 6431.3 6440.9 6462.0 5598.4 5740.3 5815.6 5816.5 5828.0 27052.8 27852.7 27992.7 28059.4 28585.6 2030.1 2056.8 2097.1 2099.7 2163.8 16322.3 16624.8 17013.0 17640.8 18090.3 1909.5 1921.5 1927.6 1932.0 1932.3 152352.0 155858.0 156981.0 157833.0 161905.0 10502.4 12411.9 12427.0 12559.6 12643.3 13885.7 16319.3 16348.3 16358.4 16419.8 7444.9 7761.5 8942.6 9164.9 9302.4 8834.8 8851.2 8852.1 8921.2 8998.9 7902.9 7985.1 7986.6 8032.6 8056.6 2227.6 2229.2 2230.7 2235.9 2417.7 814.9 939.6 943.5 952.4 993.9 17806.1 18587.0 19785.5 20214.3 20612.9 825.7 881.9 990.1 1001.6 1024.6 7765.7 8873.8 10748.7 10810.1 10991.8 674946.0 732670.0 763263.0 771501.0 776769.0 132157.0 134042.0 152589.0 153679.2 169906.0 1214.4 1233.5 1269.2 1274.8 1275.9 22215.3 22223.3 22302.8 22309.9 22672.7 43387.3 64421.0 64677.7 64958.4 65446.3 64769.7 88330.1 89081.0 89924.7 92590.0 7256.9 8005.0 8204.5 8657.3 8771.0 13789.5 13799.4 13824.4 14247.3 14263.8 10228.6 11462.9 11680.0 11854.1 12010.0 10646.6 10750.9 10830.1 11014.4 11328.3 11693.5 11919.3 12195.7 12197.7 12303.4 8588.1 8650.7 8820.3 8867.3 9022.9 11607.7 11690.1 11907.2 11950.6 12068.9 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | [#3] mootools.html Cycles:180 Average:6705.47 Median:2487.70 stddev:4130.63 (166.0%) stddev-sans-first:4122.85 11:13:23 INFO - PID 6607 | Values: 1383.2 1406.8 1414.6 1416.0 1448.8 10552.9 10977.5 11054.0 11062.4 11149.4 9090.7 10894.1 10990.5 11101.9 11110.9 2449.5 2484.9 2490.5 2492.1 2494.9 2051.8 2410.5 2431.8 2450.5 2473.4 2392.2 2428.6 2443.2 2470.9 2472.6 2314.9 2426.2 2435.3 2445.7 2466.1 2044.6 2139.9 2356.3 2450.9 2455.2 10929.7 11020.1 11043.1 11058.2 11066.6 6193.9 6392.6 6430.2 6437.0 6453.7 3862.9 3893.1 3947.9 3979.6 3994.0 1152.1 1570.4 1612.9 1630.4 1704.2 15251.9 15304.5 15308.2 15400.2 15407.3 5148.8 5360.9 5375.5 5418.9 5500.7 11195.0 11264.4 11307.8 11321.4 11326.9 6215.2 6224.9 6226.0 6234.9 6238.8 5721.0 5801.9 5826.5 5829.9 5887.5 4134.2 4254.7 4330.3 4342.0 4361.6 1252.1 1271.4 1276.0 1286.9 1287.9 686.9 743.5 772.1 775.5 803.3 5861.2 5954.7 6053.8 6135.4 6190.0 551.7 581.5 593.8 595.6 596.4 3609.0 3790.3 4009.6 4215.3 4319.4 12661.1 12749.5 13364.2 14013.4 14134.8 11365.9 12929.4 13287.5 13830.3 13960.8 10055.8 10082.9 10168.8 10270.4 10302.5 5283.6 5472.4 5485.6 6444.7 6614.3 11253.2 12209.9 12335.3 12439.3 12538.1 10550.6 12906.7 12947.8 12970.8 13022.8 8094.6 8149.0 8244.7 8329.8 8344.0 10071.8 10181.0 10256.6 10269.4 10295.2 8647.4 8651.5 8653.3 8716.7 8749.4 8461.0 8501.5 8557.6 8582.2 8747.0 7667.0 7811.3 7870.6 7873.4 7887.0 5785.4 5821.2 5971.1 6029.1 6032.0 5622.2 5899.7 6077.9 6148.9 6197.1 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | [#4] prototype.html Cycles:180 Average:5401.78 Median:6046.76 stddev:1698.17 (28.1%) stddev-sans-first:1660.88 11:13:23 INFO - PID 6607 | Values: 397.9 402.9 403.2 403.7 405.6 5555.5 6343.9 6405.6 6447.3 6449.0 4766.3 5913.8 6053.6 6154.3 6248.2 4696.0 4702.4 4705.2 4709.9 4728.8 4105.1 4405.7 4692.0 4729.5 4734.9 3840.9 4060.3 4065.5 4415.8 4469.6 4634.9 4647.9 4659.7 4668.2 4698.8 3441.3 4131.8 4132.8 4165.3 4172.4 5798.4 5843.6 5998.0 6117.1 6166.4 4879.9 5607.7 5611.4 5634.8 5663.7 5148.5 5230.8 6039.9 6390.6 6736.4 4025.9 4122.8 4531.4 4665.9 4708.4 6204.8 7085.9 7114.9 7135.1 7138.7 4598.5 4616.4 4739.2 4873.7 4889.7 4965.3 4969.0 4991.8 4992.6 4994.2 4475.9 4519.9 5012.4 5607.7 5651.8 6708.6 6715.3 6729.5 6740.8 6755.4 1341.9 1564.8 1577.0 1577.9 1582.6 991.7 1030.2 1032.5 1034.8 1045.2 6433.1 6481.8 6512.0 6529.2 6542.2 5542.8 6413.9 6756.0 6805.6 7045.5 5216.9 6176.4 6395.6 6436.6 6496.6 3206.7 3480.0 3578.8 3643.8 3650.7 5863.7 6161.3 6266.7 6800.3 7192.2 5905.2 6578.6 6759.8 7208.8 7282.3 6170.0 6850.9 7120.7 7203.7 7209.9 6563.9 6968.4 6990.5 6993.1 6994.3 6557.5 6707.3 6753.5 6780.1 6832.8 6651.7 7253.2 7281.1 7301.7 7343.5 3802.6 4525.6 4530.9 4538.3 4541.4 6658.9 6952.2 6999.3 7030.2 7036.9 6238.8 6486.6 6679.8 6687.9 6778.5 5361.0 6402.4 6688.3 6763.4 6814.6 5135.5 5998.4 6538.7 6560.2 6584.7 5905.6 6439.5 6716.5 6748.5 6787.5 6488.3 6561.8 6579.3 6584.7 6590.4 11:13:23 INFO - PID 6607 | 11:13:23 INFO - PID 6607 | [#5] yui.html Cycles:180 Average:20953.31 Median:16980.42 stddev:30558.16 (180.0%) stddev-sans-first:30605.72 11:13:23 INFO - PID 6607 | Values: 615.3 725.5 737.9 741.3 741.4 15758.9 16452.7 16590.9 16620.0 16642.8 13228.8 14300.6 15329.5 15329.5 15374.4 930.2 945.3 985.2 1021.3 1027.3 995.9 1009.0 1012.2 1014.1 1016.2 1056.2 1059.3 1060.0 1068.4 1068.5 1033.7 1053.4 1054.4 1057.5 1059.5 771.6 782.3 784.8 788.4 789.2 16621.2 16821.3 16967.0 16993.8 17046.9 14995.1 15101.8 15180.5 15309.3 16015.7 9904.7 11418.6 11777.7 11800.7 12103.6 2968.8 3015.4 3026.3 3029.2 3044.0 120472.4 125846.4 127563.4 127769.0 129292.0 11203.8 11622.7 11707.9 11720.9 11763.8 25512.2 25665.7 26060.6 26131.5 26173.7 7897.1 7951.0 8173.3 8203.3 8349.7 4221.1 4234.9 4328.0 4373.3 4390.1 3719.3 4092.7 4163.4 4258.8 4276.5 841.9 855.2 857.0 862.5 882.6 488.3 554.5 560.3 584.8 602.0 9475.8 9652.5 10335.8 10342.4 10496.4 538.1 547.6 551.2 551.9 555.3 4638.8 4767.0 4827.5 4884.0 5180.9 67870.7 68133.7 87856.1 102770.0 106858.0 93870.5 96821.5 97568.0 98915.0 99253.5 76526.0 77158.6 77812.0 77966.6 78396.2 10172.7 10793.4 11137.2 11186.0 11236.6 31090.7 36678.8 37190.5 39322.2 41313.0 68897.3 70014.0 71790.6 72008.6 73140.0 13592.3 14047.4 14352.0 14391.6 14748.3 15262.2 15396.7 15412.6 15467.8 15963.6 13779.2 14000.6 14103.4 14312.0 14721.8 13970.7 14025.8 14086.9 14555.4 14790.4 13635.5 13880.4 13929.3 14461.6 14750.4 9735.3 10079.8 10257.8 10261.1 10374.8 8619.6 10362.5 11176.5 11492.9 11502.4 11:13:23 INFO - PID 6607 | -------- Summary: end -------- 11:13:23 INFO - PID 6607 | 11:13:24 INFO - TEST-INFO | 6607: exit 0 11:13:24 INFO - TEST-OK | dromaeo_css | took 1118197ms 11:13:24 INFO - TEST-START | kraken 11:13:24 INFO - operating with platform_type : mac_ 11:13:24 INFO - Initialising browser for kraken test... 11:13:24 INFO - TEST-INFO | started process 6612 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpXHow1k/profile http://localhost:57399/getInfo.html) 11:13:27 INFO - PID 6612 | 2017-04-01 11:13:27.050 plugin-container[6613:127675] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 11:13:27 INFO - PID 6612 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:27 INFO - PID 6612 | 2017-04-01 11:13:27.053 plugin-container[6613:127675] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 11:13:27 INFO - PID 6612 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:27 INFO - PID 6612 | 2017-04-01 11:13:27.053 plugin-container[6613:127675] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:13:27 INFO - PID 6612 | __metrics Screen width/height:1600/1200 11:13:27 INFO - PID 6612 | colorDepth:24 11:13:27 INFO - PID 6612 | Browser inner width/height: 1024/689 11:13:27 INFO - PID 6612 | __metrics 11:13:27 ERROR - PID 6612 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 11:13:28 INFO - TEST-INFO | 6612: exit 0 11:13:28 INFO - Browser initialized. 11:13:28 INFO - Running cycle 1/1 for kraken test... 11:13:28 INFO - TEST-INFO | started process 6614 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpXHow1k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:30 INFO - PID 6614 | 2017-04-01 11:13:30.471 plugin-container[6615:127795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 11:13:30 INFO - PID 6614 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:30 INFO - PID 6614 | 2017-04-01 11:13:30.471 plugin-container[6615:127795] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 11:13:30 INFO - PID 6614 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:30 INFO - PID 6614 | 2017-04-01 11:13:30.471 plugin-container[6615:127795] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:13:40 INFO - PID 6614 | RSS: Main: 228761600 11:13:40 INFO - PID 6614 | 11:13:43 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:44 INFO - PID 6614 | RSS: Main: 243535872 11:13:44 INFO - PID 6614 | 11:13:46 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-dft) 11:13:47 INFO - PID 6614 | RSS: Main: 252100608 11:13:47 INFO - PID 6614 | 11:13:51 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-fft) 11:13:51 INFO - PID 6614 | RSS: Main: 254431232 11:13:51 INFO - PID 6614 | 11:13:53 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57399/tests/kraken/driver.html?testName=audio-oscillator) 11:13:54 INFO - PID 6614 | RSS: Main: 256471040 11:13:54 INFO - PID 6614 | 11:13:56 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:57 INFO - PID 6614 | RSS: Main: 257097728 11:13:57 INFO - PID 6614 | 11:14:00 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57399/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:01 INFO - PID 6614 | RSS: Main: 262864896 11:14:01 INFO - PID 6614 | 11:14:04 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57399/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:05 INFO - PID 6614 | RSS: Main: 260272128 11:14:05 INFO - PID 6614 | 11:14:08 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57399/tests/kraken/driver.html?testName=json-parse-financial) 11:14:09 INFO - PID 6614 | RSS: Main: 261361664 11:14:09 INFO - PID 6614 | 11:14:10 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:11 INFO - PID 6614 | RSS: Main: 261537792 11:14:11 INFO - PID 6614 | 11:14:13 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:14 INFO - PID 6614 | RSS: Main: 261541888 11:14:14 INFO - PID 6614 | 11:14:16 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:17 INFO - PID 6614 | RSS: Main: 261808128 11:14:17 INFO - PID 6614 | 11:14:20 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:21 INFO - PID 6614 | RSS: Main: 262193152 11:14:21 INFO - PID 6614 | 11:14:24 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:25 INFO - PID 6614 | RSS: Main: 260075520 11:14:25 INFO - PID 6614 | 11:14:26 INFO - PID 6614 | Cycle 1(1): loaded http://localhost:57399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57399/tests/kraken/driver.html?testName=ai-astar) 11:14:27 INFO - PID 6614 | RSS: Main: 263348224 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | __start_tp_report 11:14:27 INFO - PID 6614 | _x_x_mozilla_page_load 11:14:27 INFO - PID 6614 | _x_x_mozilla_page_load_details 11:14:27 INFO - PID 6614 | |i|pagename|runs| 11:14:27 INFO - PID 6614 | |0;ai-astar;159;178;136;182;151;120;123;123;119;121 11:14:27 INFO - PID 6614 | |1;audio-beat-detection;145;103;125;191;161;108;146;153;177;117 11:14:27 INFO - PID 6614 | |2;audio-dft;225;230;246;251;305;235;217;208;210;217 11:14:27 INFO - PID 6614 | |3;audio-fft;83;59;63;90;63;62;59;49;92;91 11:14:27 INFO - PID 6614 | |4;audio-oscillator;87;71;88;74;71;74;83;79;57;104 11:14:27 INFO - PID 6614 | |5;imaging-gaussian-blur;127;92;92;92;90;135;91;113;108;91 11:14:27 INFO - PID 6614 | |6;imaging-darkroom;111;160;149;161;99;107;100;127;119;171 11:14:27 INFO - PID 6614 | |7;imaging-desaturate;101;104;102;144;143;100;103;131;115;160 11:14:27 INFO - PID 6614 | |8;json-parse-financial;52;60;64;68;54;52;53;53;53;54 11:14:27 INFO - PID 6614 | |9;json-stringify-tinderbox;59;69;63;99;53;80;86;85;89;87 11:14:27 INFO - PID 6614 | |10;stanford-crypto-aes;86;88;108;78;107;78;90;104;113;109 11:14:27 INFO - PID 6614 | |11;stanford-crypto-ccm;148;167;185;170;170;136;172;172;221;171 11:14:27 INFO - PID 6614 | |12;stanford-crypto-pbkdf2;233;206;177;237;211;179;258;234;197;206 11:14:27 INFO - PID 6614 | |13;stanford-crypto-sha256-iterative;73;73;73;76;88;109;69;71;70;72 11:14:27 INFO - PID 6614 | __end_tp_report 11:14:27 INFO - PID 6614 | __start_cc_report 11:14:27 INFO - PID 6614 | _x_x_mozilla_cycle_collect,1007 11:14:27 INFO - PID 6614 | __end_cc_report 11:14:27 INFO - PID 6614 | __startTimestamp1491070467124__endTimestamp 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | ------- Summary: start ------- 11:14:27 INFO - PID 6614 | Number of tests: 14 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#0] ai-astar Cycles:10 Average:141.20 Median:143.50 stddev:24.66 (17.2%) stddev-sans-first:25.30 11:14:27 INFO - PID 6614 | Values: 159.0 178.0 136.0 182.0 151.0 120.0 123.0 123.0 119.0 121.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:149.50 stddev:29.29 (19.6%) stddev-sans-first:31.05 11:14:27 INFO - PID 6614 | Values: 145.0 103.0 125.0 191.0 161.0 108.0 146.0 153.0 177.0 117.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#2] audio-dft Cycles:10 Average:234.40 Median:232.50 stddev:28.68 (12.3%) stddev-sans-first:30.21 11:14:27 INFO - PID 6614 | Values: 225.0 230.0 246.0 251.0 305.0 235.0 217.0 208.0 210.0 217.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#3] audio-fft Cycles:10 Average:71.10 Median:73.00 stddev:16.08 (22.0%) stddev-sans-first:16.47 11:14:27 INFO - PID 6614 | Values: 83.0 59.0 63.0 90.0 63.0 62.0 59.0 49.0 92.0 91.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:76.50 stddev:12.68 (16.6%) stddev-sans-first:13.10 11:14:27 INFO - PID 6614 | Values: 87.0 71.0 88.0 74.0 71.0 74.0 83.0 79.0 57.0 104.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:91.00 stddev:16.82 (18.5%) stddev-sans-first:15.45 11:14:27 INFO - PID 6614 | Values: 127.0 92.0 92.0 92.0 90.0 135.0 91.0 113.0 108.0 91.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#6] imaging-darkroom Cycles:10 Average:130.40 Median:154.50 stddev:27.45 (17.8%) stddev-sans-first:28.21 11:14:27 INFO - PID 6614 | Values: 111.0 160.0 149.0 161.0 99.0 107.0 100.0 127.0 119.0 171.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#7] imaging-desaturate Cycles:10 Average:120.30 Median:123.00 stddev:22.31 (18.1%) stddev-sans-first:22.55 11:14:27 INFO - PID 6614 | Values: 101.0 104.0 102.0 144.0 143.0 100.0 103.0 131.0 115.0 160.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:54.00 stddev:5.68 (10.5%) stddev-sans-first:5.80 11:14:27 INFO - PID 6614 | Values: 52.0 60.0 64.0 68.0 54.0 52.0 53.0 53.0 53.0 54.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:85.50 stddev:15.06 (17.6%) stddev-sans-first:14.50 11:14:27 INFO - PID 6614 | Values: 59.0 69.0 63.0 99.0 53.0 80.0 86.0 85.0 89.0 87.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#10] stanford-crypto-aes Cycles:10 Average:96.10 Median:78.00 stddev:13.48 (17.3%) stddev-sans-first:13.79 11:14:27 INFO - PID 6614 | Values: 86.0 88.0 108.0 78.0 107.0 78.0 90.0 104.0 113.0 109.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#11] stanford-crypto-ccm Cycles:10 Average:171.20 Median:171.50 stddev:22.29 (13.0%) stddev-sans-first:22.00 11:14:27 INFO - PID 6614 | Values: 148.0 167.0 185.0 170.0 170.0 136.0 172.0 172.0 221.0 171.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:213.80 Median:222.00 stddev:26.34 (11.9%) stddev-sans-first:27.01 11:14:27 INFO - PID 6614 | Values: 233.0 206.0 177.0 237.0 211.0 179.0 258.0 234.0 197.0 206.0 11:14:27 INFO - PID 6614 | 11:14:27 INFO - PID 6614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:73.00 stddev:12.32 (16.9%) stddev-sans-first:12.97 11:14:27 INFO - PID 6614 | Values: 73.0 73.0 73.0 76.0 88.0 109.0 69.0 71.0 70.0 72.0 11:14:27 INFO - PID 6614 | -------- Summary: end -------- 11:14:27 INFO - PID 6614 | 11:14:28 INFO - TEST-INFO | 6614: exit 0 11:14:28 INFO - TEST-OK | kraken | took 63816ms 11:14:28 INFO - SUITE-END | took 1182s 11:14:28 INFO - Completed test suite (00:19:42) 11:14:28 INFO - javascript benchmark 11:14:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7808.446550992807, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3562.9287414251717, 3608.386574282372, 3621.0404242875625, 3629.61889001655, 3630.546181727284, 5850.912236316453, 6159.784407545737, 6263.9060414093765, 6279.277883043452, 6326.652034138132, 5573.972130139354, 6001.87996240075, 6189.381061893809, 6242.344553821851, 6340.809775706724, 5490.6431081979745, 5555.444455554452, 5617.494425501704, 5647.181158731982, 5680.715964201794, 5484.561235101202, 5570.554355651539, 5658.603897727161, 5668.064769313059, 5695.316562012544, 5404.297441332602, 5481.835544933659, 5604.887902241932, 5625.746841392106, 5638.210650508932, 4626.86119416418, 5436.592255580847, 5558.583106267046, 5565.526930210937, 5590.832275031756, 5471.50756431923, 5509.311336082989, 5510.614257002011, 5530.778768849241, 5540.113581826889, 6147.538934579924, 6183.690815459209, 6295.433410992987, 6368.649724265164, 6376.075469056961, 6655.201375834931, 6749.6962636681465, 6825.726970921207, 6831.59010459374, 6854.588724676535, 6898.0687607173395, 6929.44564434844, 6934.410575101122, 6934.653267336664, 6944.826379340507, 6280.591761535486, 6377.0, 6383.585066970725, 6385.584936979081, 6387.872242555216, 6819.795406137824, 6912.343327383891, 6976.476764242702, 7018.403435708022, 7054.858902822018, 5613.324196287582, 6448.516361272923, 6530.771423000172, 6609.6695165241545, 6639.601623902581, 6782.491313151533, 6867.141607299088, 6879.105716256955, 6914.991978489374, 6918.135233095863, 6786.59280443175, 6829.282925292872, 6834.4874134440115, 6841.965790171117, 6844.8973265401055, 6514.5114116441455, 6567.638779867153, 6586.868262634721, 6717.932820671828, 6752.93247067523, 4822.397200349957, 5456.127019676833, 5462.180672899097, 5464.426235245242, 5478.863028424321, 4298.871033868989, 4658.208104622222, 4789.592884604847, 4816.566509014136, 4824.831130910401, 5706.400827913092, 5898.941010589925, 6238.1266622672865, 6534.183227096613, 6566.0, 5761.222234998221, 6872.278410766898, 6901.275366086589, 6934.895976560356, 6972.651367431709, 6441.25925518562, 6459.0, 6466.870662586722, 6484.221893372825, 6502.349765023459, 5866.735996880236, 6001.339852616209, 6086.482648974798, 6089.63462192261, 6111.8472038198515, 6913.51605387618, 7053.153621565445, 7117.217106118219, 7144.392726618088, 7159.606221657858, 6919.342662447059, 6922.965385173042, 6938.06336144614, 6942.8611427772175, 6945.305469453015, 6960.095187625576, 7053.647317633995, 7142.607156606437, 7142.678579463833, 7145.4998150128995, 6494.545381823227, 6590.275069742229, 6707.1616047994, 6723.7646682365885, 6770.1537307836525, 6845.828854278484, 6853.348931851466, 6866.141732283465, 6883.070785444102, 6889.862202756017, 4993.800247990185, 6386.393292637192, 6416.294207637063, 6622.0, 6731.663416829237, 6494.772682956074, 6677.599344039373, 6702.229243637044, 6730.4952128589575, 6731.966340168267, 6320.209973753281, 6390.48876089921, 6421.550491465552, 6452.548321617442, 6485.935140648533, 6640.800775976729, 6678.432333251728, 6698.631575263407, 6703.597784132968, 6709.832254193684, 6529.608223506605, 6548.0832683425315, 6548.246951600437, 6550.508711846726, 6552.213734351908], "value": 6191.70444561551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.472653146874, 754.5698951597589, 823.5882058970512, 1081.4808891731968, 1287.9420426080826, 37821.62178378215, 39071.60928390715, 39105.60894391055, 39122.0, 39128.80435597818, 38625.61374386255, 39017.0, 39022.414663780066, 39046.0, 39083.02292442691, 7974.840503189918, 8148.470349427268, 8499.915000850006, 8751.3436492263, 8786.209241168293, 8618.956905215466, 8729.650813967433, 8736.0, 8754.781130471725, 8766.123387661246, 8673.869891951626, 8693.652253909868, 8749.650013999433, 8762.123787621218, 8766.780830479225, 8638.65445382184, 8663.826723465558, 8713.302935765123, 8731.956340218321, 8738.956305218497, 8575.528345940971, 8644.438111522732, 8646.740597782076, 8655.831462752574, 8667.306615470747, 38811.8059409704, 38914.41628375577, 39063.8046809767, 39095.41356879649, 39143.608563914284, 3073.4775088235056, 3082.0, 3086.6450358208867, 3108.1918701137643, 3160.4153231652217, 27596.724032759616, 28080.997319355505, 28256.293592660142, 28938.71061289381, 28963.56554651682, 2810.690824009357, 2843.24653966699, 2897.724716151962, 2956.822590644568, 2980.5976193214074, 353216.0, 354983.0, 355068.0, 358610.0, 359767.0, 39914.80042599768, 51105.488945110075, 51134.0, 51179.744101279255, 51186.0, 46357.30464043042, 53188.73405633024, 53422.931541368955, 53698.19452708212, 53740.92518149615, 14806.0, 14832.0, 14934.775978360334, 14947.626309342353, 14966.176860272572, 10150.340227885164, 12140.69648258783, 12145.757084858431, 12148.696282593006, 12212.57255996036, 12254.509819607116, 12388.876111238953, 12763.106582539132, 13655.317234138254, 13780.310984450738, 5209.791608335624, 5911.940880591225, 5920.934231838224, 5996.700164991733, 6034.969825150846, 992.0, 995.5221493683073, 998.6754304850953, 1000.6897861662908, 1038.6364772329623, 20383.286584969454, 23154.884225578764, 24683.50632987366, 24689.62965555518, 24710.752892471206, 961.5480724059681, 1065.808154532176, 1095.189559725813, 1135.6195674448986, 1147.8450409194818, 10287.897121028844, 11862.88137118635, 12090.851369119919, 12412.56556020535, 12491.312977786309, 474182.62908685236, 478317.0, 478336.0, 478369.0, 478946.0, 48771.512284877404, 55893.161602575994, 56487.0, 56909.0, 57240.0, 1470.5808844479486, 1511.9244037798067, 1512.0700769026969, 1517.8861585381142, 1519.1948267418286, 27487.86256068707, 28337.433251334445, 28675.426491469636, 28816.42367152687, 28871.711282887743, 38055.429168563045, 38214.80892595519, 38247.23505529818, 38358.6164138355, 38398.62419261361, 395757.0, 397552.0, 398947.0, 400345.0, 401224.0, 32060.67939320577, 32563.69745210165, 32628.34743305073, 32752.34495310128, 32759.836200818845, 41463.58536414597, 41867.0, 42126.52557160607, 42600.0, 42801.357979629705, 27726.0, 29791.702082978893, 29793.553096704, 29793.70206297996, 29897.402051959274, 29016.274593135342, 29742.0, 29955.70044299529, 29961.400771984874, 30174.396512069197, 34468.48297275593, 35116.473252900716, 35136.64863351436, 35347.0, 35928.10179745423, 29227.70772292335, 29251.414971700873, 29997.85001075068, 30336.54495182618, 30495.695043049287, 20236.59526809485, 23170.536589268457, 23994.76005239995, 24171.0, 24221.394465138514], "value": 17887.079200951564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.30594165647693, 423.531997143157, 426.46904603768314, 449.72566734292076, 452.86187712747613, 21689.34931952042, 22028.669569956444, 22581.435464113405, 23105.30684079476, 23367.76632233677, 22588.774112258874, 22742.204022859205, 23456.882715586442, 23678.644820327667, 23936.640950385758, 6204.689765511729, 6331.081993110996, 6405.807825765211, 6431.389018043278, 6439.452646525051, 6055.303640081403, 6320.71556779946, 6341.936580634181, 6353.396427339396, 6355.491560675158, 5333.493318134771, 6089.756409743627, 6226.719797609118, 6303.842403939915, 6390.93609063908, 6390.616563006211, 6430.035494675789, 6431.260405053432, 6440.935590644081, 6462.0306953956815, 5598.412166722517, 5740.253767010262, 5815.621984570989, 5816.47651711348, 5828.0, 27052.782624781932, 27852.746626401862, 27992.740326685143, 28059.438811223663, 28585.57121643177, 2030.0966070098812, 2056.845736569763, 2097.0668052716546, 2099.6955441460905, 2163.7836216378396, 16322.265498052617, 16624.750628740578, 17013.0, 17640.823591764045, 18090.276388944425, 1909.493984094216, 1921.4715953113007, 1927.6241132979076, 1931.985707503558, 1932.2611842826782, 152352.0, 155858.0, 156981.0, 157832.99999999886, 161905.0, 10502.422366769748, 12411.875881241253, 12427.0, 12559.560415385418, 12643.304618246084, 13885.722285554233, 16319.347226110822, 16348.264328105264, 16358.427455039016, 16419.753703694456, 7444.85110297791, 7761.534307941542, 8942.552872356357, 9164.90835091654, 9302.395344302598, 8834.823303533893, 8851.203391694778, 8852.070532594114, 8921.15249051339, 8998.910010899937, 7902.920970790334, 7985.121636619967, 7986.600669966479, 8032.638531266107, 8056.556889371141, 2227.593252435658, 2229.2309153342394, 2230.6727497139177, 2235.9441013974456, 2417.685700858877, 814.9266566008969, 939.5771902643837, 943.5235206220815, 952.3761935931838, 993.8707967964118, 17806.109694515224, 18587.0, 19785.50536236577, 20214.29249976273, 20612.896935515528, 825.7192554531488, 881.8765372847806, 990.1039559198792, 1001.62439085343, 1024.5901639344172, 7765.689372425039, 8873.778155546162, 10748.731281718019, 10810.081143102767, 10991.835122473169, 674946.0, 732670.0, 763263.0, 771501.0, 776769.0, 132157.0, 134042.0, 152589.0, 153679.23160384127, 169906.0, 1214.423149004216, 1233.5127624588238, 1269.206745783885, 1274.808778683205, 1275.8787915147861, 22215.33353999318, 22223.32309521476, 22302.77697223072, 22309.888450558294, 22672.65991010169, 43387.34918976281, 64421.0, 64677.67661161664, 64958.37604059936, 65446.34553654593, 64769.67615161894, 88330.1166988322, 89081.0, 89924.6511302344, 92590.0, 7256.891146632699, 8005.0, 8204.548749818818, 8657.307415406878, 8771.035186129648, 13789.51736689211, 13799.448022079005, 13824.447022119002, 14247.28763561797, 14263.786043209568, 10228.641997530349, 11462.885371146182, 11680.0, 11854.110941679237, 12010.0, 10646.574137034742, 10750.946245268724, 10830.133589312994, 11014.39420831862, 11328.263662861887, 11693.532258709556, 11919.284842909454, 12195.695107622381, 12197.69505762363, 12303.384830758605, 8588.055313915589, 8650.697225597074, 8820.25027872638, 8867.290616750515, 9022.909770902206, 11607.6517704469, 11690.064794816224, 11907.16649834538, 11950.641480755592, 12068.879311206776], "value": 10584.273638501692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.1562746724496, 1406.7608506553886, 1414.589768966999, 1416.0441701851248, 1448.760954442517, 10552.894471055288, 10977.506012229449, 11053.999999999989, 11062.446877656115, 11149.386783726892, 9090.727278181648, 10894.128469722424, 10990.505427255772, 11101.944490277558, 11110.888891111086, 2449.4611185539197, 2484.850908945469, 2490.5392502387117, 2492.1152990688224, 2494.9126780562683, 2051.7640471345762, 2410.505846301513, 2431.8176136789725, 2450.546648869965, 2473.4311108445067, 2392.1986134644917, 2428.574999375111, 2443.2425947956103, 2470.9135180268695, 2472.592022316325, 2314.895829687668, 2426.162973774045, 2435.2937648082034, 2445.730969593343, 2466.136852101768, 2044.570640165552, 2139.871607703543, 2356.3402247370764, 2450.8529488230765, 2455.177515532299, 10929.726756831064, 11020.063294619968, 11043.116550675926, 11058.170637202242, 11066.612668556561, 6193.876122477525, 6392.55252132351, 6430.196225471816, 6436.967815160941, 6453.709583068773, 3862.9034274143373, 3893.0729289002124, 3947.8618248361167, 3979.6418322350837, 3994.021464741157, 1152.1243854670427, 1570.371851259494, 1612.870970322383, 1630.4212004738383, 1704.1564425609279, 15251.923740381228, 15304.540863774104, 15308.158051307173, 15400.152991585346, 15407.306671199824, 5148.786022010497, 5360.865978350573, 5375.462453754593, 5418.91871621926, 5500.724963751796, 11195.0, 11264.380459074666, 11307.773844523064, 11321.433928303552, 11326.943365283121, 6215.160953271341, 6224.906626400608, 6226.0, 6234.906476402857, 6238.75044998195, 5721.027425337703, 5801.9129713054335, 5826.475617194473, 5829.941700583025, 5887.5289976802605, 4134.214499245134, 4254.680898932531, 4330.28550289205, 4342.0, 4361.5856493633055, 1252.0734656354414, 1271.4278574641264, 1276.0157954381027, 1286.8777466140702, 1287.929163895976, 686.8660611180771, 743.4907088644296, 772.1467778105225, 775.4571799740204, 803.2890891561011, 5861.238039054895, 5954.732037058343, 6053.818385448443, 6135.417135372132, 6190.0, 551.6827824001215, 581.4563383236688, 593.7803012885174, 595.6098755315276, 596.397638385234, 3608.963910360915, 3790.3177428062663, 4009.5789942055662, 4215.283401821697, 4319.352097185448, 12661.050421218446, 12749.490020399266, 13364.19814811095, 14013.369398377097, 14134.787978180335, 11365.886341136484, 12929.418176181905, 13287.468501259842, 13830.308484575731, 13960.790588141186, 10055.849162262572, 10082.949585252174, 10168.796624067478, 10270.435126067989, 10302.536385862653, 5283.603729720209, 5472.425395333433, 5485.6434331768305, 6444.742210311722, 6614.272430032596, 11253.212275140662, 12209.938950305192, 12335.259884406963, 12439.315837628656, 12538.122331436713, 10550.577976881146, 12906.741865162832, 12947.805782913076, 12970.80543791825, 13022.804657930328, 8094.595270236347, 8149.022117345957, 8244.711435099744, 8329.833403331779, 8343.958280208803, 10071.798564028824, 10181.0, 10256.641017564349, 10269.435181064815, 10295.227857910837, 8647.394682372425, 8651.52416617092, 8653.264472519906, 8716.738497845075, 8749.387542871938, 8461.0, 8501.489910605384, 8557.57212139403, 8582.184692454206, 8746.956265218632, 7666.9616651916385, 7811.296983271533, 7870.606469676379, 7873.409494288066, 7886.960565197137, 5785.4214578541805, 5821.185034095315, 5971.134185543159, 6029.065494848305, 6032.0, 5622.2128901954575, 5899.734511946886, 6077.939220607915, 6148.938510615016, 6197.101420294122], "value": 5101.006762536241, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.88393556075215, 402.8549722100042, 403.2177575503523, 403.6689914270298, 405.588327847235, 5555.527780138693, 6343.904841427382, 6405.647689377082, 6447.258565264996, 6449.0, 4766.307960673963, 5913.763449462016, 6053.614046206704, 6154.2614886213605, 6248.218972628421, 4695.966887284809, 4702.388689470373, 4705.200115980291, 4709.9058018839605, 4728.787204575802, 4105.111648641629, 4405.691601587891, 4691.9765401172945, 4729.4797572267025, 4734.928976065362, 3840.9231815363814, 4060.2894493463673, 4065.4918135233097, 4415.757133357664, 4469.64242860572, 4634.910795962946, 4647.907041859161, 4659.6505262105475, 4668.159731248374, 4698.8355407560575, 3441.328940856509, 4131.814068366931, 4132.752034877917, 4165.271077561415, 4172.436721042681, 5798.362180160179, 5843.561732870052, 5997.970010149965, 6117.134274046414, 6166.352532984017, 4879.853604391874, 5607.710226647853, 5611.382747897728, 5634.830955071355, 5663.745131469093, 5148.4851514848215, 5230.764615592269, 6039.912815693174, 6390.616563006234, 6736.360045795642, 4025.8993525161814, 4122.835086596562, 4531.388262584542, 4665.86002419928, 4708.4349878014855, 6204.751809927642, 7085.929140708578, 7114.893276600855, 7135.108111486064, 7138.714451421937, 4598.494165641777, 4616.446026476777, 4739.199104340329, 4873.6832105913, 4889.65772395936, 4965.255211718199, 4969.0, 4991.750412479361, 4992.600591952635, 4994.200927851526, 4475.865724028285, 4519.909601807945, 5012.423571289275, 5607.663540187602, 5651.802186923438, 6708.563943343667, 6715.294894036154, 6729.528932974743, 6740.831479213059, 6755.4257888080065, 1341.89964229331, 1564.8420169074802, 1576.968460630781, 1577.928993195309, 1582.5806161367248, 991.682661548312, 1030.2479190191202, 1032.5456799008412, 1034.813733527972, 1045.242199405425, 6433.102234840733, 6481.773137940149, 6512.023196520465, 6529.249136349285, 6542.182227221598, 5542.806001789999, 6413.8834184718935, 6756.0, 6805.591664500047, 7045.542039767399, 5216.921746173734, 6176.4294422127305, 6395.616263024233, 6436.645984470805, 6496.642684652389, 3206.711395974327, 3479.9826000869834, 3578.8031658258524, 3643.8178091095338, 3650.7261955352924, 5863.677497737665, 6161.322254551996, 6266.746650669793, 6800.285969973082, 7192.244814294424, 5905.232319798484, 6578.572392794453, 6759.817032019377, 7208.783736487913, 7282.344588987016, 6170.0, 6850.862982740417, 7120.679569419285, 7203.711851525985, 7209.855802883913, 6563.901541476786, 6968.372846443642, 6990.510664253454, 6993.090838241677, 6994.2656021117045, 6557.540972131905, 6707.3292670732535, 6753.459723222229, 6780.135462747784, 6832.829179270558, 6651.667416629246, 7253.202147763847, 7281.1262648482525, 7301.744438944612, 7343.522671026366, 3802.619738026286, 4525.63794896414, 4530.889931966689, 4538.2511885538515, 4541.409616749801, 6658.933410666025, 6952.235254121942, 6999.335063168991, 7030.156381234285, 7036.9296307036275, 6238.814625221194, 6486.562122075307, 6679.799606011828, 6687.929931210982, 6778.4577233822165, 5361.0, 6402.423781859655, 6688.264290928091, 6763.391294783493, 6814.637072585404, 5135.512126347991, 5998.370171131968, 6538.738450462119, 6560.179977502812, 6584.670766461753, 5905.645661260338, 6439.484841212598, 6716.462682985251, 6748.460123190035, 6787.457003439812, 6488.286288508166, 6561.80314590563, 6579.309172536815, 6584.670766461753, 6590.406863382319], "value": 4870.277755189301, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.3477314047108, 725.5102805606216, 737.9077615298088, 741.2550386861201, 741.388354607449, 15758.921205393972, 16452.670946581093, 16590.91704541477, 16620.0, 16642.83357166428, 13228.809407153378, 14300.642483937907, 15329.463468778567, 15329.463468778595, 15374.385024599003, 930.1814403325064, 945.3146468810127, 985.1576901749008, 1021.3310281765456, 1027.3014350241833, 995.8655581496478, 1009.0162091960353, 1012.2155329619567, 1014.1025192704436, 1016.1718199667284, 1056.1550759392494, 1059.3061544688242, 1060.0035966191756, 1068.3803394031481, 1068.5138262090768, 1033.7415646088477, 1053.3521884041297, 1054.430607471968, 1057.508258659723, 1059.5285098131335, 771.6219052664154, 782.3193821375382, 784.7959530522048, 788.3850596534712, 789.159545084489, 16621.168941552995, 16821.327146914107, 16967.0, 16993.83006169947, 17046.891952023077, 14995.100293982396, 15101.848981510155, 15180.468683596131, 15309.311081001382, 16015.718742500572, 9904.702858914245, 11418.60034898783, 11777.705557361049, 11800.684473623867, 12103.576374826927, 2968.7921845470823, 3015.3969206158854, 3026.3493348930087, 3029.1518374855077, 3043.9543406848916, 120472.39763801213, 125846.37076814649, 127563.3621831885, 127769.0, 129292.0, 11203.831942520868, 11622.70943226426, 11707.941460292814, 11720.941395292968, 11763.823542646867, 25512.23463296104, 25665.743342566708, 26060.60909086365, 26131.477370452863, 26173.73826261751, 7897.091834439113, 7950.960245198737, 8173.305269052197, 8203.343732501506, 8349.666013359398, 4221.071364299849, 4234.894127646833, 4327.978360108179, 4373.278409062533, 4390.1000294940095, 3719.2933342664805, 4092.733972291851, 4163.417121602978, 4258.787060646955, 4276.503223871682, 841.9175911252054, 855.1790281329869, 856.9571521423904, 862.4609618988133, 882.594006756899, 488.274911756042, 554.5341912793273, 560.3499940069499, 584.7544031506777, 601.9548533859978, 9475.763105922408, 9652.469114198786, 10335.844962325571, 10342.37945723259, 10496.370217786805, 538.1174873207942, 547.5975158258676, 551.2227758859988, 551.8565173055034, 555.2670474972997, 4638.782891627383, 4767.046749155428, 4827.517248275215, 4883.975580122148, 5180.948190518122, 67870.66064669644, 68133.65933170302, 87856.12143878607, 102770.0, 106858.0, 93870.49528231408, 96821.51589242149, 97568.0, 98915.0, 99253.50373248088, 76526.0, 77158.6142069286, 77812.0, 77966.6101669488, 78396.21603784003, 10172.694819155437, 10793.406362649815, 11137.164712646745, 11186.0, 11236.55053797839, 31090.689093109686, 36678.8166059168, 37190.512379504515, 39322.2135557293, 41313.0, 68897.31102688909, 70014.0, 71790.64104679444, 72008.63995679987, 73140.0, 13592.252426116263, 14047.367868446148, 14352.0, 14391.568252952427, 14748.262586870827, 15262.160581167698, 15396.69206615839, 15412.614684632974, 15467.84532154709, 15963.600909977344, 13779.242141682304, 14000.64998375008, 14103.435862565382, 14312.0, 14721.779173312194, 13970.650733731738, 14025.789613155606, 14086.929565352108, 14555.41778328855, 14790.408383664962, 13635.454581816617, 13880.444782209002, 13929.25582880851, 14461.566153015427, 14750.409983600535, 9735.264760069902, 10079.798404031731, 10257.846132307872, 10261.076503114755, 10374.844377334195, 8619.569021549023, 10362.533685983997, 11176.482260496723, 11492.885071149181, 11502.42487875586], "value": 7782.7963766537905, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1713.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 178.0, 136.0, 182.0, 151.0, 120.0, 123.0, 123.0, 119.0, 121.0], "value": 141.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 103.0, 125.0, 191.0, 161.0, 108.0, 146.0, 153.0, 177.0, 117.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 230.0, 246.0, 251.0, 305.0, 235.0, 217.0, 208.0, 210.0, 217.0], "value": 234.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 63.0, 90.0, 63.0, 62.0, 59.0, 49.0, 92.0, 91.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 88.0, 74.0, 71.0, 74.0, 83.0, 79.0, 57.0, 104.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 92.0, 92.0, 92.0, 90.0, 135.0, 91.0, 113.0, 108.0, 91.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 160.0, 149.0, 161.0, 99.0, 107.0, 100.0, 127.0, 119.0, 171.0], "value": 130.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 104.0, 102.0, 144.0, 143.0, 100.0, 103.0, 131.0, 115.0, 160.0], "value": 120.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 60.0, 64.0, 68.0, 54.0, 52.0, 53.0, 53.0, 53.0, 54.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 69.0, 63.0, 99.0, 53.0, 80.0, 86.0, 85.0, 89.0, 87.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 108.0, 78.0, 107.0, 78.0, 90.0, 104.0, 113.0, 109.0], "value": 96.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 167.0, 185.0, 170.0, 170.0, 136.0, 172.0, 172.0, 221.0, 171.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [233.0, 206.0, 177.0, 237.0, 211.0, 179.0, 258.0, 234.0, 197.0, 206.0], "value": 213.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 76.0, 88.0, 109.0, 69.0, 71.0, 70.0, 72.0], "value": 77.4, "unit": "score"}]}]} 11:14:28 INFO - Return code: 0 11:14:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:14:28 ERROR - # TBPL SUCCESS # 11:14:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:28 INFO - 2017-04-01 11:14:28.468 screenresolution[6619:128190] starting screenresolution argv=screenresolution get 11:14:28 INFO - 2017-04-01 11:14:28.471 screenresolution[6619:128190] Display 0: 1600x1200x32@60 11:14:28 INFO - 2017-04-01 11:14:28.477 screenresolution[6620:128193] starting screenresolution argv=screenresolution list 11:14:28 INFO - Available Modes on Display 0 11:14:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:28 INFO - Intel Iris: 11:14:28 INFO - Chipset Model: Intel Iris 11:14:28 INFO - Type: GPU 11:14:28 INFO - Bus: Built-In 11:14:28 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:28 INFO - Vendor: Intel (0x8086) 11:14:28 INFO - Device ID: 0x0a2e 11:14:28 INFO - Revision ID: 0x0009 11:14:28 INFO - Displays: 11:14:28 INFO - Display: 11:14:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:28 INFO - Display Serial Number: 1600x1200 60 11:14:28 INFO - Main Display: Yes 11:14:28 INFO - Mirror: Off 11:14:28 INFO - Online: Yes 11:14:28 INFO - Rotation: Supported 11:14:28 INFO - Return code: 0 11:14:28 INFO - Running post-action listener: _resource_record_post_action 11:14:28 INFO - [mozharness: 2017-04-01 18:14:28.715202Z] Finished run-tests step (success) 11:14:28 INFO - Running post-run listener: _resource_record_post_run 11:14:28 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 1403904; Write bytes: 517399552; Read time: 18; Write time: 2088 11:14:28 INFO - TinderboxPrint: CPU usage
54.1% 11:14:28 INFO - TinderboxPrint: I/O read bytes / time
1,403,904 / 18 11:14:28 INFO - TinderboxPrint: I/O write bytes / time
517,399,552 / 2,088 11:14:28 INFO - TinderboxPrint: CPU idle
2,208.7 (45.9%) 11:14:28 INFO - TinderboxPrint: CPU system
970.1 (20.2%) 11:14:28 INFO - TinderboxPrint: CPU user
1,635.0 (34.0%) 11:14:28 INFO - TinderboxPrint: Swap in / out
213,536,768 / 0 11:14:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207065600; Write bytes: 204817920; Read time: 15635; Write time: 420 11:14:28 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 1403904; Write bytes: 301522432; Read time: 18; Write time: 1635 11:14:29 INFO - Running post-run listener: _upload_blobber_files 11:14:29 INFO - Blob upload gear active. 11:14:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:29 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 11:14:29 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'] 11:14:29 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 11:14:29 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:14:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:31 INFO - (blobuploader) - INFO - Done attempting. 11:14:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:32 INFO - (blobuploader) - INFO - Done attempting. 11:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:33 INFO - (blobuploader) - INFO - Done attempting. 11:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:35 INFO - (blobuploader) - INFO - Done attempting. 11:14:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:35 INFO - Return code: 0 11:14:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f05e6afbe09526e4cd28b2de9df09978d481c9ba97a8a7e9a6d163a8b7c96a256241a5e6dead009cb24fc82e271fcf573164e5348b02b4445aa7a0cf5770527", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fde82770e85eabea3943671e89c6a816a683138c8bfbccfdceb6098c1146f3c61ac8d1c1c1cbcf39ef55e2e2d999a29e0b8d69a59a34f1355844e061dae3fcc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/666f07bd6a0a362b2eaa27013770f60aee6e83cd01979e289e746b91d9416a219d75c310d2bc6384789c7ade49633a69aa34c78239e9eb9b6d3f6cb83505b03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd892c6e08dd97a385ca4ce518abbeee9f61f0f74db080d591e935a4388f019d76a432898bddd852b74a1ebd9726c4aef4728f441f1425fecb457924255ad106"} 11:14:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:35 INFO - Contents: 11:14:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f05e6afbe09526e4cd28b2de9df09978d481c9ba97a8a7e9a6d163a8b7c96a256241a5e6dead009cb24fc82e271fcf573164e5348b02b4445aa7a0cf5770527", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fde82770e85eabea3943671e89c6a816a683138c8bfbccfdceb6098c1146f3c61ac8d1c1c1cbcf39ef55e2e2d999a29e0b8d69a59a34f1355844e061dae3fcc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/666f07bd6a0a362b2eaa27013770f60aee6e83cd01979e289e746b91d9416a219d75c310d2bc6384789c7ade49633a69aa34c78239e9eb9b6d3f6cb83505b03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd892c6e08dd97a385ca4ce518abbeee9f61f0f74db080d591e935a4388f019d76a432898bddd852b74a1ebd9726c4aef4728f441f1425fecb457924255ad106"} 11:14:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:35 INFO - Copying logs to upload dir... 11:14:35 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.688143 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-01 11:14:35.525075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:35.528357) ========= 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.lAbfRi41bA/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.fZ7z6An3v7/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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/3f05e6afbe09526e4cd28b2de9df09978d481c9ba97a8a7e9a6d163a8b7c96a256241a5e6dead009cb24fc82e271fcf573164e5348b02b4445aa7a0cf5770527", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fde82770e85eabea3943671e89c6a816a683138c8bfbccfdceb6098c1146f3c61ac8d1c1c1cbcf39ef55e2e2d999a29e0b8d69a59a34f1355844e061dae3fcc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/666f07bd6a0a362b2eaa27013770f60aee6e83cd01979e289e746b91d9416a219d75c310d2bc6384789c7ade49633a69aa34c78239e9eb9b6d3f6cb83505b03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd892c6e08dd97a385ca4ce518abbeee9f61f0f74db080d591e935a4388f019d76a432898bddd852b74a1ebd9726c4aef4728f441f1425fecb457924255ad106"} build_url:https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/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/3f05e6afbe09526e4cd28b2de9df09978d481c9ba97a8a7e9a6d163a8b7c96a256241a5e6dead009cb24fc82e271fcf573164e5348b02b4445aa7a0cf5770527", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fde82770e85eabea3943671e89c6a816a683138c8bfbccfdceb6098c1146f3c61ac8d1c1c1cbcf39ef55e2e2d999a29e0b8d69a59a34f1355844e061dae3fcc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/666f07bd6a0a362b2eaa27013770f60aee6e83cd01979e289e746b91d9416a219d75c310d2bc6384789c7ade49633a69aa34c78239e9eb9b6d3f6cb83505b03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd892c6e08dd97a385ca4ce518abbeee9f61f0f74db080d591e935a4388f019d76a432898bddd852b74a1ebd9726c4aef4728f441f1425fecb457924255ad106"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:35.563981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:35.564336) ========= 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.lAbfRi41bA/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.fZ7z6An3v7/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005552 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:35.612878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 11:14:35.613195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 11:14:35.613546) ========= ========= Total master_lag: 0.25 =========