builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0354 starttime: 1482267281.69 results: success (0) buildid: 20161220114253 builduid: 9575e87b407a436aaaed81bd4e774fb6 revision: 7083c0d30e75fc102c715887af9faec933e936f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.692893) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.693295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.693563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.719275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.719583) ========= 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.8OFuYmTAre/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.WOcPvKfYpu/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 --2016-12-20 12:54:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2016-12-20 12:54:41 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.894000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.894346) ========= 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.8OFuYmTAre/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.WOcPvKfYpu/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.019733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:41.945319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-20 12:54:41.945651) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7083c0d30e75fc102c715887af9faec933e936f8 --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 7083c0d30e75fc102c715887af9faec933e936f8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8OFuYmTAre/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.WOcPvKfYpu/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 2016-12-20 12:54:42,033 truncating revision to first 12 chars 2016-12-20 12:54:42,033 Setting DEBUG logging. 2016-12-20 12:54:42,033 attempt 1/10 2016-12-20 12:54:42,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7083c0d30e75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 12:54:43,947 unpacking tar archive at: mozilla-central-7083c0d30e75/testing/mozharness/ program finished with exit code 0 elapsedTime=2.177075 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-20 12:54:44.148804) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:44.149135) ========= script_repo_revision: 7083c0d30e75fc102c715887af9faec933e936f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:44.149511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:44.149781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:44.170294) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-20 12:54:44.170930) ========= /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.8OFuYmTAre/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.WOcPvKfYpu/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:54:44 INFO - MultiFileLogger online at 20161220 12:54:44 in /builds/slave/test 12:54:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:54:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:44 INFO - {'append_to_log': False, 12:54:44 INFO - 'base_work_dir': '/builds/slave/test', 12:54:44 INFO - 'blob_upload_branch': 'Firefox', 12:54:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:44 INFO - 'branch': 'Firefox', 12:54:44 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:44 INFO - 'config_files': ('talos/mac_config.py',), 12:54:44 INFO - 'default_actions': ('clobber', 12:54:44 INFO - 'read-buildbot-config', 12:54:44 INFO - 'download-and-extract', 12:54:44 INFO - 'populate-webroot', 12:54:44 INFO - 'create-virtualenv', 12:54:44 INFO - 'install', 12:54:44 INFO - 'run-tests'), 12:54:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:44 INFO - 'download_minidump_stackwalk': True, 12:54:44 INFO - 'download_symbols': 'ondemand', 12:54:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:44 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:44 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:44 INFO - 'installer_path': 'installer.exe', 12:54:44 INFO - 'log_level': 'info', 12:54:44 INFO - 'log_name': 'talos', 12:54:44 INFO - 'log_to_console': True, 12:54:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:54:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:54:44 INFO - 'opt_config_files': (), 12:54:44 INFO - 'pip_index': False, 12:54:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:54:44 INFO - 'cmd': ('bash', 12:54:44 INFO - '-c', 12:54:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:54:44 INFO - 'enabled': True, 12:54:44 INFO - 'halt_on_failure': False, 12:54:44 INFO - 'name': 'check_screen_resolution'},), 12:54:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:54:44 INFO - 'cmd': ('bash', 12:54:44 INFO - '-c', 12:54:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:54:44 INFO - 'enabled': True, 12:54:44 INFO - 'halt_on_failure': False, 12:54:44 INFO - 'name': 'check_screen_resolution'},), 12:54:44 INFO - 'run_cmd_checks_enabled': True, 12:54:44 INFO - 'sps_profile': False, 12:54:44 INFO - 'sps_profile_interval': 0, 12:54:44 INFO - 'suite': 'dromaeojs-e10s', 12:54:44 INFO - 'system_bits': '32', 12:54:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:44 INFO - 'title': 't-yosemite-r7-0354', 12:54:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:44 INFO - 'use_talos_json': True, 12:54:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:44 INFO - 'work_dir': 'build'} 12:54:44 INFO - [mozharness: 2016-12-20 20:54:44.371610Z] Running clobber step. 12:54:44 INFO - Running pre-action listener: _resource_record_pre_action 12:54:44 INFO - Running main action method: clobber 12:54:44 INFO - rmtree: /builds/slave/test/build 12:54:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:45 INFO - Running post-action listener: _resource_record_post_action 12:54:45 INFO - [mozharness: 2016-12-20 20:54:45.854610Z] Finished clobber step (success) 12:54:45 INFO - [mozharness: 2016-12-20 20:54:45.854687Z] Running read-buildbot-config step. 12:54:45 INFO - Running pre-action listener: _resource_record_pre_action 12:54:45 INFO - Running main action method: read_buildbot_config 12:54:45 INFO - Using buildbot properties: 12:54:45 INFO - { 12:54:45 INFO - "project": "", 12:54:45 INFO - "product": "firefox", 12:54:45 INFO - "script_repo_revision": "production", 12:54:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:54:45 INFO - "repository": "", 12:54:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:54:45 INFO - "buildid": "20161220114253", 12:54:45 INFO - "pgo_build": "False", 12:54:45 INFO - "basedir": "/builds/slave/test", 12:54:45 INFO - "buildnumber": 35, 12:54:45 INFO - "slavename": "t-yosemite-r7-0354", 12:54:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:54:45 INFO - "platform": "yosemite_r7", 12:54:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:54:45 INFO - "branch": "mozilla-central", 12:54:45 INFO - "repo_path": "mozilla-central", 12:54:45 INFO - "revision": "7083c0d30e75fc102c715887af9faec933e936f8", 12:54:45 INFO - "stage_platform": "macosx64", 12:54:45 INFO - "builduid": "9575e87b407a436aaaed81bd4e774fb6", 12:54:45 INFO - "slavebuilddir": "test" 12:54:45 INFO - } 12:54:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:54:45 INFO - Running post-action listener: _resource_record_post_action 12:54:45 INFO - [mozharness: 2016-12-20 20:54:45.858937Z] Finished read-buildbot-config step (success) 12:54:45 INFO - [mozharness: 2016-12-20 20:54:45.859035Z] Running download-and-extract step. 12:54:45 INFO - Running pre-action listener: _resource_record_pre_action 12:54:45 INFO - Running main action method: download_and_extract 12:54:45 INFO - mkdir: /builds/slave/test/build/tests 12: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')]} 12:54:45 INFO - trying https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:54:45 INFO - Downloading https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:54:46 INFO - Downloaded 1199 bytes. 12:54:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:54:46 INFO - Using the following test package requirements: 12:54:46 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:54:46 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:54:46 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:54:46 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'jsshell-mac.zip'], 12:54:46 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:54:46 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:54:46 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:54:46 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:54:46 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:54:46 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:54:46 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:54:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:54:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:54:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:54:46 INFO - Fetch https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:54:47 INFO - Expected file size: 16281425 12:54:47 INFO - Obtained file size: 16281425 12:54:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:54:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:54:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:54:54 INFO - Fetch https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:54:55 INFO - Expected file size: 16281425 12:54:55 INFO - Obtained file size: 16281425 12:55:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:55:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:55:01 INFO - Fetch https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:55:03 INFO - Expected file size: 14409734 12:55:03 INFO - Obtained file size: 14409734 12:55:03 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')]} 12:55:03 INFO - trying https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:55:03 INFO - Downloading https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:55:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:55:06 INFO - Downloaded 69607784 bytes. 12:55:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:55:06 INFO - mkdir: /builds/slave/test/properties 12:55:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:55:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:55:06 INFO - Contents: 12:55:06 INFO - build_url:https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:55:07 INFO - Running post-action listener: _resource_record_post_action 12:55:07 INFO - Running post-action listener: set_extra_try_arguments 12:55:07 INFO - [mozharness: 2016-12-20 20:55:07.130951Z] Finished download-and-extract step (success) 12:55:07 INFO - [mozharness: 2016-12-20 20:55:07.131087Z] Running populate-webroot step. 12:55:07 INFO - Running pre-action listener: _resource_record_pre_action 12:55:07 INFO - Running main action method: populate_webroot 12:55:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:55:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:55:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:55:07 INFO - '--tppagecycles', 12:55:07 INFO - '7'], 12:55:07 INFO - 'tests': ['tsvgm']}}, 12:55:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:55:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:55:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:55:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:55:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['damp', 'tps']}, 12:55:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'tests': ['damp', 'tps']}, 12:55:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['dromaeo_dom']}, 12:55:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:55:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['basic_compositor_video']}, 12:55:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:55:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['a11yr', 12:55:07 INFO - 'ts_paint', 12:55:07 INFO - 'tpaint', 12:55:07 INFO - 'sessionrestore', 12:55:07 INFO - 'sessionrestore_no_auto_restore', 12:55:07 INFO - 'tabpaint']}, 12:55:07 INFO - 'other-e10s': {'tests': ['a11yr', 12:55:07 INFO - 'ts_paint', 12:55:07 INFO - 'tpaint', 12:55:07 INFO - 'sessionrestore', 12:55:07 INFO - 'sessionrestore_no_auto_restore', 12:55:07 INFO - 'tabpaint']}, 12:55:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:55:07 INFO - 'ts_paint', 12:55:07 INFO - 'tpaint', 12:55:07 INFO - 'sessionrestore', 12:55:07 INFO - 'sessionrestore_no_auto_restore', 12:55:07 INFO - 'tabpaint']}, 12:55:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:55:07 INFO - 'ts_paint', 12:55:07 INFO - 'tpaint', 12:55:07 INFO - 'sessionrestore', 12:55:07 INFO - 'sessionrestore_no_auto_restore', 12:55:07 INFO - 'tabpaint']}, 12:55:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['a11yr', 12:55:07 INFO - 'ts_paint', 12:55:07 INFO - 'tpaint', 12:55:07 INFO - 'sessionrestore', 12:55:07 INFO - 'sessionrestore_no_auto_restore', 12:55:07 INFO - 'tabpaint']}, 12:55:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['a11yr', 12:55:07 INFO - 'ts_paint', 12:55:07 INFO - 'tpaint', 12:55:07 INFO - 'sessionrestore', 12:55:07 INFO - 'sessionrestore_no_auto_restore', 12:55:07 INFO - 'tabpaint']}, 12:55:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['tsvgx', 12:55:07 INFO - 'tsvgr_opacity', 12:55:07 INFO - 'tart', 12:55:07 INFO - 'tscrollx', 12:55:07 INFO - 'cart', 12:55:07 INFO - 'tsvg_static']}, 12:55:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:55:07 INFO - 'tsvgr_opacity', 12:55:07 INFO - 'tart', 12:55:07 INFO - 'tscrollx', 12:55:07 INFO - 'cart', 12:55:07 INFO - 'tsvg_static']}, 12:55:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'talos_options': ['--disable-e10s'], 12:55:07 INFO - 'tests': ['tp5o']}, 12:55:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:55:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'talos_options': ['--disable-e10s', 12:55:07 INFO - '--xperf_path', 12:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:07 INFO - 'tests': ['tp5n']}, 12:55:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:55:07 INFO - 'talos_options': ['--xperf_path', 12:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:07 INFO - 'tests': ['tp5n']}}, 12:55:07 INFO - 'talos.zip': {'path': '', 12:55:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:55:07 INFO - Running post-action listener: _resource_record_post_action 12:55:07 INFO - [mozharness: 2016-12-20 20:55:07.149661Z] Finished populate-webroot step (success) 12:55:07 INFO - [mozharness: 2016-12-20 20:55:07.149781Z] Running create-virtualenv step. 12:55:07 INFO - Running pre-action listener: _resource_record_pre_action 12:55:07 INFO - Running main action method: create_virtualenv 12:55:07 INFO - Creating virtualenv /builds/slave/test/build/venv 12:55:07 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 12:55:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:55:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:55:07 INFO - Using real prefix '/tools/python27' 12:55:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:55:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:55:10 INFO - Installing pip.................done. 12:55:10 INFO - Return code: 0 12:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:55:11 INFO - Reading from file tmpfile_stdout 12:55:11 INFO - Output received: 12:55:11 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) 12:55:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:11 INFO - 'HOME': '/Users/cltbld', 12:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:11 INFO - 'LOGNAME': 'cltbld', 12:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:11 INFO - 'MOZ_NO_REMOTE': '1', 12:55:11 INFO - 'NO_EM_RESTART': '1', 12:55:11 INFO - 'PAGER': '/bin/cat', 12:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:11 INFO - 'PWD': '/builds/slave/test', 12:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:11 INFO - 'SHELL': '/bin/bash', 12:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:11 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:11 INFO - 'USER': 'cltbld', 12:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:11 INFO - 'XPC_FLAGS': '0x0', 12:55:11 INFO - 'XPC_SERVICE_NAME': '0', 12:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:11 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 12:55:11 INFO - Cleaning up... 12:55:11 INFO - Return code: 0 12:55:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:11 INFO - 'HOME': '/Users/cltbld', 12:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:11 INFO - 'LOGNAME': 'cltbld', 12:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:11 INFO - 'MOZ_NO_REMOTE': '1', 12:55:11 INFO - 'NO_EM_RESTART': '1', 12:55:11 INFO - 'PAGER': '/bin/cat', 12:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:11 INFO - 'PWD': '/builds/slave/test', 12:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:11 INFO - 'SHELL': '/bin/bash', 12:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:11 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:11 INFO - 'USER': 'cltbld', 12:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:11 INFO - 'XPC_FLAGS': '0x0', 12:55:11 INFO - 'XPC_SERVICE_NAME': '0', 12:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:11 INFO - Downloading/unpacking psutil>=3.1.1 12:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:15 INFO - Installing collected packages: psutil 12:55:15 INFO - Running setup.py install for psutil 12:55:15 INFO - building 'psutil._psutil_osx' extension 12:55:15 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 12:55:15 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 12:55:15 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 12:55:15 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 12:55:15 INFO - building 'psutil._psutil_posix' extension 12:55:15 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 12:55:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:55:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:55:15 INFO - ^ 12:55:15 INFO - 1 warning generated. 12:55:15 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 12:55:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:16 INFO - Successfully installed psutil 12:55:16 INFO - Cleaning up... 12:55:16 INFO - Return code: 0 12:55:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:55:16 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')]} 12:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:16 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')]} 12:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:16 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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:16 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 12:55:16 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 12:55:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:16 INFO - 'HOME': '/Users/cltbld', 12:55:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:16 INFO - 'LOGNAME': 'cltbld', 12:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:16 INFO - 'MOZ_NO_REMOTE': '1', 12:55:16 INFO - 'NO_EM_RESTART': '1', 12:55:16 INFO - 'PAGER': '/bin/cat', 12:55:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:16 INFO - 'PWD': '/builds/slave/test', 12:55:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:16 INFO - 'SHELL': '/bin/bash', 12:55:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:16 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:16 INFO - 'USER': 'cltbld', 12:55:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:16 INFO - 'XPC_FLAGS': '0x0', 12:55:16 INFO - 'XPC_SERVICE_NAME': '0', 12:55:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:55:16 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 12:55:16 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 12:55:16 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 12:55:16 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 12:55:16 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 12:55:16 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 12:55:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:55:19 INFO - Installing collected packages: mozsystemmonitor 12:55:19 INFO - Running setup.py install for mozsystemmonitor 12:55:19 INFO - Successfully installed mozsystemmonitor 12:55:19 INFO - Cleaning up... 12:55:19 INFO - Return code: 0 12:55:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:19 INFO - 'HOME': '/Users/cltbld', 12:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:19 INFO - 'LOGNAME': 'cltbld', 12:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:19 INFO - 'MOZ_NO_REMOTE': '1', 12:55:19 INFO - 'NO_EM_RESTART': '1', 12:55:19 INFO - 'PAGER': '/bin/cat', 12:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:19 INFO - 'PWD': '/builds/slave/test', 12:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:19 INFO - 'SHELL': '/bin/bash', 12:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:19 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:19 INFO - 'USER': 'cltbld', 12:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:19 INFO - 'XPC_FLAGS': '0x0', 12:55:19 INFO - 'XPC_SERVICE_NAME': '0', 12:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:19 INFO - Downloading/unpacking jsonschema==2.5.1 12:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:55:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:22 INFO - Downloading functools32-3.2.3-2.tar.gz 12:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:55:22 INFO - warning: no files found matching '*.txt' 12:55:22 INFO - no previously-included directories found matching 'build' 12:55:22 INFO - no previously-included directories found matching 'dist' 12:55:22 INFO - no previously-included directories found matching '.git*' 12:55:22 INFO - Installing collected packages: jsonschema, functools32 12:55:22 INFO - Running setup.py install for functools32 12:55:22 INFO - warning: no files found matching '*.txt' 12:55:22 INFO - no previously-included directories found matching 'build' 12:55:22 INFO - no previously-included directories found matching 'dist' 12:55:22 INFO - no previously-included directories found matching '.git*' 12:55:22 INFO - Successfully installed jsonschema functools32 12:55:22 INFO - Cleaning up... 12:55:22 INFO - Return code: 0 12:55:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:22 INFO - 'HOME': '/Users/cltbld', 12:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:22 INFO - 'LOGNAME': 'cltbld', 12:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:22 INFO - 'MOZ_NO_REMOTE': '1', 12:55:22 INFO - 'NO_EM_RESTART': '1', 12:55:22 INFO - 'PAGER': '/bin/cat', 12:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:22 INFO - 'PWD': '/builds/slave/test', 12:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:22 INFO - 'SHELL': '/bin/bash', 12:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:22 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:22 INFO - 'USER': 'cltbld', 12:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:22 INFO - 'XPC_FLAGS': '0x0', 12:55:22 INFO - 'XPC_SERVICE_NAME': '0', 12:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:55:23 INFO - Cleaning up... 12:55:23 INFO - Return code: 0 12:55:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:23 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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:23 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 12:55:23 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 12:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:23 INFO - 'HOME': '/Users/cltbld', 12:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:23 INFO - 'LOGNAME': 'cltbld', 12:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:23 INFO - 'MOZ_NO_REMOTE': '1', 12:55:23 INFO - 'NO_EM_RESTART': '1', 12:55:23 INFO - 'PAGER': '/bin/cat', 12:55:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:23 INFO - 'PWD': '/builds/slave/test', 12:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:23 INFO - 'SHELL': '/bin/bash', 12:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:23 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:23 INFO - 'USER': 'cltbld', 12:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:23 INFO - 'XPC_FLAGS': '0x0', 12:55:23 INFO - 'XPC_SERVICE_NAME': '0', 12:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:23 INFO - Downloading/unpacking blobuploader==1.2.4 12:55:23 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 12:55:23 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 12:55:23 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 12:55:23 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 12:55:23 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 12:55:23 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 12:55:26 INFO - Downloading blobuploader-1.2.4.tar.gz 12:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:55:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:55:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 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 12:55:26 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 12:55:27 INFO - Downloading docopt-0.6.1.tar.gz 12:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:55:27 INFO - Installing collected packages: blobuploader, requests, docopt 12:55:27 INFO - Running setup.py install for blobuploader 12:55:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:55:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:55:27 INFO - Running setup.py install for requests 12:55:28 INFO - Running setup.py install for docopt 12:55:28 INFO - Successfully installed blobuploader requests docopt 12:55:28 INFO - Cleaning up... 12:55:28 INFO - Return code: 0 12:55:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:28 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')]} 12:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:28 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')]} 12:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:28 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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:28 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 12:55:28 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 12:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:28 INFO - 'HOME': '/Users/cltbld', 12:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:28 INFO - 'LOGNAME': 'cltbld', 12:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:28 INFO - 'MOZ_NO_REMOTE': '1', 12:55:28 INFO - 'NO_EM_RESTART': '1', 12:55:28 INFO - 'PAGER': '/bin/cat', 12:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:28 INFO - 'PWD': '/builds/slave/test', 12:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:28 INFO - 'SHELL': '/bin/bash', 12:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:28 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:28 INFO - 'USER': 'cltbld', 12:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:28 INFO - 'XPC_FLAGS': '0x0', 12:55:28 INFO - 'XPC_SERVICE_NAME': '0', 12:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Gkl56r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Spo20_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-4PNMaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-VdxE4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-lUVkkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-LINSt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-mB89UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-HzM6El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-hV3Tbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-JUC4pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Y7vvIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-6yvzI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-_wjDzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-GggK28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-01cVDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-l0INIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-uQQVCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:55:30 INFO - Running setup.py install for manifestparser 12:55:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:55:30 INFO - Running setup.py install for mozcrash 12:55:30 INFO - Running setup.py install for mozdebug 12:55:30 INFO - Running setup.py install for mozdevice 12:55:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:55:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Running setup.py install for mozfile 12:55:31 INFO - Running setup.py install for mozhttpd 12:55:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Running setup.py install for mozinfo 12:55:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Running setup.py install for mozInstall 12:55:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Running setup.py install for mozleak 12:55:31 INFO - Running setup.py install for mozlog 12:55:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:55:31 INFO - Running setup.py install for moznetwork 12:55:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:55:32 INFO - Running setup.py install for mozprocess 12:55:32 INFO - Running setup.py install for mozprofile 12:55:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:55:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:55:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:55:32 INFO - Running setup.py install for mozrunner 12:55:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:55:32 INFO - Running setup.py install for mozscreenshot 12:55:32 INFO - Running setup.py install for moztest 12:55:32 INFO - Running setup.py install for mozversion 12:55:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:55:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:32 INFO - Cleaning up... 12:55:32 INFO - Return code: 0 12:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:32 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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:32 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 12:55:32 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 12:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:32 INFO - 'HOME': '/Users/cltbld', 12:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:32 INFO - 'LOGNAME': 'cltbld', 12:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:32 INFO - 'MOZ_NO_REMOTE': '1', 12:55:32 INFO - 'NO_EM_RESTART': '1', 12:55:32 INFO - 'PAGER': '/bin/cat', 12:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:32 INFO - 'PWD': '/builds/slave/test', 12:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:32 INFO - 'SHELL': '/bin/bash', 12:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:32 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:32 INFO - 'USER': 'cltbld', 12:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:32 INFO - 'XPC_FLAGS': '0x0', 12:55:32 INFO - 'XPC_SERVICE_NAME': '0', 12:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-GOBQXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-XyiwN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-ONhS9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-i2ugYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-OAtPIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-EAbSS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5unYNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:33 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)) 12:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:33 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-AA923t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-gafgJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Um2FtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-eu0s8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-SwuVlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-OdyYR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-waKVGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-PivzUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:34 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-qISYnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 12:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:34 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5gg8IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:35 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)) 12:55:35 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)) 12:55:35 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)) 12:55:35 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)) 12:55:35 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)) 12:55:35 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)) 12:55:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:35 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 12:55:35 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 12:55:35 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 12:55:35 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 12:55:35 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 12:55:35 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 12:55:37 INFO - Downloading blessings-1.6.tar.gz 12:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:37 INFO - Installing collected packages: blessings 12:55:37 INFO - Running setup.py install for blessings 12:55:37 INFO - Successfully installed blessings 12:55:37 INFO - Cleaning up... 12:55:38 INFO - Return code: 0 12:55:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:38 INFO - Reading from file tmpfile_stdout 12:55:38 INFO - Current package versions: 12:55:38 INFO - blessings == 1.6 12:55:38 INFO - blobuploader == 1.2.4 12:55:38 INFO - docopt == 0.6.1 12:55:38 INFO - functools32 == 3.2.3-2 12:55:38 INFO - jsonschema == 2.5.1 12:55:38 INFO - manifestparser == 1.1 12:55:38 INFO - mozInstall == 1.12 12:55:38 INFO - mozcrash == 1.0 12:55:38 INFO - mozdebug == 0.1 12:55:38 INFO - mozdevice == 0.49 12:55:38 INFO - mozfile == 1.2 12:55:38 INFO - mozhttpd == 0.7 12:55:38 INFO - mozinfo == 0.9 12:55:38 INFO - mozleak == 0.1 12:55:38 INFO - mozlog == 3.4 12:55:38 INFO - moznetwork == 0.27 12:55:38 INFO - mozprocess == 0.23 12:55:38 INFO - mozprofile == 0.28 12:55:38 INFO - mozrunner == 6.13 12:55:38 INFO - mozscreenshot == 0.1 12:55:38 INFO - mozsystemmonitor == 0.3 12:55:38 INFO - moztest == 0.7 12:55:38 INFO - mozversion == 1.4 12:55:38 INFO - psutil == 3.1.1 12:55:38 INFO - requests == 1.2.3 12:55:38 INFO - wsgiref == 0.1.2 12:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:38 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')]} 12:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:38 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')]} 12:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:39 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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:39 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 12:55:39 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 12:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:39 INFO - 'HOME': '/Users/cltbld', 12:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:39 INFO - 'LOGNAME': 'cltbld', 12:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:39 INFO - 'MOZ_NO_REMOTE': '1', 12:55:39 INFO - 'NO_EM_RESTART': '1', 12:55:39 INFO - 'PAGER': '/bin/cat', 12:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:39 INFO - 'PWD': '/builds/slave/test', 12:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:39 INFO - 'SHELL': '/bin/bash', 12:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:39 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:39 INFO - 'USER': 'cltbld', 12:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:39 INFO - 'XPC_FLAGS': '0x0', 12:55:39 INFO - 'XPC_SERVICE_NAME': '0', 12:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 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)) 12:55:39 INFO - Cleaning up... 12:55:39 INFO - Return code: 0 12:55:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:39 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 0x1019fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b94b30c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, '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.8OFuYmTAre/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.WOcPvKfYpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 12:55:39 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 12:55:39 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 12:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:39 INFO - 'HOME': '/Users/cltbld', 12:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:39 INFO - 'LOGNAME': 'cltbld', 12:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:39 INFO - 'MOZ_NO_REMOTE': '1', 12:55:39 INFO - 'NO_EM_RESTART': '1', 12:55:39 INFO - 'PAGER': '/bin/cat', 12:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:39 INFO - 'PWD': '/builds/slave/test', 12:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:39 INFO - 'SHELL': '/bin/bash', 12:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:55:39 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:39 INFO - 'USER': 'cltbld', 12:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:39 INFO - 'XPC_FLAGS': '0x0', 12:55:39 INFO - 'XPC_SERVICE_NAME': '0', 12:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:55:40 INFO - Cleaning up... 12:55:40 INFO - Return code: 0 12:55:40 INFO - Running post-action listener: _resource_record_post_action 12:55:40 INFO - Running post-action listener: _start_resource_monitoring 12:55:40 INFO - Starting resource monitoring. 12:55:40 INFO - [mozharness: 2016-12-20 20:55:40.192838Z] Finished create-virtualenv step (success) 12:55:40 INFO - [mozharness: 2016-12-20 20:55:40.193836Z] Running install step. 12:55:40 INFO - Running pre-action listener: _resource_record_pre_action 12:55:40 INFO - Running main action method: install 12:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:40 INFO - Reading from file tmpfile_stdout 12:55:40 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:40 INFO - Reading from file tmpfile_stdout 12:55:40 INFO - Output received: 12:55:40 INFO - Usage: mozinstall [options] installer 12:55:40 INFO - Options: 12:55:40 INFO - -h, --help show this help message and exit 12:55:40 INFO - -d DEST, --destination=DEST 12:55:40 INFO - Directory to install application into. [default: 12:55:40 INFO - "/builds/slave/test"] 12:55:40 INFO - --app=APP Application being installed. [default: firefox] 12:55:40 INFO - mkdir: /builds/slave/test/build/application 12:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:56:02 INFO - Reading from file tmpfile_stdout 12:56:02 INFO - Output received: 12:56:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:56:02 INFO - Running post-action listener: _resource_record_post_action 12:56:02 INFO - [mozharness: 2016-12-20 20:56:02.268061Z] Finished install step (success) 12:56:02 INFO - [mozharness: 2016-12-20 20:56:02.268199Z] Running run-tests step. 12:56:02 INFO - Running pre-action listener: _resource_record_pre_action 12:56:02 INFO - Running main action method: run_tests 12:56:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:56:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:56:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:56:02 INFO - 2016-12-20 12:56:02.282 screenresolution[1906:19582] starting screenresolution argv=screenresolution get 12:56:02 INFO - 2016-12-20 12:56:02.284 screenresolution[1906:19582] Display 0: 1600x1200x32@60 12:56:02 INFO - 2016-12-20 12:56:02.290 screenresolution[1907:19584] starting screenresolution argv=screenresolution list 12:56:02 INFO - Available Modes on Display 0 12:56:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:56:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:56:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:56:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:56:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:56:02 INFO - Intel Iris: 12:56:02 INFO - Chipset Model: Intel Iris 12:56:02 INFO - Type: GPU 12:56:02 INFO - Bus: Built-In 12:56:02 INFO - VRAM (Dynamic, Max): 1536 MB 12:56:02 INFO - Vendor: Intel (0x8086) 12:56:02 INFO - Device ID: 0x0a2e 12:56:02 INFO - Revision ID: 0x0009 12:56:02 INFO - Displays: 12:56:02 INFO - Display: 12:56:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:56:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:56:02 INFO - Display Serial Number: 1600x1200 60 12:56:02 INFO - Main Display: Yes 12:56:02 INFO - Mirror: Off 12:56:02 INFO - Online: Yes 12:56:02 INFO - Rotation: Supported 12:56:02 INFO - Return code: 0 12:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:56:02 INFO - Python 2.7.3 12:56:02 INFO - Return code: 0 12:56:02 INFO - grabbing minidump binary from tooltool 12:56: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')]} 12:56:02 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 0x1017d9d30>, '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 0x101700db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017cebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:56:02 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 12:56:02 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 12:56:02 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 12:56:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:56:02 INFO - Return code: 0 12:56:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:56:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:56:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:56:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:56:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:56:02 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/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--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 12:56:02 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/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --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 12:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8OFuYmTAre/Render', 12:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:56:02 INFO - 'HOME': '/Users/cltbld', 12:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:56:02 INFO - 'LOGNAME': 'cltbld', 12:56:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:56:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:02 INFO - 'MOZ_NO_REMOTE': '1', 12:56:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:56:02 INFO - 'NO_EM_RESTART': '1', 12:56:02 INFO - 'PAGER': '/bin/cat', 12:56:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:02 INFO - 'PWD': '/builds/slave/test', 12:56:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:56:02 INFO - 'SHELL': '/bin/bash', 12:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WOcPvKfYpu/Listeners', 12:56:02 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 12:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:56:02 INFO - 'USER': 'cltbld', 12:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:02 INFO - 'XPC_FLAGS': '0x0', 12:56:02 INFO - 'XPC_SERVICE_NAME': '0', 12:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:56:02 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/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--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 12:56:02 INFO - mozversion application_buildid: 20161220114253 12:56:02 INFO - mozversion application_changeset: 7083c0d30e75fc102c715887af9faec933e936f8 12:56:02 INFO - mozversion application_display_name: Nightly 12:56:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:56:02 INFO - mozversion application_name: Firefox 12:56:02 INFO - mozversion application_remotingname: firefox 12:56:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:56:02 INFO - mozversion application_vendor: Mozilla 12:56:02 INFO - mozversion application_version: 53.0a1 12:56:02 INFO - mozversion platform_buildid: 20161220114253 12:56:02 INFO - mozversion platform_changeset: 7083c0d30e75fc102c715887af9faec933e936f8 12:56:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:56:02 INFO - mozversion platform_version: 53.0a1 12:56:02 INFO - using testdate: 1482267362 12:56:02 INFO - actual date: 1482267362 12:56:02 INFO - starting webserver on 'localhost:55662' 12:56:02 INFO - SUITE-START | Running 2 tests 12:56:02 INFO - TEST-START | dromaeo_css 12:56:02 INFO - operating with platform_type : mac_ 12:56:02 INFO - Initialising browser for dromaeo_css test... 12:56:02 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpUVMmZG/profile http://localhost:55662/getInfo.html) 12:56:05 INFO - PROCESS | 1917 | 2016-12-20 12:56:05.611 plugin-container[1919:19739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494b, name = 'com.apple.tsm.portname' 12:56:05 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:56:05 INFO - PROCESS | 1917 | 2016-12-20 12:56:05.613 plugin-container[1919:19739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c17, name = 'com.apple.CFPasteboardClient' 12:56:05 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:56:05 INFO - PROCESS | 1917 | 2016-12-20 12:56:05.613 plugin-container[1919:19739] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:56:05 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 12:56:05 INFO - PROCESS | 1917 | colorDepth:24 12:56:05 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 12:56:05 INFO - PROCESS | 1917 | __metrics 12:56:05 ERROR - PROCESS | 1917 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 12:56:06 INFO - TEST-INFO | 1917: exit 0 12:56:06 INFO - Browser initialized. 12:56:06 INFO - Running cycle 1/1 for dromaeo_css test... 12:56:06 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpUVMmZG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:56:08 INFO - PROCESS | 1920 | 2016-12-20 12:56:08.770 plugin-container[1921:19860] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 12:56:08 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:56:08 INFO - PROCESS | 1920 | 2016-12-20 12:56:08.771 plugin-container[1921:19860] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481b, name = 'com.apple.CFPasteboardClient' 12:56:08 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:56:08 INFO - PROCESS | 1920 | 2016-12-20 12:56:08.771 plugin-container[1921:19860] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:56:18 INFO - PROCESS | 1920 | RSS: Main: 234524672 12:56:18 INFO - PROCESS | 1920 | 12:57:08 INFO - PROCESS | 1920 | 1482267428219 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:59:22 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55662/tests/dromaeo/cssquery-ext.html) 12:59:24 INFO - PROCESS | 1920 | RSS: Main: 250028032 12:59:24 INFO - PROCESS | 1920 | 13:02:26 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-ext.html (next: http://localhost:55662/tests/dromaeo/cssquery-jquery.html) 13:02:27 INFO - PROCESS | 1920 | RSS: Main: 262496256 13:02:27 INFO - PROCESS | 1920 | 13:05:29 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55662/tests/dromaeo/cssquery-mootools.html) 13:05:29 INFO - PROCESS | 1920 | RSS: Main: 267808768 13:05:29 INFO - PROCESS | 1920 | 13:08:31 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55662/tests/dromaeo/cssquery-prototype.html) 13:08:32 INFO - PROCESS | 1920 | RSS: Main: 266665984 13:08:32 INFO - PROCESS | 1920 | 13:11:35 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55662/tests/dromaeo/cssquery-yui.html) 13:11:35 INFO - PROCESS | 1920 | RSS: Main: 272039936 13:11:35 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:55662/tests/dromaeo/cssquery-yui.html (next: http://localhost:55662/tests/dromaeo/cssquery-dojo.html) 13:14:39 INFO - PROCESS | 1920 | RSS: Main: 274956288 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | __start_tp_report 13:14:39 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 13:14:39 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 13:14:39 INFO - PROCESS | 1920 | |i|pagename|runs| 13:14:39 INFO - PROCESS | 1920 | |0;dojo.html;3353.6143343515487;3367.2592029753455;3401.5407919930817;3402.2344972381234;3411.0960595442198;4902.705837649743;5053.671511351759;5559.221708960744;5565.526930210926;5612.681019960306;5574.386817450078;5585.776568937237;5671.574631902603;5693.77224911003;5755.366909639947;5032.421271553763;5110.667806592578;5119.5136462036235;5181.119209734355;5214.426413094557;5070.594352451813;5126.436092029874;5256.894862102756;5291.312129423189;5346.091164502024;5119.001794650045;5141.100307446182;5230.686158830483;5240.292560504321;5241.371035475768;5085.008423357447;5138.075146473633;5216.556592689626;5217.895642087175;5255.789768409259;4187.497500299953;4863.708177509361;5056.570191533724;5107.7446127693465;5130.3074084998425;4919.016196760626;5229.2417599448245;5639.041362968264;5658.660480371191;5667.376588575254;5253.789848406059;5768.70204204055;6112.6638034908065;6132.661461321608;6150.907736383913;6145.494353883327;6235.563510554263;6242.96878515609;6280.654563998978;6294.527910406738;5818;5821.825345239649;5826.621269617462;5827;5854.619449735754;5396.163594642758;6176.876462470816;6306.716197771111;6308.495320374359;6353.174087368705;5991.400859914061;6000.249968753906;6067.059605761114;6070.605410648293;6093.086037094471;6023.518118550505;6225.688715564203;6245.812625621239;6257.7184026718905;6271.31015588294;5991.131285963511;6007.639541627516;6071.878562428727;6086;6116.755329786848;6155.876882462326;6160.7535698571555;6170.691465426711;6170.753169873155;6219.1604133442315;4772.997670489167;4860.076585448754;4886.682365646222;4890.388701412324;4917.803287868445;4310.22415965123;4419.558044195619;4426.269665505156;4428.158649856517;4442.68901176921;5772.278465191851;5775.48020678141;5779.219805326227;5789.913151302734;5815.854603634943;6086.756529738849;6260.311365749764;6264.185655864709;6266.24805023391;6288.5598008139905;5672.914906276409;5688.8862222755315;5733.913991290134;5735.483806457439;5754.74103665336;5352.330958630171;5367.35591728995;5367.731613419313;5388.973055134699;5445.319335083114;6232.844178895564;6284.528660350401;6302.747890084437;6305.306416294296;6338.429541341301;6212.627242365473;6302.432781049728;6302.936970630235;6315.084312774714;6316;6227.564070515021;6253.8749225014335;6270.059491076375;6274.6548939808745;6282.685865706605;6151.354107818794;6154.815355539341;6155.969220153871;6172.197614310111;6198.938010619836;6220.875582488235;6282.340354262737;6282.654454005074;6291.842703932438;6305.716242769178;5898.35118136996;5901.0558310670085;5953.315368732651;6000.399960003964;6085.939140608714;5987.491063259497;5999.610025348338;6002.789902353396;6003.7898673546215;6015.909761353671;4887.169181239126;5654.15187721845;5848.824535263949;5885.55858310637;5909.172715819875;6022.638641681513;6055.364186760326;6078.3617720138745;6091.634501929899;6116.235470566179;5784.190213370048;5808.506276966336;5871.060630299132;5906.143609176731;5992.340842507408 13:14:39 INFO - PROCESS | 1920 | |1;ext.html;437.1693781814554;464.1042787420279;464.9070185962808;465.969711968722;502.6607040247832;37552.812235938814;39467.802660986694;39611.40582891252;39672.60327396725;39708.801455992754;40516.59483405173;40708.37166513336;40976.59023409765;41064.79467602665;41135.79432102843;8329.625166867505;8554.743357699279;9182.770430739218;9402.81194376112;9418.481983490905;9972.700818975442;10907.127429805636;11235.719107022349;11239;11392.943035284812;9533;9544.570494327772;9880.25898057645;11294.20940534163;11323.830142547868;9230.815383692356;11036.337819730801;11071.225014249007;11095.72260693485;11112.777744445146;11015.944920275428;11064.778704425948;11087.72280692981;11095.44522773858;11124.998750112447;33972.660273397196;36793.08017299562;38333.61666383356;38601.806990965146;38717.612823871685;2780.9721902780916;3363.613184483767;3386.305807309496;3719.8698045568276;4053.310937140693;29116.708832911823;29346;29504.557431638543;29882;30076.84961575178;3160;3177.3327601203546;3183.108729555728;3268.852901619433;3290.128116049249;365717;368644;370711;370956;371220;56742;57063.72575976543;57144;57212.42787572071;57398.42601573931;59007.40992590105;59246.40753592409;59274.70362648159;59300.40699593035;59669.70165149233;15435.845641543441;15679.137647429501;15682.372705091668;15683.372665093268;15688.137152456497;10959.945200273947;11187.94406027981;11955.701107472383;12204.633860984184;12281.263124212575;15093.01895376797;15106.39574417033;15128.54614361571;15216;15276.541703748906;6279.739293854209;6290.276618188876;6302.212223472066;6308.558400911984;6351.396617321347;816.4733746733442;869.6651789061257;963.205355581648;993.9155171810332;1029.2897900448665;20200;28768.280792979924;28924.710752892202;29586.260343491154;29626.40747185044;1043.3270540501335;1054.1198099586932;1090.8200146975819;1117.541807858774;1137.351709525579;13176.209427434385;15099;15178.241087945558;15203.771943420636;15477.922610386877;504838;591313;598969;601966;604869;55406.72296638491;56003.71998139983;56014.43985560174;56212;56319.87360252772;1338.8259526261525;1370.8149399831095;1376.2018029542842;1380.4064252371577;1380.4616199682132;27985.580216297178;28727.850885964326;29036.56445153282;29423.411531769674;29519.114426567237;47407.76296118497;48079.278810817166;48122.5187748132;48124;48360;452436;454944.7252763715;456039;457473;458394;28755.705993229938;32456.02631921046;38218;38536.229275414895;38670.806645967714;40728;44698;44719;45501.089978200915;45503;37161.628383716896;37243;37263.62736372602;38018.61981380151;38297.85106446811;36619;36646.450303246005;37473.2505349897;37487.62512374841;37795.81102094472;35779.10552236215;36096;36267.81866090652;36418.08954776152;36844;32166.51750223795;33351.49972750362;33692.83153584216;33734.3253134931;33736.1565960853;19056.237750489825;19469;22445.77554224502;23587.88206058959;24429.53422794638 13:14:39 INFO - PROCESS | 1920 | |2;jquery.html;312.89674407445546;321.6654679133701;327.20728581556415;376.94534292527567;398.57352632683023;18293.908530457345;18778.718319225205;20050.598988020232;20138.395848124543;20157.496062598442;14773;19878;19944.401667949947;20051.59896802063;20372.981350932467;5441.211024401459;5834.912476312858;5835.299764028323;5840.890230856124;5855.121731740252;5576.470235327637;5758.798442054529;5760.934227167966;5822.7088645567765;5834.824955251349;5746.367899531048;5766.0486019806685;5788.6237394569425;5792.218050563183;5792.942070579304;5563.972180139093;5675.2054712340305;5784.334801497839;5784.595078344497;5787.536997040227;5062.54437100659;5071.594272458195;5081.441041485434;5084.79660813567;5085.466026067246;25607.487850243077;26464.47071058568;26615.33461663474;27397.315067123283;27821.860890695618;1999.2302963359066;2283.9836272858583;2302.504961433283;2389.665446837444;2857.285678580355;15777.053376797428;16586.004839709654;16873.325066997306;17184.82815171857;17341;2023.1907237105129;2076.7923207679264;2078.4284321811624;2121.7453905531434;2126.362091372582;106678;109949.45025274903;112095.43952280268;112648.43675781651;114773;17017.48947531576;20337.288194913108;21349.78650213509;21526.757240400108;21531.461713457287;25623;33785.32429351399;33894.83052584721;34148.658513415045;34265.31469370649;8514.318854491627;9480.24158067353;9760.219182465386;10290.02244786744;10806.189535784848;7017.859642807115;7184.137903451619;8623.482591044558;8726.86909696355;8860.291176705849;7757.689692412353;7980.827791779533;8085.989251343582;8184.508929464251;8572.885524881725;2958.349163184096;3909.4917660703927;3911.8460054284055;3925.430812532224;3930.4104384342577;782.5278533182887;784.1648644193915;882.3294296334832;923.6813299411826;984.9116726017647;17864.91067544654;18703.81296187048;19047.904760476387;20870.79129208719;21266;761.4974117082699;806.7378102116835;933.3233405780891;962.8266911955915;972.8005758819424;10780.890405523352;11805.055595552336;11838;11840.934315911609;11879.22785018971;416532;477764;526718;531349;537504;103381;126341;128145;130802.34598827135;132110;977.6089564174387;1018.2159737002614;1041.8437234414898;1046.9738256543646;1047.3349423116224;16098.356065757238;18706.251749929852;19728;19757.604847902672;19804.910729909992;54434;54495;55011.44988550223;55184.72407637936;55580.72209638926;66156.36905416768;67083.32916670771;68076;76274;78769.60615197117;7070.540414873017;7229.132504099542;7286.927130728837;7994.320482759031;8105.918940810517;12007.459664314953;12192.536895572588;12603.18079324841;12608.49566017349;12741.55404560836;8618.310535157298;9739.853902191615;9748.317617766972;10431.68704938853;11041.723956901142;9073.591688373906;9556.426614403159;10600.840987385041;10805.459727013775;10886.836697449386;10364.42995635217;10706.571737130427;11188.216824822184;11236.381998989807;11313.264637798517;6061.909071364022;7946.40401969843;8068.273855353046;8240.381971352053;8249.546274954935;10500.684979450629;10509.211809114195;10694.41180735067;10838.783224335311;11040.558377664804 13:14:39 INFO - PROCESS | 1920 | |3;mootools.html;1517.8709809666177;1535.1096364108819;1780.706183479726;1837.825406586374;1869.289669925429;7524.05949256343;7714.498557593753;7949.403794715397;8452.070272270046;8482;7912.604369781502;8216.260536551708;8225.971753530808;8346.248837604615;8362;2252.3918541993694;2298.586254474194;2299.356180269527;2301.2981040782556;2309.203324852923;2280.7377151627525;2293.6674182243564;2310.9537809243807;2338.53229354129;2348.283773449097;1695.4066076873119;1905.961880762384;2280.600894843404;2283.200879692111;2291.450051987519;1810.6962986649658;2223.8888055597154;2243.6971008913833;2259.152817693365;2280.213326402405;1864.8041955594604;2267.2291420916804;2287.8169746420244;2308.0767692922964;2310.353101131686;8286.047104582989;8291.58542072894;8361.916380836175;8377.49735015901;8377.790555236106;5054.115529782273;5150.201718733565;5184.766685499161;5190;5195.974020129913;3204.1348835814433;3308.106811160997;3483.076984599083;3502.2820321833965;3510.7542472026967;1024.4621573673805;1065.8934106589356;1065.9360438373644;1070.4487189097622;1084.9186311026626;10627.29963205891;10673.306235094771;10686.251962362638;10768.892311076866;10834.02493775564;4374.431323927869;4592.265237561974;4688.976555117202;4712.481627021025;4713.434387873409;9200.975785327217;9253.49105799174;9285.442873427615;9295.209907157967;9332.02013788556;5128.538431541179;5150.948490515122;5171.198464238049;5176.171812509981;5180.067587834151;3849.615038496184;4221.746695198298;4239;4642.744649044335;4761.4524329701835;3747.2880152770886;3783.7729736215915;3829.6170382962036;3848.2111167210655;3872.225554888977;1276.6744480157686;1283.3637112681406;1287.909846310768;1295.0675513630172;1295.9935200323937;807.6955716517781;867.6182479708908;874.2044739287218;880.6433394475248;909.9863502047475;5313.787448502094;5672.574556908248;5689.516391106802;5770.221020162308;5912.881742365129;950.7528042708807;978.4373984958535;986.9358491698017;987.511181964932;988.5847943863595;3309.520119582647;3654.488371627974;3692;3773.8490460381827;3828.368319227352;9602.519874006271;9839;10013.349132306377;10034.899651003396;10072.546735396925;9205.953970230106;9940.45327506994;10002.699919002442;10005.399676019317;10076.546555404877;7528;7832.647530861125;7844.37245020397;7852.685892564347;7854.4894581851995;5640.717964101696;5691.3170419549915;5771.8557036074435;5831.7375718093635;5834.124881267844;7638.236176382317;9270.490123043297;9330.533473326443;9338;9342.486163261086;9031.503267320099;9281.164695177466;9407.623695052394;9433.915099763615;9502;7003.194632617314;7062.364387205176;7079;7177.856442871218;7190.784276471714;7749.031371078615;7762.184970578008;7806.57063861493;7815;7829.295363417092;6841.589504629738;7069.293070692889;7093.503454758117;7119.82200444993;7133.928660713326;5441.102218133963;6757.256701762901;6977.965110174619;7061.82345441368;7217.494775365674;6501.122348482894;6591.176102987127;6644.169478815148;6657;6674.232463266787;4760.904781904412;4833.975830120968;4847.2729090636685;4880.926786098283;4923.876903077452;4768.308595253599;4793.376861008186;4838.298446725275;4928.8767780805765;4980.382418673951 13:14:39 INFO - PROCESS | 1920 | |4;prototype.html;251.37909363871236;351.58161787472903;352.3639830106657;364.5716283367043;371.5225934673945;4952.281919121734;5004.849854504361;5236.857885268837;5283.577313814895;5289.709066001373;4583.235454350082;5151.793928242875;5164.870878228036;5168.431472538018;5194.558462530689;3369.58477439476;4026.4362989181536;4043.876964593597;4109.856155034575;4197;3708.3139619170406;3721.1999420124666;4107.17856428714;4113.856015039474;4153.916921661565;3027.666956634768;3937.6849852011915;3951.0714981979354;3951.723379363446;3965.4448377227213;3107.64262109858;3931.3513270310364;3936.5866584008695;3961.980190099031;3972.980135099306;3453.4632088720527;3453.9654603453896;3456.4296891012955;3457.8416230562793;3477.3045390921916;3909.4135879618284;4834.3473631059705;4977.664964473775;5126.2054381570915;5152.304438900738;4524.773761311922;4533.252013417782;4552.8861778455475;4557.498675145731;4617.976910115462;4920.671418716926;4934.950650493485;5498.405462415934;5554.944450555524;5570.3315602127595;3598.442241452579;3649.3066317399876;3708.1471261609713;3781.9054523636855;3790.753601015925;5177;5398.8920221595745;5770.826875193751;5788;5801.8549536261935;3046.69533046698;3809.7523660961947;3818.16000479894;3827.961720382816;3857.3056849767313;3412.3828741534053;3797.6202379761803;3891.6886649068006;3895.902602434905;3902.2780785554764;3587.3542762303036;3999.900027492463;4264.957350426518;4492.483364413069;4499.460064792246;4799;5485.341758988947;5567.830755541382;5577.6932268724795;5600.327960644668;1073.6564299424265;1208.3173007250875;1215.9392030398444;1246.8254444377794;1255.629589271167;764.7208768799348;854.8717692346073;855.3157474020759;858.1975852577859;865.5066612031208;4186.392973018956;4328.675349348749;4666.463356714022;5006.774695138654;5013.222950442614;4895.583875370562;5394.9095773621575;5448.618596698272;5488.69812160335;5492.80775172867;4028.8589899353383;4482.529334419904;4572.428446444194;4729.952700472952;4993.450720420751;2378.8096952243777;2462.8891699873548;2631.9735303231755;2750.766184874268;2844.672862620825;4823.614110871122;5172.405178401051;5395.277258691491;5469.0349496614635;5525.751341189656;4629.907401851944;5026.748662566857;5165;5498.917516237259;5628.7766332298515;4829.7585120744525;5052.69683818972;5650.463205995424;5662.631928924689;5722.914156287576;5460.508554229979;5471.37079235893;5484.533814625802;5505.752241149078;5535.0147893516605;4397.890052748707;4743.715377077387;5120.436751957207;5343.385510666323;5391.762418596239;4394.582514661102;4832.371791667061;4901.877453063702;4987.6508644396;5623.606347555796;2981.925451863721;3658.689011434058;3664.3953747631344;3673.834677439468;3674.262674307658;4807.774017625483;5127.923081153711;5361.410244872983;5486.561075113901;5494.642848214853;4776.832810851603;5332.9733351333;5427.592930530147;5633.2395126657375;5642.520385767256;4936.3089167515855;4977.900441991213;5585.469380408855;5611.887762244651;5618.52242559387;5028.622853286091;5318.202269659582;5432.511074003359;5461.9180712290145;5495.835124946258;4712.7643617818285;4878.584880682987;5015.623828212972;5056.280864506086;5536.612437129363;4384.772263766151;4459.907322705958;5485.040117979417;5485.793125512381;5499.202615620633 13:14:39 INFO - PROCESS | 1920 | |5;yui.html;577.4668849531181;703.4161645833958;704.246456291768;780.6213986216684;797.776622545687;14719.190444525548;15710.764338534931;15713.45002924898;15724.29240684169;15785.210739463038;14052.297385130729;14083.155010699365;14185.21981291031;14230.857691423083;14236.217008064552;692.8995295682123;716.0726858717973;865.2688478235912;875.5622188905547;897.6768363389175;873.0745409865531;889.5107690770083;896.6234181643725;897.2552781191596;897.9416337938046;923.6443969071888;943.6178347769164;951.5765484359463;952.6951375559823;953.3945944325369;927.9838576758439;934.985975210369;937.3485427627801;938.8497840345512;947.2800671489648;706.0609389511936;706.9469789765736;708.624429052603;710.0485349631467;710.8471678589076;14752.336144873507;15130.394784208618;15513.612159695986;15635.218239088;15781.28984195714;14065.789013164811;14316.141031538036;14407;14453.78319325211;14527.854721452755;11832.408379581073;11854.585089521825;11856.881431185664;11966.880331196664;12480.687982800411;3210.9036728898172;3299.7195238404765;3700.1674623209833;3726.4224045273027;3884.3008258513737;71816;105569.47215263952;119542;128409;129473.41053178978;10631.574737010587;10860.67417977462;10873.293235939638;10901.509432075418;11385.886141138648;21507.56984860294;21583.13667453284;21612.027458764394;21626.134954601956;21677.891610542163;7441.702331906771;7604.201558836243;7625.885611715828;7626.580538070349;7833.1775163608145;4176.874693759192;4299.333603291495;4305.84929527465;4384.649228061748;4427.8228870844805;3410.300888317889;3456.8962931112105;3490.1449144959647;3491.94762078569;3502.7022703070525;619.3373090792899;646.324590802603;646.8188907106017;649.525846132326;663.5487868249637;564.6837770848338;565.8783361577281;585.0142509870881;594.1562980567604;624.4317670919442;7727.768166955;8221.671133154607;8527.70153044653;8824.602892869836;8856.627222780351;523.39809219398;564.7938502446659;571.151839518315;574.9827505174851;600.86780908201;4083.612056854594;4129.112240868228;4178.1643671265865;4270.316749320094;4809.470958194595;91941.54029229812;100081;104460.75494308029;105082;108899;81631;85186;97743.51128244313;100246.49876750569;101306.49346753219;76537;77717.22282777213;79857.60071199607;81422.59288703519;83822;9774.755631108994;9903.158231550398;9933.602655893972;9982;9999.250056245955;45399;50311;51586.19448319291;51820.22269665883;55768;76075.23924760903;78703.60648196722;79070;79382.60308698419;80842;12653.683657908257;12886;12973.416196271002;13126.934365328112;13504.392302346221;14574.562763117123;14949.327280272197;15158.31787569584;15212.239388030333;15318.693626127191;13091.934540327238;13301.86698133045;13650.795238071636;13707.383167757276;13967.580972570839;13063.412146453622;13223;13235.073544851768;13322.40049197769;13757.862421376058;13329;13332.200067995951;13349.399277032751;13553.119047261896;13567.1859688419;10737.355758654505;10860.022597966221;10973.177011723992;11066.612668556561;11254.437278136224;11110.888931103065;11222.158338124837;11486.82769758471;11513.358454357473;11518.308901465938 13:14:39 INFO - PROCESS | 1920 | __end_tp_report 13:14:39 INFO - PROCESS | 1920 | __start_cc_report 13:14:39 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,369 13:14:39 INFO - PROCESS | 1920 | __end_cc_report 13:14:39 INFO - PROCESS | 1920 | __startTimestamp1482268479289__endTimestamp 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | ------- Summary: start ------- 13:14:39 INFO - PROCESS | 1920 | Number of tests: 6 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | [#0] dojo.html Cycles:165 Average:5671.93 Median:5854.62 stddev:652.70 (11.1%) stddev-sans-first:628.86 13:14:39 INFO - PROCESS | 1920 | Values: 3353.6 3367.3 3401.5 3402.2 3411.1 4902.7 5053.7 5559.2 5565.5 5612.7 5574.4 5585.8 5671.6 5693.8 5755.4 5032.4 5110.7 5119.5 5181.1 5214.4 5070.6 5126.4 5256.9 5291.3 5346.1 5119.0 5141.1 5230.7 5240.3 5241.4 5085.0 5138.1 5216.6 5217.9 5255.8 4187.5 4863.7 5056.6 5107.7 5130.3 4919.0 5229.2 5639.0 5658.7 5667.4 5253.8 5768.7 6112.7 6132.7 6150.9 6145.5 6235.6 6243.0 6280.7 6294.5 5818.0 5821.8 5826.6 5827.0 5854.6 5396.2 6176.9 6306.7 6308.5 6353.2 5991.4 6000.2 6067.1 6070.6 6093.1 6023.5 6225.7 6245.8 6257.7 6271.3 5991.1 6007.6 6071.9 6086.0 6116.8 6155.9 6160.8 6170.7 6170.8 6219.2 4773.0 4860.1 4886.7 4890.4 4917.8 4310.2 4419.6 4426.3 4428.2 4442.7 5772.3 5775.5 5779.2 5789.9 5815.9 6086.8 6260.3 6264.2 6266.2 6288.6 5672.9 5688.9 5733.9 5735.5 5754.7 5352.3 5367.4 5367.7 5389.0 5445.3 6232.8 6284.5 6302.7 6305.3 6338.4 6212.6 6302.4 6302.9 6315.1 6316.0 6227.6 6253.9 6270.1 6274.7 6282.7 6151.4 6154.8 6156.0 6172.2 6198.9 6220.9 6282.3 6282.7 6291.8 6305.7 5898.4 5901.1 5953.3 6000.4 6085.9 5987.5 5999.6 6002.8 6003.8 6015.9 4887.2 5654.2 5848.8 5885.6 5909.2 6022.6 6055.4 6078.4 6091.6 6116.2 5784.2 5808.5 5871.1 5906.1 5992.3 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | [#1] ext.html Cycles:180 Average:61150.55 Median:202744.00 stddev:127027.16 (62.7%) stddev-sans-first:127301.71 13:14:39 INFO - PROCESS | 1920 | Values: 437.2 464.1 464.9 466.0 502.7 37552.8 39467.8 39611.4 39672.6 39708.8 40516.6 40708.4 40976.6 41064.8 41135.8 8329.6 8554.7 9182.8 9402.8 9418.5 9972.7 10907.1 11235.7 11239.0 11392.9 9533.0 9544.6 9880.3 11294.2 11323.8 9230.8 11036.3 11071.2 11095.7 11112.8 11015.9 11064.8 11087.7 11095.4 11125.0 33972.7 36793.1 38333.6 38601.8 38717.6 2781.0 3363.6 3386.3 3719.9 4053.3 29116.7 29346.0 29504.6 29882.0 30076.8 3160.0 3177.3 3183.1 3268.9 3290.1 365717.0 368644.0 370711.0 370956.0 371220.0 56742.0 57063.7 57144.0 57212.4 57398.4 59007.4 59246.4 59274.7 59300.4 59669.7 15435.8 15679.1 15682.4 15683.4 15688.1 10959.9 11187.9 11955.7 12204.6 12281.3 15093.0 15106.4 15128.5 15216.0 15276.5 6279.7 6290.3 6302.2 6308.6 6351.4 816.5 869.7 963.2 993.9 1029.3 20200.0 28768.3 28924.7 29586.3 29626.4 1043.3 1054.1 1090.8 1117.5 1137.4 13176.2 15099.0 15178.2 15203.8 15477.9 504838.0 591313.0 598969.0 601966.0 604869.0 55406.7 56003.7 56014.4 56212.0 56319.9 1338.8 1370.8 1376.2 1380.4 1380.5 27985.6 28727.9 29036.6 29423.4 29519.1 47407.8 48079.3 48122.5 48124.0 48360.0 452436.0 454944.7 456039.0 457473.0 458394.0 28755.7 32456.0 38218.0 38536.2 38670.8 40728.0 44698.0 44719.0 45501.1 45503.0 37161.6 37243.0 37263.6 38018.6 38297.9 36619.0 36646.5 37473.3 37487.6 37795.8 35779.1 36096.0 36267.8 36418.1 36844.0 32166.5 33351.5 33692.8 33734.3 33736.2 19056.2 19469.0 22445.8 23587.9 24429.5 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | [#2] jquery.html Cycles:180 Average:32753.18 Median:17056.27 stddev:84018.49 (492.6%) stddev-sans-first:84218.87 13:14:39 INFO - PROCESS | 1920 | Values: 312.9 321.7 327.2 376.9 398.6 18293.9 18778.7 20050.6 20138.4 20157.5 14773.0 19878.0 19944.4 20051.6 20373.0 5441.2 5834.9 5835.3 5840.9 5855.1 5576.5 5758.8 5760.9 5822.7 5834.8 5746.4 5766.0 5788.6 5792.2 5792.9 5564.0 5675.2 5784.3 5784.6 5787.5 5062.5 5071.6 5081.4 5084.8 5085.5 25607.5 26464.5 26615.3 27397.3 27821.9 1999.2 2284.0 2302.5 2389.7 2857.3 15777.1 16586.0 16873.3 17184.8 17341.0 2023.2 2076.8 2078.4 2121.7 2126.4 106678.0 109949.5 112095.4 112648.4 114773.0 17017.5 20337.3 21349.8 21526.8 21531.5 25623.0 33785.3 33894.8 34148.7 34265.3 8514.3 9480.2 9760.2 10290.0 10806.2 7017.9 7184.1 8623.5 8726.9 8860.3 7757.7 7980.8 8086.0 8184.5 8572.9 2958.3 3909.5 3911.8 3925.4 3930.4 782.5 784.2 882.3 923.7 984.9 17864.9 18703.8 19047.9 20870.8 21266.0 761.5 806.7 933.3 962.8 972.8 10780.9 11805.1 11838.0 11840.9 11879.2 416532.0 477764.0 526718.0 531349.0 537504.0 103381.0 126341.0 128145.0 130802.3 132110.0 977.6 1018.2 1041.8 1047.0 1047.3 16098.4 18706.3 19728.0 19757.6 19804.9 54434.0 54495.0 55011.4 55184.7 55580.7 66156.4 67083.3 68076.0 76274.0 78769.6 7070.5 7229.1 7286.9 7994.3 8105.9 12007.5 12192.5 12603.2 12608.5 12741.6 8618.3 9739.9 9748.3 10431.7 11041.7 9073.6 9556.4 10600.8 10805.5 10886.8 10364.4 10706.6 11188.2 11236.4 11313.3 6061.9 7946.4 8068.3 8240.4 8249.5 10500.7 10509.2 10694.4 10838.8 11040.6 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | [#3] mootools.html Cycles:180 Average:5386.97 Median:5173.69 stddev:2939.69 (56.8%) stddev-sans-first:2933.56 13:14:39 INFO - PROCESS | 1920 | Values: 1517.9 1535.1 1780.7 1837.8 1869.3 7524.1 7714.5 7949.4 8452.1 8482.0 7912.6 8216.3 8226.0 8346.2 8362.0 2252.4 2298.6 2299.4 2301.3 2309.2 2280.7 2293.7 2311.0 2338.5 2348.3 1695.4 1906.0 2280.6 2283.2 2291.5 1810.7 2223.9 2243.7 2259.2 2280.2 1864.8 2267.2 2287.8 2308.1 2310.4 8286.0 8291.6 8361.9 8377.5 8377.8 5054.1 5150.2 5184.8 5190.0 5196.0 3204.1 3308.1 3483.1 3502.3 3510.8 1024.5 1065.9 1065.9 1070.4 1084.9 10627.3 10673.3 10686.3 10768.9 10834.0 4374.4 4592.3 4689.0 4712.5 4713.4 9201.0 9253.5 9285.4 9295.2 9332.0 5128.5 5150.9 5171.2 5176.2 5180.1 3849.6 4221.7 4239.0 4642.7 4761.5 3747.3 3783.8 3829.6 3848.2 3872.2 1276.7 1283.4 1287.9 1295.1 1296.0 807.7 867.6 874.2 880.6 910.0 5313.8 5672.6 5689.5 5770.2 5912.9 950.8 978.4 986.9 987.5 988.6 3309.5 3654.5 3692.0 3773.8 3828.4 9602.5 9839.0 10013.3 10034.9 10072.5 9206.0 9940.5 10002.7 10005.4 10076.5 7528.0 7832.6 7844.4 7852.7 7854.5 5640.7 5691.3 5771.9 5831.7 5834.1 7638.2 9270.5 9330.5 9338.0 9342.5 9031.5 9281.2 9407.6 9433.9 9502.0 7003.2 7062.4 7079.0 7177.9 7190.8 7749.0 7762.2 7806.6 7815.0 7829.3 6841.6 7069.3 7093.5 7119.8 7133.9 5441.1 6757.3 6978.0 7061.8 7217.5 6501.1 6591.2 6644.2 6657.0 6674.2 4760.9 4834.0 4847.3 4880.9 4923.9 4768.3 4793.4 4838.3 4928.9 4980.4 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | [#4] prototype.html Cycles:180 Average:4329.74 Median:4831.07 stddev:1330.92 (27.5%) stddev-sans-first:1298.97 13:14:39 INFO - PROCESS | 1920 | Values: 251.4 351.6 352.4 364.6 371.5 4952.3 5004.8 5236.9 5283.6 5289.7 4583.2 5151.8 5164.9 5168.4 5194.6 3369.6 4026.4 4043.9 4109.9 4197.0 3708.3 3721.2 4107.2 4113.9 4153.9 3027.7 3937.7 3951.1 3951.7 3965.4 3107.6 3931.4 3936.6 3962.0 3973.0 3453.5 3454.0 3456.4 3457.8 3477.3 3909.4 4834.3 4977.7 5126.2 5152.3 4524.8 4533.3 4552.9 4557.5 4618.0 4920.7 4935.0 5498.4 5554.9 5570.3 3598.4 3649.3 3708.1 3781.9 3790.8 5177.0 5398.9 5770.8 5788.0 5801.9 3046.7 3809.8 3818.2 3828.0 3857.3 3412.4 3797.6 3891.7 3895.9 3902.3 3587.4 3999.9 4265.0 4492.5 4499.5 4799.0 5485.3 5567.8 5577.7 5600.3 1073.7 1208.3 1215.9 1246.8 1255.6 764.7 854.9 855.3 858.2 865.5 4186.4 4328.7 4666.5 5006.8 5013.2 4895.6 5394.9 5448.6 5488.7 5492.8 4028.9 4482.5 4572.4 4730.0 4993.5 2378.8 2462.9 2632.0 2750.8 2844.7 4823.6 5172.4 5395.3 5469.0 5525.8 4629.9 5026.7 5165.0 5498.9 5628.8 4829.8 5052.7 5650.5 5662.6 5722.9 5460.5 5471.4 5484.5 5505.8 5535.0 4397.9 4743.7 5120.4 5343.4 5391.8 4394.6 4832.4 4901.9 4987.7 5623.6 2981.9 3658.7 3664.4 3673.8 3674.3 4807.8 5127.9 5361.4 5486.6 5494.6 4776.8 5333.0 5427.6 5633.2 5642.5 4936.3 4977.9 5585.5 5611.9 5618.5 5028.6 5318.2 5432.5 5461.9 5495.8 4712.8 4878.6 5015.6 5056.3 5536.6 4384.8 4459.9 5485.0 5485.8 5499.2 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - PROCESS | 1920 | [#5] yui.html Cycles:180 Average:21083.70 Median:4106.36 stddev:30947.25 (753.6%) stddev-sans-first:30995.76 13:14:39 INFO - PROCESS | 1920 | Values: 577.5 703.4 704.2 780.6 797.8 14719.2 15710.8 15713.5 15724.3 15785.2 14052.3 14083.2 14185.2 14230.9 14236.2 692.9 716.1 865.3 875.6 897.7 873.1 889.5 896.6 897.3 897.9 923.6 943.6 951.6 952.7 953.4 928.0 935.0 937.3 938.8 947.3 706.1 706.9 708.6 710.0 710.8 14752.3 15130.4 15513.6 15635.2 15781.3 14065.8 14316.1 14407.0 14453.8 14527.9 11832.4 11854.6 11856.9 11966.9 12480.7 3210.9 3299.7 3700.2 3726.4 3884.3 71816.0 105569.5 119542.0 128409.0 129473.4 10631.6 10860.7 10873.3 10901.5 11385.9 21507.6 21583.1 21612.0 21626.1 21677.9 7441.7 7604.2 7625.9 7626.6 7833.2 4176.9 4299.3 4305.8 4384.6 4427.8 3410.3 3456.9 3490.1 3491.9 3502.7 619.3 646.3 646.8 649.5 663.5 564.7 565.9 585.0 594.2 624.4 7727.8 8221.7 8527.7 8824.6 8856.6 523.4 564.8 571.2 575.0 600.9 4083.6 4129.1 4178.2 4270.3 4809.5 91941.5 100081.0 104460.8 105082.0 108899.0 81631.0 85186.0 97743.5 100246.5 101306.5 76537.0 77717.2 79857.6 81422.6 83822.0 9774.8 9903.2 9933.6 9982.0 9999.3 45399.0 50311.0 51586.2 51820.2 55768.0 76075.2 78703.6 79070.0 79382.6 80842.0 12653.7 12886.0 12973.4 13126.9 13504.4 14574.6 14949.3 15158.3 15212.2 15318.7 13091.9 13301.9 13650.8 13707.4 13967.6 13063.4 13223.0 13235.1 13322.4 13757.9 13329.0 13332.2 13349.4 13553.1 13567.2 10737.4 10860.0 10973.2 11066.6 11254.4 11110.9 11222.2 11486.8 11513.4 11518.3 13:14:39 INFO - PROCESS | 1920 | -------- Summary: end -------- 13:14:39 INFO - PROCESS | 1920 | 13:14:39 INFO - TEST-INFO | 1920: exit 0 13:14:39 INFO - TEST-OK | dromaeo_css | took 1117061ms 13:14:39 INFO - TEST-START | kraken 13:14:39 INFO - operating with platform_type : mac_ 13:14:39 INFO - Initialising browser for kraken test... 13:14:39 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpodPqTc/profile http://localhost:55662/getInfo.html) 13:14:42 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 13:14:42 INFO - PROCESS | 1927 | colorDepth:24 13:14:42 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 13:14:42 INFO - PROCESS | 1927 | __metrics 13:14:42 INFO - PROCESS | 1927 | 2016-12-20 13:14:42.853 plugin-container[1928:22137] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 13:14:42 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:14:42 INFO - PROCESS | 1927 | 2016-12-20 13:14:42.857 plugin-container[1928:22137] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e17, name = 'com.apple.CFPasteboardClient' 13:14:42 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:14:42 INFO - PROCESS | 1927 | 2016-12-20 13:14:42.857 plugin-container[1928:22137] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:14:42 ERROR - PROCESS | 1927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 13:14:43 INFO - TEST-INFO | 1927: exit 0 13:14:43 INFO - Browser initialized. 13:14:43 INFO - Running cycle 1/1 for kraken test... 13:14:43 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpodPqTc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:45 INFO - PROCESS | 1929 | 2016-12-20 13:14:45.935 plugin-container[1930:22255] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 13:14:45 INFO - PROCESS | 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:14:45 INFO - PROCESS | 1929 | 2016-12-20 13:14:45.936 plugin-container[1930:22255] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 13:14:45 INFO - PROCESS | 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:14:45 INFO - PROCESS | 1929 | 2016-12-20 13:14:45.937 plugin-container[1930:22255] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:14:55 INFO - PROCESS | 1929 | RSS: Main: 234446848 13:14:55 INFO - PROCESS | 1929 | 13:14:59 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-beat-detection) 13:15:00 INFO - PROCESS | 1929 | RSS: Main: 247283712 13:15:00 INFO - PROCESS | 1929 | 13:15:02 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-dft) 13:15:03 INFO - PROCESS | 1929 | RSS: Main: 254787584 13:15:03 INFO - PROCESS | 1929 | 13:15:06 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-fft) 13:15:07 INFO - PROCESS | 1929 | RSS: Main: 257695744 13:15:07 INFO - PROCESS | 1929 | 13:15:09 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55662/tests/kraken/driver.html?testName=audio-oscillator) 13:15:10 INFO - PROCESS | 1929 | RSS: Main: 259719168 13:15:10 INFO - PROCESS | 1929 | 13:15:12 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:15:13 INFO - PROCESS | 1929 | RSS: Main: 260030464 13:15:13 INFO - PROCESS | 1929 | 13:15:16 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55662/tests/kraken/driver.html?testName=imaging-darkroom) 13:15:16 INFO - PROCESS | 1929 | RSS: Main: 266113024 13:15:16 INFO - PROCESS | 1929 | 13:15:20 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55662/tests/kraken/driver.html?testName=imaging-desaturate) 13:15:20 INFO - PROCESS | 1929 | RSS: Main: 265703424 13:15:20 INFO - PROCESS | 1929 | 13:15:23 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55662/tests/kraken/driver.html?testName=json-parse-financial) 13:15:24 INFO - PROCESS | 1929 | RSS: Main: 264966144 13:15:24 INFO - PROCESS | 1929 | 13:15:25 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:15:26 INFO - PROCESS | 1929 | RSS: Main: 264978432 13:15:26 INFO - PROCESS | 1929 | 13:15:28 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:15:29 INFO - PROCESS | 1929 | RSS: Main: 265023488 13:15:29 INFO - PROCESS | 1929 | 13:15:31 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:15:32 INFO - PROCESS | 1929 | RSS: Main: 265031680 13:15:32 INFO - PROCESS | 1929 | 13:15:35 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:35 INFO - PROCESS | 1929 | RSS: Main: 265551872 13:15:35 INFO - PROCESS | 1929 | 13:15:38 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:39 INFO - PROCESS | 1929 | RSS: Main: 265162752 13:15:39 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:55662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55662/tests/kraken/driver.html?testName=ai-astar) 13:15:41 INFO - PROCESS | 1929 | RSS: Main: 267534336 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | __start_tp_report 13:15:41 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 13:15:41 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 13:15:41 INFO - PROCESS | 1929 | |i|pagename|runs| 13:15:41 INFO - PROCESS | 1929 | |0;ai-astar;156;176;159;114;107;95;174;174;178;172 13:15:41 INFO - PROCESS | 1929 | |1;audio-beat-detection;150;112;98;182;102;121;111;100;128;137 13:15:41 INFO - PROCESS | 1929 | |2;audio-dft;214;258;274;199;229;184;200;272;278;209 13:15:41 INFO - PROCESS | 1929 | |3;audio-fft;81;60;50;86;72;82;85;52;64;68 13:15:41 INFO - PROCESS | 1929 | |4;audio-oscillator;114;57;97;105;58;87;104;103;104;113 13:15:41 INFO - PROCESS | 1929 | |5;imaging-gaussian-blur;116;111;111;112;128;174;109;112;111;111 13:15:41 INFO - PROCESS | 1929 | |6;imaging-darkroom;99;135;116;176;170;102;99;128;124;99 13:15:41 INFO - PROCESS | 1929 | |7;imaging-desaturate;93;94;101;93;86;144;155;93;93;93 13:15:41 INFO - PROCESS | 1929 | |8;json-parse-financial;61;60;60;62;62;62;63;64;62;63 13:15:41 INFO - PROCESS | 1929 | |9;json-stringify-tinderbox;68;68;80;75;76;70;70;71;73;71 13:15:41 INFO - PROCESS | 1929 | |10;stanford-crypto-aes;89;90;90;89;90;90;88;113;111;84 13:15:41 INFO - PROCESS | 1929 | |11;stanford-crypto-ccm;140;147;158;155;154;158;154;157;192;147 13:15:41 INFO - PROCESS | 1929 | |12;stanford-crypto-pbkdf2;175;176;175;175;175;192;237;201;172;172 13:15:41 INFO - PROCESS | 1929 | |13;stanford-crypto-sha256-iterative;69;69;67;69;68;67;68;67;69;74 13:15:41 INFO - PROCESS | 1929 | __end_tp_report 13:15:41 INFO - PROCESS | 1929 | __start_cc_report 13:15:41 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,927 13:15:41 INFO - PROCESS | 1929 | __end_cc_report 13:15:41 INFO - PROCESS | 1929 | __startTimestamp1482268541379__endTimestamp 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | ------- Summary: start ------- 13:15:41 INFO - PROCESS | 1929 | Number of tests: 14 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#0] ai-astar Cycles:10 Average:150.50 Median:174.00 stddev:32.28 (18.6%) stddev-sans-first:34.18 13:15:41 INFO - PROCESS | 1929 | Values: 156.0 176.0 159.0 114.0 107.0 95.0 174.0 174.0 178.0 172.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:132.50 stddev:26.42 (19.9%) stddev-sans-first:26.31 13:15:41 INFO - PROCESS | 1929 | Values: 150.0 112.0 98.0 182.0 102.0 121.0 111.0 100.0 128.0 137.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#2] audio-dft Cycles:10 Average:231.70 Median:243.50 stddev:35.64 (14.6%) stddev-sans-first:37.23 13:15:41 INFO - PROCESS | 1929 | Values: 214.0 258.0 274.0 199.0 229.0 184.0 200.0 272.0 278.0 209.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#3] audio-fft Cycles:10 Average:70.00 Median:76.50 stddev:13.39 (17.5%) stddev-sans-first:13.60 13:15:41 INFO - PROCESS | 1929 | Values: 81.0 60.0 50.0 86.0 72.0 82.0 85.0 52.0 64.0 68.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:85.50 stddev:20.78 (24.3%) stddev-sans-first:20.77 13:15:41 INFO - PROCESS | 1929 | Values: 114.0 57.0 97.0 105.0 58.0 87.0 104.0 103.0 104.0 113.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#5] imaging-gaussian-blur Cycles:10 Average:119.50 Median:112.00 stddev:19.91 (17.8%) stddev-sans-first:21.07 13:15:41 INFO - PROCESS | 1929 | Values: 116.0 111.0 111.0 112.0 128.0 174.0 109.0 112.0 111.0 111.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#6] imaging-darkroom Cycles:10 Average:124.80 Median:173.00 stddev:28.62 (16.5%) stddev-sans-first:28.80 13:15:41 INFO - PROCESS | 1929 | Values: 99.0 135.0 116.0 176.0 170.0 102.0 99.0 128.0 124.0 99.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#7] imaging-desaturate Cycles:10 Average:104.50 Median:93.00 stddev:24.12 (25.9%) stddev-sans-first:25.22 13:15:41 INFO - PROCESS | 1929 | Values: 93.0 94.0 101.0 93.0 86.0 144.0 155.0 93.0 93.0 93.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.32 13:15:41 INFO - PROCESS | 1929 | Values: 61.0 60.0 60.0 62.0 62.0 62.0 63.0 64.0 62.0 63.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.82 (5.3%) stddev-sans-first:3.74 13:15:41 INFO - PROCESS | 1929 | Values: 68.0 68.0 80.0 75.0 76.0 70.0 70.0 71.0 73.0 71.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:89.50 stddev:9.98 (11.2%) stddev-sans-first:10.46 13:15:41 INFO - PROCESS | 1929 | Values: 89.0 90.0 90.0 89.0 90.0 90.0 88.0 113.0 111.0 84.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:156.00 stddev:13.87 (8.9%) stddev-sans-first:13.42 13:15:41 INFO - PROCESS | 1929 | Values: 140.0 147.0 158.0 155.0 154.0 158.0 154.0 157.0 192.0 147.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:175.50 stddev:20.62 (11.8%) stddev-sans-first:21.55 13:15:41 INFO - PROCESS | 1929 | Values: 175.0 176.0 175.0 175.0 175.0 192.0 237.0 201.0 172.0 172.0 13:15:41 INFO - PROCESS | 1929 | 13:15:41 INFO - PROCESS | 1929 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.06 (3.0%) stddev-sans-first:2.18 13:15:41 INFO - PROCESS | 1929 | Values: 69.0 69.0 67.0 69.0 68.0 67.0 68.0 67.0 69.0 74.0 13:15:41 INFO - PROCESS | 1929 | -------- Summary: end -------- 13:15:41 INFO - PROCESS | 1929 | 13:15:42 INFO - TEST-INFO | 1929: exit 0 13:15:42 INFO - TEST-OK | kraken | took 62364ms 13:15:42 INFO - SUITE-END | took 1179s 13:15:42 INFO - Completed test suite (00:19:39) 13:15:42 INFO - javascript benchmark 13:15:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7217.812800369789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.6143343515487, 3367.2592029753455, 3401.5407919930817, 3402.2344972381234, 3411.0960595442198, 4902.705837649743, 5053.671511351759, 5559.221708960744, 5565.526930210926, 5612.681019960306, 5574.386817450078, 5585.776568937237, 5671.574631902603, 5693.77224911003, 5755.366909639947, 5032.421271553763, 5110.667806592578, 5119.5136462036235, 5181.119209734355, 5214.426413094557, 5070.594352451813, 5126.436092029874, 5256.894862102756, 5291.312129423189, 5346.091164502024, 5119.001794650045, 5141.100307446182, 5230.686158830483, 5240.292560504321, 5241.371035475768, 5085.008423357447, 5138.075146473633, 5216.556592689626, 5217.895642087175, 5255.789768409259, 4187.497500299953, 4863.708177509361, 5056.570191533724, 5107.7446127693465, 5130.3074084998425, 4919.016196760626, 5229.2417599448245, 5639.041362968264, 5658.660480371191, 5667.376588575254, 5253.789848406059, 5768.70204204055, 6112.6638034908065, 6132.661461321608, 6150.907736383913, 6145.494353883327, 6235.563510554263, 6242.96878515609, 6280.654563998978, 6294.527910406738, 5818.0, 5821.825345239649, 5826.621269617462, 5827.0, 5854.619449735754, 5396.163594642758, 6176.876462470816, 6306.716197771111, 6308.495320374359, 6353.174087368705, 5991.400859914061, 6000.249968753906, 6067.059605761114, 6070.605410648293, 6093.086037094471, 6023.518118550505, 6225.688715564203, 6245.812625621239, 6257.7184026718905, 6271.31015588294, 5991.131285963511, 6007.639541627516, 6071.878562428727, 6086.0, 6116.755329786848, 6155.876882462326, 6160.7535698571555, 6170.691465426711, 6170.753169873155, 6219.1604133442315, 4772.997670489167, 4860.076585448754, 4886.682365646222, 4890.388701412324, 4917.803287868445, 4310.22415965123, 4419.558044195619, 4426.269665505156, 4428.158649856517, 4442.68901176921, 5772.278465191851, 5775.48020678141, 5779.219805326227, 5789.913151302734, 5815.854603634943, 6086.756529738849, 6260.311365749764, 6264.185655864709, 6266.24805023391, 6288.5598008139905, 5672.914906276409, 5688.8862222755315, 5733.913991290134, 5735.483806457439, 5754.74103665336, 5352.330958630171, 5367.35591728995, 5367.731613419313, 5388.973055134699, 5445.319335083114, 6232.844178895564, 6284.528660350401, 6302.747890084437, 6305.306416294296, 6338.429541341301, 6212.627242365473, 6302.432781049728, 6302.936970630235, 6315.084312774714, 6316.0, 6227.564070515021, 6253.8749225014335, 6270.059491076375, 6274.6548939808745, 6282.685865706605, 6151.354107818794, 6154.815355539341, 6155.969220153871, 6172.197614310111, 6198.938010619836, 6220.875582488235, 6282.340354262737, 6282.654454005074, 6291.842703932438, 6305.716242769178, 5898.35118136996, 5901.0558310670085, 5953.315368732651, 6000.399960003964, 6085.939140608714, 5987.491063259497, 5999.610025348338, 6002.789902353396, 6003.7898673546215, 6015.909761353671, 4887.169181239126, 5654.15187721845, 5848.824535263949, 5885.55858310637, 5909.172715819875, 6022.638641681513, 6055.364186760326, 6078.3617720138745, 6091.634501929899, 6116.235470566179, 5784.190213370048, 5808.506276966336, 5871.060630299132, 5906.143609176731, 5992.340842507408], "value": 5630.670618841189, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.1693781814554, 464.1042787420279, 464.9070185962808, 465.969711968722, 502.6607040247832, 37552.812235938814, 39467.802660986694, 39611.40582891252, 39672.60327396725, 39708.801455992754, 40516.59483405173, 40708.37166513336, 40976.59023409765, 41064.79467602665, 41135.79432102843, 8329.625166867505, 8554.743357699279, 9182.770430739218, 9402.81194376112, 9418.481983490905, 9972.700818975442, 10907.127429805636, 11235.719107022349, 11239.0, 11392.943035284812, 9533.0, 9544.570494327772, 9880.25898057645, 11294.20940534163, 11323.830142547868, 9230.815383692356, 11036.337819730801, 11071.225014249007, 11095.72260693485, 11112.777744445146, 11015.944920275428, 11064.778704425948, 11087.72280692981, 11095.44522773858, 11124.998750112447, 33972.660273397196, 36793.08017299562, 38333.61666383356, 38601.806990965146, 38717.612823871685, 2780.9721902780916, 3363.613184483767, 3386.305807309496, 3719.8698045568276, 4053.310937140693, 29116.708832911823, 29346.0, 29504.557431638543, 29882.0, 30076.84961575178, 3160.0, 3177.3327601203546, 3183.108729555728, 3268.852901619433, 3290.128116049249, 365717.0, 368644.0, 370711.0, 370956.0, 371220.0, 56742.0, 57063.72575976543, 57144.0, 57212.42787572071, 57398.42601573931, 59007.40992590105, 59246.40753592409, 59274.70362648159, 59300.40699593035, 59669.70165149233, 15435.845641543441, 15679.137647429501, 15682.372705091668, 15683.372665093268, 15688.137152456497, 10959.945200273947, 11187.94406027981, 11955.701107472383, 12204.633860984184, 12281.263124212575, 15093.01895376797, 15106.39574417033, 15128.54614361571, 15216.0, 15276.541703748906, 6279.739293854209, 6290.276618188876, 6302.212223472066, 6308.558400911984, 6351.396617321347, 816.4733746733442, 869.6651789061257, 963.205355581648, 993.9155171810332, 1029.2897900448665, 20200.0, 28768.280792979924, 28924.710752892202, 29586.260343491154, 29626.40747185044, 1043.3270540501335, 1054.1198099586932, 1090.8200146975819, 1117.541807858774, 1137.351709525579, 13176.209427434385, 15099.0, 15178.241087945558, 15203.771943420636, 15477.922610386877, 504838.0, 591313.0, 598969.0, 601966.0, 604869.0, 55406.72296638491, 56003.71998139983, 56014.43985560174, 56212.0, 56319.87360252772, 1338.8259526261525, 1370.8149399831095, 1376.2018029542842, 1380.4064252371577, 1380.4616199682132, 27985.580216297178, 28727.850885964326, 29036.56445153282, 29423.411531769674, 29519.114426567237, 47407.76296118497, 48079.278810817166, 48122.5187748132, 48124.0, 48360.0, 452436.0, 454944.7252763715, 456039.0, 457473.0, 458394.0, 28755.705993229938, 32456.02631921046, 38218.0, 38536.229275414895, 38670.806645967714, 40728.0, 44698.0, 44719.0, 45501.089978200915, 45503.0, 37161.628383716896, 37243.0, 37263.62736372602, 38018.61981380151, 38297.85106446811, 36619.0, 36646.450303246005, 37473.2505349897, 37487.62512374841, 37795.81102094472, 35779.10552236215, 36096.0, 36267.81866090652, 36418.08954776152, 36844.0, 32166.51750223795, 33351.49972750362, 33692.83153584216, 33734.3253134931, 33736.1565960853, 19056.237750489825, 19469.0, 22445.77554224502, 23587.88206058959, 24429.53422794638], "value": 19218.257010454257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.89674407445546, 321.6654679133701, 327.20728581556415, 376.94534292527567, 398.57352632683023, 18293.908530457345, 18778.718319225205, 20050.598988020232, 20138.395848124543, 20157.496062598442, 14773.0, 19878.0, 19944.401667949947, 20051.59896802063, 20372.981350932467, 5441.211024401459, 5834.912476312858, 5835.299764028323, 5840.890230856124, 5855.121731740252, 5576.470235327637, 5758.798442054529, 5760.934227167966, 5822.7088645567765, 5834.824955251349, 5746.367899531048, 5766.0486019806685, 5788.6237394569425, 5792.218050563183, 5792.942070579304, 5563.972180139093, 5675.2054712340305, 5784.334801497839, 5784.595078344497, 5787.536997040227, 5062.54437100659, 5071.594272458195, 5081.441041485434, 5084.79660813567, 5085.466026067246, 25607.487850243077, 26464.47071058568, 26615.33461663474, 27397.315067123283, 27821.860890695618, 1999.2302963359066, 2283.9836272858583, 2302.504961433283, 2389.665446837444, 2857.285678580355, 15777.053376797428, 16586.004839709654, 16873.325066997306, 17184.82815171857, 17341.0, 2023.1907237105129, 2076.7923207679264, 2078.4284321811624, 2121.7453905531434, 2126.362091372582, 106678.0, 109949.45025274903, 112095.43952280268, 112648.43675781651, 114773.0, 17017.48947531576, 20337.288194913108, 21349.78650213509, 21526.757240400108, 21531.461713457287, 25623.0, 33785.32429351399, 33894.83052584721, 34148.658513415045, 34265.31469370649, 8514.318854491627, 9480.24158067353, 9760.219182465386, 10290.02244786744, 10806.189535784848, 7017.859642807115, 7184.137903451619, 8623.482591044558, 8726.86909696355, 8860.291176705849, 7757.689692412353, 7980.827791779533, 8085.989251343582, 8184.508929464251, 8572.885524881725, 2958.349163184096, 3909.4917660703927, 3911.8460054284055, 3925.430812532224, 3930.4104384342577, 782.5278533182887, 784.1648644193915, 882.3294296334832, 923.6813299411826, 984.9116726017647, 17864.91067544654, 18703.81296187048, 19047.904760476387, 20870.79129208719, 21266.0, 761.4974117082699, 806.7378102116835, 933.3233405780891, 962.8266911955915, 972.8005758819424, 10780.890405523352, 11805.055595552336, 11838.0, 11840.934315911609, 11879.22785018971, 416532.0, 477764.0, 526718.0, 531349.0, 537504.0, 103381.0, 126341.0, 128145.0, 130802.34598827135, 132110.0, 977.6089564174387, 1018.2159737002614, 1041.8437234414898, 1046.9738256543646, 1047.3349423116224, 16098.356065757238, 18706.251749929852, 19728.0, 19757.604847902672, 19804.910729909992, 54434.0, 54495.0, 55011.44988550223, 55184.72407637936, 55580.72209638926, 66156.36905416768, 67083.32916670771, 68076.0, 76274.0, 78769.60615197117, 7070.540414873017, 7229.132504099542, 7286.927130728837, 7994.320482759031, 8105.918940810517, 12007.459664314953, 12192.536895572588, 12603.18079324841, 12608.49566017349, 12741.55404560836, 8618.310535157298, 9739.853902191615, 9748.317617766972, 10431.68704938853, 11041.723956901142, 9073.591688373906, 9556.426614403159, 10600.840987385041, 10805.459727013775, 10886.836697449386, 10364.42995635217, 10706.571737130427, 11188.216824822184, 11236.381998989807, 11313.264637798517, 6061.909071364022, 7946.40401969843, 8068.273855353046, 8240.381971352053, 8249.546274954935, 10500.684979450629, 10509.211809114195, 10694.41180735067, 10838.783224335311, 11040.558377664804], "value": 10189.339767798107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.8709809666177, 1535.1096364108819, 1780.706183479726, 1837.825406586374, 1869.289669925429, 7524.05949256343, 7714.498557593753, 7949.403794715397, 8452.070272270046, 8482.0, 7912.604369781502, 8216.260536551708, 8225.971753530808, 8346.248837604615, 8362.0, 2252.3918541993694, 2298.586254474194, 2299.356180269527, 2301.2981040782556, 2309.203324852923, 2280.7377151627525, 2293.6674182243564, 2310.9537809243807, 2338.53229354129, 2348.283773449097, 1695.4066076873119, 1905.961880762384, 2280.600894843404, 2283.200879692111, 2291.450051987519, 1810.6962986649658, 2223.8888055597154, 2243.6971008913833, 2259.152817693365, 2280.213326402405, 1864.8041955594604, 2267.2291420916804, 2287.8169746420244, 2308.0767692922964, 2310.353101131686, 8286.047104582989, 8291.58542072894, 8361.916380836175, 8377.49735015901, 8377.790555236106, 5054.115529782273, 5150.201718733565, 5184.766685499161, 5190.0, 5195.974020129913, 3204.1348835814433, 3308.106811160997, 3483.076984599083, 3502.2820321833965, 3510.7542472026967, 1024.4621573673805, 1065.8934106589356, 1065.9360438373644, 1070.4487189097622, 1084.9186311026626, 10627.29963205891, 10673.306235094771, 10686.251962362638, 10768.892311076866, 10834.02493775564, 4374.431323927869, 4592.265237561974, 4688.976555117202, 4712.481627021025, 4713.434387873409, 9200.975785327217, 9253.49105799174, 9285.442873427615, 9295.209907157967, 9332.02013788556, 5128.538431541179, 5150.948490515122, 5171.198464238049, 5176.171812509981, 5180.067587834151, 3849.615038496184, 4221.746695198298, 4239.0, 4642.744649044335, 4761.4524329701835, 3747.2880152770886, 3783.7729736215915, 3829.6170382962036, 3848.2111167210655, 3872.225554888977, 1276.6744480157686, 1283.3637112681406, 1287.909846310768, 1295.0675513630172, 1295.9935200323937, 807.6955716517781, 867.6182479708908, 874.2044739287218, 880.6433394475248, 909.9863502047475, 5313.787448502094, 5672.574556908248, 5689.516391106802, 5770.221020162308, 5912.881742365129, 950.7528042708807, 978.4373984958535, 986.9358491698017, 987.511181964932, 988.5847943863595, 3309.520119582647, 3654.488371627974, 3692.0, 3773.8490460381827, 3828.368319227352, 9602.519874006271, 9839.0, 10013.349132306377, 10034.899651003396, 10072.546735396925, 9205.953970230106, 9940.45327506994, 10002.699919002442, 10005.399676019317, 10076.546555404877, 7528.0, 7832.647530861125, 7844.37245020397, 7852.685892564347, 7854.4894581851995, 5640.717964101696, 5691.3170419549915, 5771.8557036074435, 5831.7375718093635, 5834.124881267844, 7638.236176382317, 9270.490123043297, 9330.533473326443, 9338.0, 9342.486163261086, 9031.503267320099, 9281.164695177466, 9407.623695052394, 9433.915099763615, 9502.0, 7003.194632617314, 7062.364387205176, 7079.0, 7177.856442871218, 7190.784276471714, 7749.031371078615, 7762.184970578008, 7806.57063861493, 7815.0, 7829.295363417092, 6841.589504629738, 7069.293070692889, 7093.503454758117, 7119.82200444993, 7133.928660713326, 5441.102218133963, 6757.256701762901, 6977.965110174619, 7061.82345441368, 7217.494775365674, 6501.122348482894, 6591.176102987127, 6644.169478815148, 6657.0, 6674.232463266787, 4760.904781904412, 4833.975830120968, 4847.2729090636685, 4880.926786098283, 4923.876903077452, 4768.308595253599, 4793.376861008186, 4838.298446725275, 4928.8767780805765, 4980.382418673951], "value": 4379.372665788264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.37909363871236, 351.58161787472903, 352.3639830106657, 364.5716283367043, 371.5225934673945, 4952.281919121734, 5004.849854504361, 5236.857885268837, 5283.577313814895, 5289.709066001373, 4583.235454350082, 5151.793928242875, 5164.870878228036, 5168.431472538018, 5194.558462530689, 3369.58477439476, 4026.4362989181536, 4043.876964593597, 4109.856155034575, 4197.0, 3708.3139619170406, 3721.1999420124666, 4107.17856428714, 4113.856015039474, 4153.916921661565, 3027.666956634768, 3937.6849852011915, 3951.0714981979354, 3951.723379363446, 3965.4448377227213, 3107.64262109858, 3931.3513270310364, 3936.5866584008695, 3961.980190099031, 3972.980135099306, 3453.4632088720527, 3453.9654603453896, 3456.4296891012955, 3457.8416230562793, 3477.3045390921916, 3909.4135879618284, 4834.3473631059705, 4977.664964473775, 5126.2054381570915, 5152.304438900738, 4524.773761311922, 4533.252013417782, 4552.8861778455475, 4557.498675145731, 4617.976910115462, 4920.671418716926, 4934.950650493485, 5498.405462415934, 5554.944450555524, 5570.3315602127595, 3598.442241452579, 3649.3066317399876, 3708.1471261609713, 3781.9054523636855, 3790.753601015925, 5177.0, 5398.8920221595745, 5770.826875193751, 5788.0, 5801.8549536261935, 3046.69533046698, 3809.7523660961947, 3818.16000479894, 3827.961720382816, 3857.3056849767313, 3412.3828741534053, 3797.6202379761803, 3891.6886649068006, 3895.902602434905, 3902.2780785554764, 3587.3542762303036, 3999.900027492463, 4264.957350426518, 4492.483364413069, 4499.460064792246, 4799.0, 5485.341758988947, 5567.830755541382, 5577.6932268724795, 5600.327960644668, 1073.6564299424265, 1208.3173007250875, 1215.9392030398444, 1246.8254444377794, 1255.629589271167, 764.7208768799348, 854.8717692346073, 855.3157474020759, 858.1975852577859, 865.5066612031208, 4186.392973018956, 4328.675349348749, 4666.463356714022, 5006.774695138654, 5013.222950442614, 4895.583875370562, 5394.9095773621575, 5448.618596698272, 5488.69812160335, 5492.80775172867, 4028.8589899353383, 4482.529334419904, 4572.428446444194, 4729.952700472952, 4993.450720420751, 2378.8096952243777, 2462.8891699873548, 2631.9735303231755, 2750.766184874268, 2844.672862620825, 4823.614110871122, 5172.405178401051, 5395.277258691491, 5469.0349496614635, 5525.751341189656, 4629.907401851944, 5026.748662566857, 5165.0, 5498.917516237259, 5628.7766332298515, 4829.7585120744525, 5052.69683818972, 5650.463205995424, 5662.631928924689, 5722.914156287576, 5460.508554229979, 5471.37079235893, 5484.533814625802, 5505.752241149078, 5535.0147893516605, 4397.890052748707, 4743.715377077387, 5120.436751957207, 5343.385510666323, 5391.762418596239, 4394.582514661102, 4832.371791667061, 4901.877453063702, 4987.6508644396, 5623.606347555796, 2981.925451863721, 3658.689011434058, 3664.3953747631344, 3673.834677439468, 3674.262674307658, 4807.774017625483, 5127.923081153711, 5361.410244872983, 5486.561075113901, 5494.642848214853, 4776.832810851603, 5332.9733351333, 5427.592930530147, 5633.2395126657375, 5642.520385767256, 4936.3089167515855, 4977.900441991213, 5585.469380408855, 5611.887762244651, 5618.52242559387, 5028.622853286091, 5318.202269659582, 5432.511074003359, 5461.9180712290145, 5495.835124946258, 4712.7643617818285, 4878.584880682987, 5015.623828212972, 5056.280864506086, 5536.612437129363, 4384.772263766151, 4459.907322705958, 5485.040117979417, 5485.793125512381, 5499.202615620633], "value": 3916.726941444841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4668849531181, 703.4161645833958, 704.246456291768, 780.6213986216684, 797.776622545687, 14719.190444525548, 15710.764338534931, 15713.45002924898, 15724.29240684169, 15785.210739463038, 14052.297385130729, 14083.155010699365, 14185.21981291031, 14230.857691423083, 14236.217008064552, 692.8995295682123, 716.0726858717973, 865.2688478235912, 875.5622188905547, 897.6768363389175, 873.0745409865531, 889.5107690770083, 896.6234181643725, 897.2552781191596, 897.9416337938046, 923.6443969071888, 943.6178347769164, 951.5765484359463, 952.6951375559823, 953.3945944325369, 927.9838576758439, 934.985975210369, 937.3485427627801, 938.8497840345512, 947.2800671489648, 706.0609389511936, 706.9469789765736, 708.624429052603, 710.0485349631467, 710.8471678589076, 14752.336144873507, 15130.394784208618, 15513.612159695986, 15635.218239088, 15781.28984195714, 14065.789013164811, 14316.141031538036, 14407.0, 14453.78319325211, 14527.854721452755, 11832.408379581073, 11854.585089521825, 11856.881431185664, 11966.880331196664, 12480.687982800411, 3210.9036728898172, 3299.7195238404765, 3700.1674623209833, 3726.4224045273027, 3884.3008258513737, 71816.0, 105569.47215263952, 119542.0, 128409.0, 129473.41053178978, 10631.574737010587, 10860.67417977462, 10873.293235939638, 10901.509432075418, 11385.886141138648, 21507.56984860294, 21583.13667453284, 21612.027458764394, 21626.134954601956, 21677.891610542163, 7441.702331906771, 7604.201558836243, 7625.885611715828, 7626.580538070349, 7833.1775163608145, 4176.874693759192, 4299.333603291495, 4305.84929527465, 4384.649228061748, 4427.8228870844805, 3410.300888317889, 3456.8962931112105, 3490.1449144959647, 3491.94762078569, 3502.7022703070525, 619.3373090792899, 646.324590802603, 646.8188907106017, 649.525846132326, 663.5487868249637, 564.6837770848338, 565.8783361577281, 585.0142509870881, 594.1562980567604, 624.4317670919442, 7727.768166955, 8221.671133154607, 8527.70153044653, 8824.602892869836, 8856.627222780351, 523.39809219398, 564.7938502446659, 571.151839518315, 574.9827505174851, 600.86780908201, 4083.612056854594, 4129.112240868228, 4178.1643671265865, 4270.316749320094, 4809.470958194595, 91941.54029229812, 100081.0, 104460.75494308029, 105082.0, 108899.0, 81631.0, 85186.0, 97743.51128244313, 100246.49876750569, 101306.49346753219, 76537.0, 77717.22282777213, 79857.60071199607, 81422.59288703519, 83822.0, 9774.755631108994, 9903.158231550398, 9933.602655893972, 9982.0, 9999.250056245955, 45399.0, 50311.0, 51586.19448319291, 51820.22269665883, 55768.0, 76075.23924760903, 78703.60648196722, 79070.0, 79382.60308698419, 80842.0, 12653.683657908257, 12886.0, 12973.416196271002, 13126.934365328112, 13504.392302346221, 14574.562763117123, 14949.327280272197, 15158.31787569584, 15212.239388030333, 15318.693626127191, 13091.934540327238, 13301.86698133045, 13650.795238071636, 13707.383167757276, 13967.580972570839, 13063.412146453622, 13223.0, 13235.073544851768, 13322.40049197769, 13757.862421376058, 13329.0, 13332.200067995951, 13349.399277032751, 13553.119047261896, 13567.1859688419, 10737.355758654505, 10860.022597966221, 10973.177011723992, 11066.612668556561, 11254.437278136224, 11110.888931103065, 11222.158338124837, 11486.82769758471, 11513.358454357473, 11518.308901465938], "value": 7475.3039601266655, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1656.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 176.0, 159.0, 114.0, 107.0, 95.0, 174.0, 174.0, 178.0, 172.0], "value": 150.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 112.0, 98.0, 182.0, 102.0, 121.0, 111.0, 100.0, 128.0, 137.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 258.0, 274.0, 199.0, 229.0, 184.0, 200.0, 272.0, 278.0, 209.0], "value": 231.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 50.0, 86.0, 72.0, 82.0, 85.0, 52.0, 64.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 57.0, 97.0, 105.0, 58.0, 87.0, 104.0, 103.0, 104.0, 113.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 111.0, 112.0, 128.0, 174.0, 109.0, 112.0, 111.0, 111.0], "value": 119.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 135.0, 116.0, 176.0, 170.0, 102.0, 99.0, 128.0, 124.0, 99.0], "value": 124.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 101.0, 93.0, 86.0, 144.0, 155.0, 93.0, 93.0, 93.0], "value": 104.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 62.0, 62.0, 62.0, 63.0, 64.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 80.0, 75.0, 76.0, 70.0, 70.0, 71.0, 73.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 89.0, 90.0, 90.0, 88.0, 113.0, 111.0, 84.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 158.0, 155.0, 154.0, 158.0, 154.0, 157.0, 192.0, 147.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 175.0, 175.0, 175.0, 192.0, 237.0, 201.0, 172.0, 172.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 69.0, 68.0, 67.0, 68.0, 67.0, 69.0, 74.0], "value": 68.7, "unit": "score"}]}]} 13:15:42 INFO - Return code: 0 13:15:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:15:42 ERROR - # TBPL SUCCESS # 13:15:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:15:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:15:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:15:42 INFO - 2016-12-20 13:15:42.692 screenresolution[1934:22642] starting screenresolution argv=screenresolution get 13:15:42 INFO - 2016-12-20 13:15:42.694 screenresolution[1934:22642] Display 0: 1600x1200x32@60 13:15:42 INFO - 2016-12-20 13:15:42.700 screenresolution[1935:22645] starting screenresolution argv=screenresolution list 13:15:42 INFO - Available Modes on Display 0 13:15:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:15:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:15:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:15:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:15:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:15:42 INFO - Intel Iris: 13:15:42 INFO - Chipset Model: Intel Iris 13:15:42 INFO - Type: GPU 13:15:42 INFO - Bus: Built-In 13:15:42 INFO - VRAM (Dynamic, Max): 1536 MB 13:15:42 INFO - Vendor: Intel (0x8086) 13:15:42 INFO - Device ID: 0x0a2e 13:15:42 INFO - Revision ID: 0x0009 13:15:42 INFO - Displays: 13:15:42 INFO - Display: 13:15:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:15:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:15:42 INFO - Display Serial Number: 1600x1200 60 13:15:42 INFO - Main Display: Yes 13:15:42 INFO - Mirror: Off 13:15:42 INFO - Online: Yes 13:15:42 INFO - Rotation: Supported 13:15:42 INFO - Return code: 0 13:15:42 INFO - Running post-action listener: _resource_record_post_action 13:15:42 INFO - [mozharness: 2016-12-20 21:15:42.944617Z] Finished run-tests step (success) 13:15:42 INFO - Running post-run listener: _resource_record_post_run 13:15:43 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 2291200; Write bytes: 555525120; Read time: 15; Write time: 1733 13:15:43 INFO - TinderboxPrint: CPU usage
54.6% 13:15:43 INFO - TinderboxPrint: I/O read bytes / time
2,291,200 / 15 13:15:43 INFO - TinderboxPrint: I/O write bytes / time
555,525,120 / 1,733 13:15:43 INFO - TinderboxPrint: CPU idle
2,184.0 (45.4%) 13:15:43 INFO - TinderboxPrint: CPU system
974.3 (20.3%) 13:15:43 INFO - TinderboxPrint: CPU user
1,651.4 (34.3%) 13:15:43 INFO - TinderboxPrint: Swap in / out
252,575,744 / 0 13:15:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250341888; Write bytes: 252270592; Read time: 18267; Write time: 554 13:15:43 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 1299968; Write bytes: 301759488; Read time: 11; Write time: 1167 13:15:43 INFO - Running post-run listener: _upload_blobber_files 13:15:43 INFO - Blob upload gear active. 13:15:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:43 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 13:15:43 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'] 13:15:43 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 13:15:43 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:15:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:15:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:44 INFO - (blobuploader) - INFO - Done attempting. 13:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:45 INFO - (blobuploader) - INFO - Done attempting. 13:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:15:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:46 INFO - (blobuploader) - INFO - Done attempting. 13:15:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:50 INFO - (blobuploader) - INFO - Done attempting. 13:15:50 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:50 INFO - Return code: 0 13:15:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba37b8755a232588abcea463bab9fa425b748a3a3cb8dfc73145701ffb0ceecba401b1654c7ffeaa0396357d235ce73b618656782c4b99e255cbf2c1d289fb6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d61d078c028b57fe38aced6ca79dbc9f0a0a602964b645471e8aaffc1b75110162c3e6d73ba8a6caad57b575bc3b884024502137064bad392f7747d5de711290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195006eff1a8a7379f226e2320eea31730b9f251c11be9479582fcdb8b1cfa8cab1342729de3057eba6c4e914a7d94e27590208fb8ce25ab058289fccc009be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5d8c7fc0f32e91f44df4cb6c52faa813e95b60c8dba21a7c7b8b897287f7c75db68b98846018f241b5edae45b72bf2483658136e7c46166ff4bdebb46d52b20"} 13:15:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:50 INFO - Contents: 13:15:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba37b8755a232588abcea463bab9fa425b748a3a3cb8dfc73145701ffb0ceecba401b1654c7ffeaa0396357d235ce73b618656782c4b99e255cbf2c1d289fb6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d61d078c028b57fe38aced6ca79dbc9f0a0a602964b645471e8aaffc1b75110162c3e6d73ba8a6caad57b575bc3b884024502137064bad392f7747d5de711290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195006eff1a8a7379f226e2320eea31730b9f251c11be9479582fcdb8b1cfa8cab1342729de3057eba6c4e914a7d94e27590208fb8ce25ab058289fccc009be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5d8c7fc0f32e91f44df4cb6c52faa813e95b60c8dba21a7c7b8b897287f7c75db68b98846018f241b5edae45b72bf2483658136e7c46166ff4bdebb46d52b20"} 13:15:50 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:50 INFO - Copying logs to upload dir... 13:15:50 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.876904 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-20 13:15:50.087864) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 13:15:50.091207) ========= 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.8OFuYmTAre/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.WOcPvKfYpu/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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/bba37b8755a232588abcea463bab9fa425b748a3a3cb8dfc73145701ffb0ceecba401b1654c7ffeaa0396357d235ce73b618656782c4b99e255cbf2c1d289fb6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d61d078c028b57fe38aced6ca79dbc9f0a0a602964b645471e8aaffc1b75110162c3e6d73ba8a6caad57b575bc3b884024502137064bad392f7747d5de711290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195006eff1a8a7379f226e2320eea31730b9f251c11be9479582fcdb8b1cfa8cab1342729de3057eba6c4e914a7d94e27590208fb8ce25ab058289fccc009be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5d8c7fc0f32e91f44df4cb6c52faa813e95b60c8dba21a7c7b8b897287f7c75db68b98846018f241b5edae45b72bf2483658136e7c46166ff4bdebb46d52b20"} build_url:https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/MI4Ey_ljSw-i0ViRGEdtaA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba37b8755a232588abcea463bab9fa425b748a3a3cb8dfc73145701ffb0ceecba401b1654c7ffeaa0396357d235ce73b618656782c4b99e255cbf2c1d289fb6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d61d078c028b57fe38aced6ca79dbc9f0a0a602964b645471e8aaffc1b75110162c3e6d73ba8a6caad57b575bc3b884024502137064bad392f7747d5de711290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195006eff1a8a7379f226e2320eea31730b9f251c11be9479582fcdb8b1cfa8cab1342729de3057eba6c4e914a7d94e27590208fb8ce25ab058289fccc009be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5d8c7fc0f32e91f44df4cb6c52faa813e95b60c8dba21a7c7b8b897287f7c75db68b98846018f241b5edae45b72bf2483658136e7c46166ff4bdebb46d52b20"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 13:15:50.124924) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 13:15:50.125236) ========= 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.8OFuYmTAre/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.WOcPvKfYpu/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.005007 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 13:15:50.173638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 13:15:50.173961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 13:15:50.174277) ========= ========= Total master_lag: 0.19 =========