builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1482420952.09 results: success (0) buildid: 20161222030229 builduid: bb0f02f22436450da9022035d84eb747 revision: f179934df0c1bab590c558485d419c7910e41325 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.086139) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.086579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.095477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.152410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.152853) ========= 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.Qy7inS2MSo/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.RfphjGPyHF/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-22 07:35:52-- 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% 143M=0s 2016-12-22 07:35:52 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.513136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.690002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.690450) ========= 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.Qy7inS2MSo/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.RfphjGPyHF/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.019415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.742425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 07:35:52.743121) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f179934df0c1bab590c558485d419c7910e41325 --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 f179934df0c1bab590c558485d419c7910e41325 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qy7inS2MSo/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.RfphjGPyHF/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-22 07:35:52,816 truncating revision to first 12 chars 2016-12-22 07:35:52,816 Setting DEBUG logging. 2016-12-22 07:35:52,816 attempt 1/10 2016-12-22 07:35:52,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f179934df0c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 07:35:54,323 unpacking tar archive at: mozilla-central-f179934df0c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.743802 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 07:35:54.514762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:54.515390) ========= script_repo_revision: f179934df0c1bab590c558485d419c7910e41325 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:54.516303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:54.516838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:54.539114) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-22 07:35:54.539812) ========= /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.Qy7inS2MSo/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.RfphjGPyHF/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:35:54 INFO - MultiFileLogger online at 20161222 07:35:54 in /builds/slave/test 07:35:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:35:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:54 INFO - {'append_to_log': False, 07:35:54 INFO - 'base_work_dir': '/builds/slave/test', 07:35:54 INFO - 'blob_upload_branch': 'Firefox', 07:35:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:54 INFO - 'branch': 'Firefox', 07:35:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:54 INFO - 'config_files': ('talos/mac_config.py',), 07:35:54 INFO - 'default_actions': ('clobber', 07:35:54 INFO - 'read-buildbot-config', 07:35:54 INFO - 'download-and-extract', 07:35:54 INFO - 'populate-webroot', 07:35:54 INFO - 'create-virtualenv', 07:35:54 INFO - 'install', 07:35:54 INFO - 'run-tests'), 07:35:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:54 INFO - 'download_minidump_stackwalk': True, 07:35:54 INFO - 'download_symbols': 'ondemand', 07:35:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:54 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:54 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:54 INFO - 'installer_path': 'installer.exe', 07:35:54 INFO - 'log_level': 'info', 07:35:54 INFO - 'log_name': 'talos', 07:35:54 INFO - 'log_to_console': True, 07:35:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:54 INFO - 'opt_config_files': (), 07:35:54 INFO - 'pip_index': False, 07:35:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:54 INFO - 'cmd': ('bash', 07:35:54 INFO - '-c', 07:35:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:54 INFO - 'enabled': True, 07:35:54 INFO - 'halt_on_failure': False, 07:35:54 INFO - 'name': 'check_screen_resolution'},), 07:35:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:54 INFO - 'cmd': ('bash', 07:35:54 INFO - '-c', 07:35:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:54 INFO - 'enabled': True, 07:35:54 INFO - 'halt_on_failure': False, 07:35:54 INFO - 'name': 'check_screen_resolution'},), 07:35:54 INFO - 'run_cmd_checks_enabled': True, 07:35:54 INFO - 'sps_profile': False, 07:35:54 INFO - 'sps_profile_interval': 0, 07:35:54 INFO - 'suite': 'dromaeojs-e10s', 07:35:54 INFO - 'system_bits': '32', 07:35:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:54 INFO - 'title': 't-yosemite-r7-0139', 07:35:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:54 INFO - 'use_talos_json': True, 07:35:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:54 INFO - 'work_dir': 'build'} 07:35:54 INFO - [mozharness: 2016-12-22 15:35:54.741950Z] Running clobber step. 07:35:54 INFO - Running pre-action listener: _resource_record_pre_action 07:35:54 INFO - Running main action method: clobber 07:35:54 INFO - rmtree: /builds/slave/test/build 07:35:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:55 INFO - Running post-action listener: _resource_record_post_action 07:35:55 INFO - [mozharness: 2016-12-22 15:35:55.109134Z] Finished clobber step (success) 07:35:55 INFO - [mozharness: 2016-12-22 15:35:55.109339Z] Running read-buildbot-config step. 07:35:55 INFO - Running pre-action listener: _resource_record_pre_action 07:35:55 INFO - Running main action method: read_buildbot_config 07:35:55 INFO - Using buildbot properties: 07:35:55 INFO - { 07:35:55 INFO - "project": "", 07:35:55 INFO - "product": "firefox", 07:35:55 INFO - "script_repo_revision": "production", 07:35:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:35:55 INFO - "repository": "", 07:35:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:35:55 INFO - "buildid": "20161222030229", 07:35:55 INFO - "stage_platform": "macosx64", 07:35:55 INFO - "basedir": "/builds/slave/test", 07:35:55 INFO - "nightly_build": "True", 07:35:55 INFO - "buildnumber": 18, 07:35:55 INFO - "slavename": "t-yosemite-r7-0139", 07:35:55 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:35:55 INFO - "platform": "yosemite_r7", 07:35:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:35:55 INFO - "branch": "mozilla-central", 07:35:55 INFO - "repo_path": "mozilla-central", 07:35:55 INFO - "revision": "f179934df0c1bab590c558485d419c7910e41325", 07:35:55 INFO - "pgo_build": "False", 07:35:55 INFO - "builduid": "bb0f02f22436450da9022035d84eb747", 07:35:55 INFO - "slavebuilddir": "test" 07:35:55 INFO - } 07:35:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:35:55 INFO - Running post-action listener: _resource_record_post_action 07:35:55 INFO - [mozharness: 2016-12-22 15:35:55.113680Z] Finished read-buildbot-config step (success) 07:35:55 INFO - [mozharness: 2016-12-22 15:35:55.113811Z] Running download-and-extract step. 07:35:55 INFO - Running pre-action listener: _resource_record_pre_action 07:35:55 INFO - Running main action method: download_and_extract 07:35:55 INFO - mkdir: /builds/slave/test/build/tests 07:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:55 INFO - trying https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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 07:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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 07:35:55 INFO - Downloaded 1199 bytes. 07:35:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:35:55 INFO - Using the following test package requirements: 07:35:55 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:35:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:35:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:35:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'jsshell-mac.zip'], 07:35:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:35:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:35:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:35:55 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:35:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:35:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:55 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:35:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:35:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:35:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:35:55 INFO - Fetch https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:35:58 INFO - Expected file size: 16289308 07:35:58 INFO - Obtained file size: 16289308 07:36:05 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 07:36:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:36:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:36:05 INFO - Fetch https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:36:06 INFO - Expected file size: 16289308 07:36:06 INFO - Obtained file size: 16289308 07:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:36:14 INFO - Expected file size: 14409734 07:36:14 INFO - Obtained file size: 14409734 07:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:14 INFO - trying https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:36:14 INFO - Downloading https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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 07:36:17 INFO - Downloaded 69750756 bytes. 07:36:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:36:17 INFO - mkdir: /builds/slave/test/properties 07:36:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:17 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:17 INFO - Contents: 07:36:17 INFO - build_url:https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - Running post-action listener: set_extra_try_arguments 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.498227Z] Finished download-and-extract step (success) 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.498386Z] Running populate-webroot step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: populate_webroot 07:36:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:18 INFO - '--tppagecycles', 07:36:18 INFO - '7'], 07:36:18 INFO - 'tests': ['tsvgm']}}, 07:36:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['damp', 'tps']}, 07:36:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'tests': ['damp', 'tps']}, 07:36:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['dromaeo_dom']}, 07:36:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['basic_compositor_video']}, 07:36:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tsvgx', 07:36:18 INFO - 'tsvgr_opacity', 07:36:18 INFO - 'tart', 07:36:18 INFO - 'tscrollx', 07:36:18 INFO - 'cart', 07:36:18 INFO - 'tsvg_static']}, 07:36:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:18 INFO - 'tsvgr_opacity', 07:36:18 INFO - 'tart', 07:36:18 INFO - 'tscrollx', 07:36:18 INFO - 'cart', 07:36:18 INFO - 'tsvg_static']}, 07:36:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tp5o']}, 07:36:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:36:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s', 07:36:18 INFO - '--xperf_path', 07:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:18 INFO - 'tests': ['tp5n']}, 07:36:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--xperf_path', 07:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:18 INFO - 'tests': ['tp5n']}}, 07:36:18 INFO - 'talos.zip': {'path': '', 07:36:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.516529Z] Finished populate-webroot step (success) 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.516658Z] Running create-virtualenv step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: create_virtualenv 07:36:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:18 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 07:36:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:18 INFO - Using real prefix '/tools/python27' 07:36:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:22 INFO - Installing pip.................done. 07:36:22 INFO - Return code: 0 07:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:36:22 INFO - Reading from file tmpfile_stdout 07:36:22 INFO - Output received: 07:36:22 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) 07:36:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36: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', 'pip>=1.5'] in /builds/slave/test/build 07:36: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 pip>=1.5 07:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:22 INFO - 'HOME': '/Users/cltbld', 07:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:22 INFO - 'LOGNAME': 'cltbld', 07:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:22 INFO - 'MOZ_NO_REMOTE': '1', 07:36:22 INFO - 'NO_EM_RESTART': '1', 07:36:22 INFO - 'PAGER': '/bin/cat', 07:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:22 INFO - 'PWD': '/builds/slave/test', 07:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:22 INFO - 'SHELL': '/bin/bash', 07:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:22 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:22 INFO - 'USER': 'cltbld', 07:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:22 INFO - 'XPC_FLAGS': '0x0', 07:36:22 INFO - 'XPC_SERVICE_NAME': '0', 07:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:36:22 INFO - Cleaning up... 07:36:22 INFO - Return code: 0 07:36:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:22 INFO - 'HOME': '/Users/cltbld', 07:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:22 INFO - 'LOGNAME': 'cltbld', 07:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:22 INFO - 'MOZ_NO_REMOTE': '1', 07:36:22 INFO - 'NO_EM_RESTART': '1', 07:36:22 INFO - 'PAGER': '/bin/cat', 07:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:22 INFO - 'PWD': '/builds/slave/test', 07:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:22 INFO - 'SHELL': '/bin/bash', 07:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:22 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:22 INFO - 'USER': 'cltbld', 07:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:22 INFO - 'XPC_FLAGS': '0x0', 07:36:22 INFO - 'XPC_SERVICE_NAME': '0', 07:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:23 INFO - Downloading/unpacking psutil>=3.1.1 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:26 INFO - Installing collected packages: psutil 07:36:26 INFO - Running setup.py install for psutil 07:36:27 INFO - building 'psutil._psutil_osx' extension 07:36:27 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 07:36:27 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 07:36:27 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 07:36:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:36:27 INFO - building 'psutil._psutil_posix' extension 07:36:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:36:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:36:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:36:27 INFO - ^ 07:36:27 INFO - 1 warning generated. 07:36:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:27 INFO - Successfully installed psutil 07:36:27 INFO - Cleaning up... 07:36:27 INFO - Return code: 0 07:36:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:27 INFO - 'HOME': '/Users/cltbld', 07:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:27 INFO - 'LOGNAME': 'cltbld', 07:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:27 INFO - 'MOZ_NO_REMOTE': '1', 07:36:27 INFO - 'NO_EM_RESTART': '1', 07:36:27 INFO - 'PAGER': '/bin/cat', 07:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:27 INFO - 'PWD': '/builds/slave/test', 07:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:27 INFO - 'SHELL': '/bin/bash', 07:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:27 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:27 INFO - 'USER': 'cltbld', 07:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:27 INFO - 'XPC_FLAGS': '0x0', 07:36:27 INFO - 'XPC_SERVICE_NAME': '0', 07:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 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 07:36:28 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 07:36:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:30 INFO - Installing collected packages: mozsystemmonitor 07:36:30 INFO - Running setup.py install for mozsystemmonitor 07:36:30 INFO - Successfully installed mozsystemmonitor 07:36:30 INFO - Cleaning up... 07:36:31 INFO - Return code: 0 07:36:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:31 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')]} 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:31 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')]} 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:31 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 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:31 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 07:36:31 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 07:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:31 INFO - 'HOME': '/Users/cltbld', 07:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:31 INFO - 'LOGNAME': 'cltbld', 07:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:31 INFO - 'MOZ_NO_REMOTE': '1', 07:36:31 INFO - 'NO_EM_RESTART': '1', 07:36:31 INFO - 'PAGER': '/bin/cat', 07:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:31 INFO - 'PWD': '/builds/slave/test', 07:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:31 INFO - 'SHELL': '/bin/bash', 07:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:31 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:31 INFO - 'USER': 'cltbld', 07:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:31 INFO - 'XPC_FLAGS': '0x0', 07:36:31 INFO - 'XPC_SERVICE_NAME': '0', 07:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:34 INFO - warning: no files found matching '*.txt' 07:36:34 INFO - no previously-included directories found matching 'build' 07:36:34 INFO - no previously-included directories found matching 'dist' 07:36:34 INFO - no previously-included directories found matching '.git*' 07:36:34 INFO - Installing collected packages: jsonschema, functools32 07:36:34 INFO - Running setup.py install for functools32 07:36:34 INFO - warning: no files found matching '*.txt' 07:36:34 INFO - no previously-included directories found matching 'build' 07:36:34 INFO - no previously-included directories found matching 'dist' 07:36:34 INFO - no previously-included directories found matching '.git*' 07:36:34 INFO - Successfully installed jsonschema functools32 07:36:34 INFO - Cleaning up... 07:36:34 INFO - Return code: 0 07:36:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:34 INFO - 'HOME': '/Users/cltbld', 07:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:34 INFO - 'LOGNAME': 'cltbld', 07:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:34 INFO - 'MOZ_NO_REMOTE': '1', 07:36:34 INFO - 'NO_EM_RESTART': '1', 07:36:34 INFO - 'PAGER': '/bin/cat', 07:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:34 INFO - 'PWD': '/builds/slave/test', 07:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:34 INFO - 'SHELL': '/bin/bash', 07:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:34 INFO - 'USER': 'cltbld', 07:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:34 INFO - 'XPC_FLAGS': '0x0', 07:36:34 INFO - 'XPC_SERVICE_NAME': '0', 07:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:35 INFO - Cleaning up... 07:36:35 INFO - Return code: 0 07:36:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:35 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')]} 07:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:35 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')]} 07:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:35 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 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:35 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 07:36:35 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 07:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:35 INFO - 'HOME': '/Users/cltbld', 07:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:35 INFO - 'LOGNAME': 'cltbld', 07:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:35 INFO - 'MOZ_NO_REMOTE': '1', 07:36:35 INFO - 'NO_EM_RESTART': '1', 07:36:35 INFO - 'PAGER': '/bin/cat', 07:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:35 INFO - 'PWD': '/builds/slave/test', 07:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:35 INFO - 'SHELL': '/bin/bash', 07:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:35 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:35 INFO - 'USER': 'cltbld', 07:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:35 INFO - 'XPC_FLAGS': '0x0', 07:36:35 INFO - 'XPC_SERVICE_NAME': '0', 07:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:37 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:39 INFO - Downloading docopt-0.6.1.tar.gz 07:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:39 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:39 INFO - Running setup.py install for blobuploader 07:36:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:39 INFO - Running setup.py install for requests 07:36:39 INFO - Running setup.py install for docopt 07:36:40 INFO - Successfully installed blobuploader requests docopt 07:36:40 INFO - Cleaning up... 07:36:40 INFO - Return code: 0 07:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 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 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:40 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 07:36:40 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 07:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:40 INFO - 'HOME': '/Users/cltbld', 07:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:40 INFO - 'LOGNAME': 'cltbld', 07:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:40 INFO - 'MOZ_NO_REMOTE': '1', 07:36:40 INFO - 'NO_EM_RESTART': '1', 07:36:40 INFO - 'PAGER': '/bin/cat', 07:36:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:40 INFO - 'PWD': '/builds/slave/test', 07:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:40 INFO - 'SHELL': '/bin/bash', 07:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:40 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:40 INFO - 'USER': 'cltbld', 07:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:40 INFO - 'XPC_FLAGS': '0x0', 07:36:40 INFO - 'XPC_SERVICE_NAME': '0', 07:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:40 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mg8e1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:40 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bpCm6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:40 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-uyUbyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:40 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-WRkM8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:40 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-VqJjjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:40 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-g9gXcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-uCWnu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-5H8MvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gTHBjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-tPOcg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-1D5DRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-avqV4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-WLDTwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-lBQpf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:41 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-hAKFDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-RB5Dax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gukV2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:42 INFO - Running setup.py install for manifestparser 07:36:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:42 INFO - Running setup.py install for mozcrash 07:36:42 INFO - Running setup.py install for mozdebug 07:36:42 INFO - Running setup.py install for mozdevice 07:36:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:42 INFO - Running setup.py install for mozfile 07:36:42 INFO - Running setup.py install for mozhttpd 07:36:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozinfo 07:36:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozInstall 07:36:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozleak 07:36:43 INFO - Running setup.py install for mozlog 07:36:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for moznetwork 07:36:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozprocess 07:36:44 INFO - Running setup.py install for mozprofile 07:36:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozrunner 07:36:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozscreenshot 07:36:44 INFO - Running setup.py install for moztest 07:36:44 INFO - Running setup.py install for mozversion 07:36:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:44 INFO - 'HOME': '/Users/cltbld', 07:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:44 INFO - 'LOGNAME': 'cltbld', 07:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:44 INFO - 'MOZ_NO_REMOTE': '1', 07:36:44 INFO - 'NO_EM_RESTART': '1', 07:36:44 INFO - 'PAGER': '/bin/cat', 07:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:44 INFO - 'PWD': '/builds/slave/test', 07:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:44 INFO - 'SHELL': '/bin/bash', 07:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:44 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:44 INFO - 'USER': 'cltbld', 07:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:44 INFO - 'XPC_FLAGS': '0x0', 07:36:44 INFO - 'XPC_SERVICE_NAME': '0', 07:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mTswAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-SjQidb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-vy5aYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-dFCGrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-KKprmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-x83wAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bUPhA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-7JUE16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-SGCfy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9D8LhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-5KUg8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-rNLh87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Ln3Xtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ZYOSVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-qFeUCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-6hFcSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-fJm5pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:49 INFO - Downloading blessings-1.6.tar.gz 07:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:49 INFO - Installing collected packages: blessings 07:36:49 INFO - Running setup.py install for blessings 07:36:49 INFO - Successfully installed blessings 07:36:49 INFO - Cleaning up... 07:36:49 INFO - Return code: 0 07:36:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:50 INFO - Reading from file tmpfile_stdout 07:36:50 INFO - Current package versions: 07:36:50 INFO - blessings == 1.6 07:36:50 INFO - blobuploader == 1.2.4 07:36:50 INFO - docopt == 0.6.1 07:36:50 INFO - functools32 == 3.2.3-2 07:36:50 INFO - jsonschema == 2.5.1 07:36:50 INFO - manifestparser == 1.1 07:36:50 INFO - mozInstall == 1.12 07:36:50 INFO - mozcrash == 1.0 07:36:50 INFO - mozdebug == 0.1 07:36:50 INFO - mozdevice == 0.49 07:36:50 INFO - mozfile == 1.2 07:36:50 INFO - mozhttpd == 0.7 07:36:50 INFO - mozinfo == 0.9 07:36:50 INFO - mozleak == 0.1 07:36:50 INFO - mozlog == 3.4 07:36:50 INFO - moznetwork == 0.27 07:36:50 INFO - mozprocess == 0.23 07:36:50 INFO - mozprofile == 0.28 07:36:50 INFO - mozrunner == 6.13 07:36:50 INFO - mozscreenshot == 0.1 07:36:50 INFO - mozsystemmonitor == 0.3 07:36:50 INFO - moztest == 0.7 07:36:50 INFO - mozversion == 1.4 07:36:50 INFO - psutil == 3.1.1 07:36:50 INFO - requests == 1.2.3 07:36:50 INFO - wsgiref == 0.1.2 07:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 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 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:50 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 07:36:50 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 07:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:50 INFO - 'HOME': '/Users/cltbld', 07:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:50 INFO - 'LOGNAME': 'cltbld', 07:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:50 INFO - 'MOZ_NO_REMOTE': '1', 07:36:50 INFO - 'NO_EM_RESTART': '1', 07:36:50 INFO - 'PAGER': '/bin/cat', 07:36:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:50 INFO - 'PWD': '/builds/slave/test', 07:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:50 INFO - 'SHELL': '/bin/bash', 07:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:50 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:50 INFO - 'USER': 'cltbld', 07:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:50 INFO - 'XPC_FLAGS': '0x0', 07:36:50 INFO - 'XPC_SERVICE_NAME': '0', 07:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:36:50 INFO - Cleaning up... 07:36:50 INFO - Return code: 0 07:36:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11046bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11046e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f937ad8f0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, '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.Qy7inS2MSo/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.RfphjGPyHF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 07:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:50 INFO - 'HOME': '/Users/cltbld', 07:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:50 INFO - 'LOGNAME': 'cltbld', 07:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:50 INFO - 'MOZ_NO_REMOTE': '1', 07:36:50 INFO - 'NO_EM_RESTART': '1', 07:36:50 INFO - 'PAGER': '/bin/cat', 07:36:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:50 INFO - 'PWD': '/builds/slave/test', 07:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:50 INFO - 'SHELL': '/bin/bash', 07:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:36:50 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:50 INFO - 'USER': 'cltbld', 07:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:50 INFO - 'XPC_FLAGS': '0x0', 07:36:50 INFO - 'XPC_SERVICE_NAME': '0', 07:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:50 INFO - Cleaning up... 07:36:50 INFO - Return code: 0 07:36:50 INFO - Running post-action listener: _resource_record_post_action 07:36:50 INFO - Running post-action listener: _start_resource_monitoring 07:36:50 INFO - Starting resource monitoring. 07:36:50 INFO - [mozharness: 2016-12-22 15:36:50.805060Z] Finished create-virtualenv step (success) 07:36:50 INFO - [mozharness: 2016-12-22 15:36:50.806026Z] Running install step. 07:36:50 INFO - Running pre-action listener: _resource_record_pre_action 07:36:50 INFO - Running main action method: install 07:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:51 INFO - Reading from file tmpfile_stdout 07:36:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:51 INFO - Reading from file tmpfile_stdout 07:36:51 INFO - Output received: 07:36:51 INFO - Usage: mozinstall [options] installer 07:36:51 INFO - Options: 07:36:51 INFO - -h, --help show this help message and exit 07:36:51 INFO - -d DEST, --destination=DEST 07:36:51 INFO - Directory to install application into. [default: 07:36:51 INFO - "/builds/slave/test"] 07:36:51 INFO - --app=APP Application being installed. [default: firefox] 07:36:51 INFO - mkdir: /builds/slave/test/build/application 07:36:51 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'] 07:36:51 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 07:37:13 INFO - Reading from file tmpfile_stdout 07:37:13 INFO - Output received: 07:37:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 07:37:13 INFO - Running post-action listener: _resource_record_post_action 07:37:13 INFO - [mozharness: 2016-12-22 15:37:13.085507Z] Finished install step (success) 07:37:13 INFO - [mozharness: 2016-12-22 15:37:13.085650Z] Running run-tests step. 07:37:13 INFO - Running pre-action listener: _resource_record_pre_action 07:37:13 INFO - Running main action method: run_tests 07:37:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:13 INFO - 2016-12-22 07:37:13.100 screenresolution[2291:283221] starting screenresolution argv=screenresolution get 07:37:13 INFO - 2016-12-22 07:37:13.103 screenresolution[2291:283221] Display 0: 1600x1200x32@60 07:37:13 INFO - 2016-12-22 07:37:13.109 screenresolution[2292:283224] starting screenresolution argv=screenresolution list 07:37:13 INFO - Available Modes on Display 0 07:37:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:13 INFO - Intel Iris: 07:37:13 INFO - Chipset Model: Intel Iris 07:37:13 INFO - Type: GPU 07:37:13 INFO - Bus: Built-In 07:37:13 INFO - VRAM (Dynamic, Max): 1536 MB 07:37:13 INFO - Vendor: Intel (0x8086) 07:37:13 INFO - Device ID: 0x0a2e 07:37:13 INFO - Revision ID: 0x0009 07:37:13 INFO - Displays: 07:37:13 INFO - Display: 07:37:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:13 INFO - Display Serial Number: 1600x1200 60 07:37:13 INFO - Main Display: Yes 07:37:13 INFO - Mirror: Off 07:37:13 INFO - Online: Yes 07:37:13 INFO - Rotation: Supported 07:37:13 INFO - Return code: 0 07:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:13 INFO - Python 2.7.3 07:37:13 INFO - Return code: 0 07:37:13 INFO - grabbing minidump binary from tooltool 07:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110249d30>, '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 0x110170db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:37:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:37:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:37:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:13 INFO - Return code: 0 07:37:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:37:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:37:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 07:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --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 07:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qy7inS2MSo/Render', 07:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:13 INFO - 'HOME': '/Users/cltbld', 07:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:13 INFO - 'LOGNAME': 'cltbld', 07:37:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:13 INFO - 'MOZ_NO_REMOTE': '1', 07:37:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:13 INFO - 'NO_EM_RESTART': '1', 07:37:13 INFO - 'PAGER': '/bin/cat', 07:37:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:13 INFO - 'PWD': '/builds/slave/test', 07:37:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:13 INFO - 'SHELL': '/bin/bash', 07:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RfphjGPyHF/Listeners', 07:37:13 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 07:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:13 INFO - 'USER': 'cltbld', 07:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:13 INFO - 'XPC_FLAGS': '0x0', 07:37:13 INFO - 'XPC_SERVICE_NAME': '0', 07:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 07:37:13 INFO - mozversion application_buildid: 20161222030229 07:37:13 INFO - mozversion application_changeset: f179934df0c1bab590c558485d419c7910e41325 07:37:13 INFO - mozversion application_display_name: Nightly 07:37:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:13 INFO - mozversion application_name: Firefox 07:37:13 INFO - mozversion application_remotingname: firefox 07:37:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:13 INFO - mozversion application_vendor: Mozilla 07:37:13 INFO - mozversion application_version: 53.0a1 07:37:13 INFO - mozversion platform_buildid: 20161222030229 07:37:13 INFO - mozversion platform_changeset: f179934df0c1bab590c558485d419c7910e41325 07:37:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:13 INFO - mozversion platform_version: 53.0a1 07:37:13 INFO - using testdate: 1482421033 07:37:13 INFO - actual date: 1482421033 07:37:13 INFO - starting webserver on 'localhost:49410' 07:37:13 INFO - SUITE-START | Running 2 tests 07:37:13 INFO - TEST-START | dromaeo_css 07:37:13 INFO - operating with platform_type : mac_ 07:37:13 INFO - Initialising browser for dromaeo_css test... 07:37:13 INFO - TEST-INFO | started process 2302 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmp4RD1Sc/profile http://localhost:49410/getInfo.html) 07:37:16 INFO - PROCESS | 2302 | 2016-12-22 07:37:16.909 plugin-container[2306:283398] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x944f, name = 'com.apple.tsm.portname' 07:37:16 INFO - PROCESS | 2302 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:37:16 INFO - PROCESS | 2302 | 2016-12-22 07:37:16.910 plugin-container[2306:283398] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 07:37:16 INFO - PROCESS | 2302 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:37:16 INFO - PROCESS | 2302 | 2016-12-22 07:37:16.910 plugin-container[2306:283398] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:37:16 INFO - PROCESS | 2302 | __metrics Screen width/height:1600/1200 07:37:16 INFO - PROCESS | 2302 | colorDepth:24 07:37:16 INFO - PROCESS | 2302 | Browser inner width/height: 1024/689 07:37:16 INFO - PROCESS | 2302 | __metrics 07:37:17 ERROR - PROCESS | 2302 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3247: TypeError: this.tabs is undefined 07:37:17 INFO - TEST-INFO | 2302: exit 0 07:37:17 INFO - Browser initialized. 07:37:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:17 INFO - TEST-INFO | started process 2307 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmp4RD1Sc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:19 INFO - PROCESS | 2307 | 2016-12-22 07:37:19.993 plugin-container[2308:283522] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:37:19 INFO - PROCESS | 2307 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:37:19 INFO - PROCESS | 2307 | 2016-12-22 07:37:19.993 plugin-container[2308:283522] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:37:19 INFO - PROCESS | 2307 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:37:19 INFO - PROCESS | 2307 | 2016-12-22 07:37:19.993 plugin-container[2308:283522] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:37:29 INFO - PROCESS | 2307 | RSS: Main: 235307008 07:37:29 INFO - PROCESS | 2307 | 07:38:19 INFO - PROCESS | 2307 | 1482421099335 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] 07:40:31 INFO - PROCESS | 2307 | Cycle 1(1): loaded http://localhost:49410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49410/tests/dromaeo/cssquery-ext.html) 07:40:33 INFO - PROCESS | 2307 | RSS: Main: 253591552 07:40:33 INFO - PROCESS | 2307 | 07:43:36 INFO - PROCESS | 2307 | Cycle 1(1): loaded http://localhost:49410/tests/dromaeo/cssquery-ext.html (next: http://localhost:49410/tests/dromaeo/cssquery-jquery.html) 07:43:37 INFO - PROCESS | 2307 | RSS: Main: 263135232 07:43:37 INFO - PROCESS | 2307 | 07:46:39 INFO - PROCESS | 2307 | Cycle 1(1): loaded http://localhost:49410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49410/tests/dromaeo/cssquery-mootools.html) 07:46:39 INFO - PROCESS | 2307 | RSS: Main: 267501568 07:46:39 INFO - PROCESS | 2307 | 07:49:41 INFO - PROCESS | 2307 | Cycle 1(1): loaded http://localhost:49410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49410/tests/dromaeo/cssquery-prototype.html) 07:49:42 INFO - PROCESS | 2307 | RSS: Main: 267808768 07:49:42 INFO - PROCESS | 2307 | 07:52:45 INFO - PROCESS | 2307 | Cycle 1(1): loaded http://localhost:49410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49410/tests/dromaeo/cssquery-yui.html) 07:52:45 INFO - PROCESS | 2307 | RSS: Main: 272322560 07:52:45 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | Cycle 1(1): loaded http://localhost:49410/tests/dromaeo/cssquery-yui.html (next: http://localhost:49410/tests/dromaeo/cssquery-dojo.html) 07:55:48 INFO - PROCESS | 2307 | RSS: Main: 274743296 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | __start_tp_report 07:55:48 INFO - PROCESS | 2307 | _x_x_mozilla_page_load 07:55:48 INFO - PROCESS | 2307 | _x_x_mozilla_page_load_details 07:55:48 INFO - PROCESS | 2307 | |i|pagename|runs| 07:55:48 INFO - PROCESS | 2307 | |0;dojo.html;3277.4592192288274;3286.967130328697;3307.751918606105;3323.185819474229;3328.1346849819047;5407.134858422653;5466.043442397579;5469.316335458063;5474.616776825624;5515.531179849718;4560.338750881128;5609.691466969315;5614.29821272341;5619.241402410673;5657.717114144297;5034.899302013958;5070.72111033893;5082.364704411949;5177.456367081459;5200.791968321262;3839.577646458887;5180.740962951856;5186.299849520305;5208.843734687946;5234.37187537496;4087.448194493735;4391.8581168896;5168.198929165986;5183.481651834824;5213.113770658978;5027.648064635477;5084.694918304914;5100.566451851597;5118.667286626357;5134.358205224347;4957.429895562021;5055.595552355802;5058.46886076964;5075.187969924795;5142.3829140503;4216.746995180299;5493.587980901449;5554.2779438672715;5558.638688485235;5621.7751289948355;6092.66490343031;6110.388961103854;6124.816255512342;6132.172156758869;6135.69321533926;5919.378465261172;5930.436608522184;5937;5960.761569537213;6046.939530604725;5521.779128834842;5644.943550564483;5657.57568182388;5677.233573467529;5772.509336706343;5145.588352931756;6144.56988010835;6202.162708034448;6208.410201030895;6229.750809967551;6052.969735151296;6080.604760690541;6099.939000610026;6103.176071230416;6113.96943015291;5436.646617969819;5450.5367043800925;5472.2338872557875;5524.4199359067525;6059.36376680451;5003.624728145331;5997.580169388189;6035.728392222272;6081.57428979976;6109.5112391008615;4987.476314986947;5197.179159341562;5991.221141251696;6016.338202797689;6053.727582258809;4559.156556037144;4719.551642593948;4797.256425254021;4915.95084049155;4959.20652695567;3885.1452680410266;3973.8013099344917;4302.698811083257;4327;4388.9122217556105;4759.595434388047;5747.08046712524;5751.338596061423;5754.6547207167705;5763.9135412968835;4729.716217026989;6032.577719559677;6198.008318668992;6205.844853878599;6219.47134493564;4787.593054590398;5602.439756024446;5666.291713535808;5680.5455563554815;5730.541556675456;5259.132243179909;5296.04671159195;5304.787808487695;5317.282166907496;5321;6144.969275153596;6192.256929168529;6221.595596286227;6231.75072997075;6248.75004999804;6077.179580756541;6117.327094019565;6130.398136742091;6141.293751218667;6142.416470435302;6132.294322189991;6166.105914642441;6182.876342473215;6238.906416403848;6253.656048917172;5919.260092488439;5937.495312898452;5941.970290148522;6103.30736498198;6136.825445958321;6048.879022419439;6124.14262003311;6130.52043589939;6155.415235552616;6183.134361189527;4870.610351171968;6008.699565021644;6012.098185272244;6016.2479690038745;6051.75792968294;5293.602979776455;5425.593080519056;5839.970800145972;5851.356350801493;5920.111983202554;5005.34930459038;5629.746661400165;5730.885382292247;5739.110437882135;5743.511801496919;4855.781489832895;6033.577649564489;6037.215162029084;6041.728122234422;6077.878442431215;5790.536757059341;5831.854203644773;5845.269341332333;5846.649201047951;5883.499902508163 07:55:48 INFO - PROCESS | 2307 | |1;ext.html;421.7701352762744;428.78132152602166;491.60671462829725;507.2214151277789;560.5319558168928;36543.817280913594;37657.62342376579;38937.61062389375;39079.60920390795;39085.218295634106;39613;40478.59521404785;40524.59475405245;40567;40590;8293.046299675523;8507.361947853904;9024.23294020009;9351.57917893693;9377.578008989612;11219.60731374402;11497.770044599103;11526.538938442452;11671.941640291829;11673.999999999958;11531.192816502848;11563.884361156406;11567.248128871639;11585.478653460572;11591.362475063868;11361.375124368156;11367.772644547145;11434.371109588968;11442.828357574643;11455.713607159805;8658;10914.017738403581;11321.433928303552;11390.772184556345;11400.543978240861;31961.52057719136;38576.614233857865;39540.80229598862;39643.810685679186;39718.60281397178;3257.2833976525126;3260.250142467246;3317.336532693471;3369.326134773031;3473.9131521711906;27218.04736834221;27730.445391092064;28192.295192620142;28473.28816779597;28474.430511389863;3031.378567393679;3209.47043737783;3218.372417378612;3307.2393349529502;3320.8173550454717;445794;447100;452036.47963520273;454019;455429.72285138693;43608.78195609065;53219;53432.73283633557;53469;53564.73217633887;55226;55903.72048139733;55923.720381397834;55955.720221399446;56182.87634247292;14879.92560037193;15344.769828452581;15434.228288585526;15435.15106669144;15461;10871.184661150288;11141.832872506919;11799.587014454624;12059.939700301442;12147.878521214852;13375.665608359674;16956.558692511273;16969.83030169707;17008.829911700726;17031.48905532836;6334.461570766536;7597.848043039219;7605.809854753676;7620.618969051525;7691.269329413697;826.6817275349034;843.8143608406141;899.469313105271;983.896690847465;1069.198101423932;28623.284417889718;29693.40613187724;29707.851460742557;30075.397655401997;30207.848960755495;1017.97455063624;1028.8096702110133;1034.4000479721744;1037.7716902281486;1064.1114669251108;13541.796873046913;14814.703705925822;15216.695666086616;15464;15539.912206145462;559575;562226;562919;563126;564621;57503;57651.711741441024;57735.71132144312;57755;57807.71096144492;1200.8078707406949;1359.9796003059962;1386.9861301386857;1397.4619771388088;1405.5080721747306;23111.88444057769;28252.71747282501;28945;29600.703992959796;29794.70205298006;45764.771176143906;46537.767311164585;47496;47553;47590.76204618955;501606;501747;505293;506479;507633.6984616562;24590.893409796245;25154.11960581371;25241.24276271715;25701.843417046653;25988;40974.59025409708;41061.58938410697;41484.75545733633;41827.9543011415;41880.58119418767;26818.865905671126;28018.859905701156;31351.84324078365;34631;35205.29589408249;28076.017339393024;32211.35577288488;34332;35280.29439411146;35489.64510354863;31685.04944851658;33967.15082122868;34182.487262691575;34225.65774342225;35048.47427288542;30585;30811.229719257197;30819;31069.378612428078;31112.844435777675;22936;23441.648375274042;23684.763152368945;23813.523729524964;23832.285031449082 07:55:48 INFO - PROCESS | 2307 | |2;jquery.html;366.8862652577701;371.6487918916623;377.31893931453715;384.56544105161163;400.3034719587916;16162.11108389038;18190.636187276246;19642.803571964294;19711.408657740256;19848.503787405323;11451.312921224733;11597;11841.289522628627;11842.348670823101;11863.050955923527;5206.791728330872;5755.510781583571;5815.273090863642;5828.300603927534;5852.297724273072;3528.7353448491335;3964.048628329195;5235.057689615867;5250.713575174088;5547.750351234184;4864.854054378375;5588.133839254901;5888.411158884121;5889.263842019747;5904.7047647617665;5871.618344807595;7173.820654483654;7476.962615186916;7542.321191092828;7703.614819259071;6966;7232.638368081627;7284.307990740871;7318.34134927859;7325.450591205681;25092.247232583053;26010.08964686246;26135;26376.20871373862;26566.86716566424;2387.4270175158013;2425.151197081025;2471.5778537033807;2601.4797040591766;2952.9852350738324;14058.859411405858;15271.694566108616;16246.431374901822;16259;16728;1936.932207372735;1996.0518753592073;2034.6947957806299;2035.1248962945926;2036.3585470576868;131568;140674;141410.2929485356;143059;145373;16808.310670292696;20800.375988720363;20943.371698848754;21020.369388918356;22300.553988920456;34146.48780268298;34252;34267.657323426945;34280.80017199386;34296.314073718386;10159.238057145743;10355.326903751382;10470.47647617616;10690.51892664832;10701.625443109453;7264.309890560388;8525.616347264388;8569.35729820266;8640.006399264039;8779.868301975475;7855.6464959076975;8911.574148136267;9457.243420526342;9761.707148785548;9826.222908206237;1593.8246792852776;1670.2316934210157;3541.7166626669805;3849.40334248192;3908.90227744303;774.6939958716275;902.309733054214;953;963.6001059560344;995.8854731705802;19911.502212444517;20167.596648066956;20210.494737631678;20337.084831182634;20451.590968180553;935.8876934767871;936.765808547863;960.4477425480377;970.6263088710897;997.7655251016006;10556.102731267774;10951.397673127894;10968.670939871816;10992.406101115454;10998.285111467729;304469;306221;306295;307059;307448;105974;112231;114392;119626;119804.40097799455;927.6567669962158;938.779386844091;961.3222678011984;962.153305091515;970.5195928015678;18284.634307313514;18285.725714114033;18328.358507452176;18364.72452913234;18415;50946.49053509418;51600.48399515957;52085.7395713019;52129.70184174143;52181.95636087181;70841;73555.63222183855;74089.2591074104;74597;75470.5661792276;7092;7096.584069647128;7324.7070117196845;7430.591317477591;7612.885806712793;10196.694099177037;12033.398330083635;12411.193272437262;12546.633416458853;12627.684307892376;9899.554520046759;11081.667549973514;11172.738119605392;11227.27022743519;11233.38216398106;10640.8935910643;10813.459327033774;10873.347599144077;11273.379964102052;11300.378479183724;10840.620578279722;10935.453227338443;11352.318860868374;11448.198626096093;11525.711857203636;6052.243469566304;6191.4118158774845;6911.7558839409385;7302.707891684273;7437.293457121565;9003.909960900308;10910.018098371185;10923.508442119964;11172;11244.887551124384 07:55:48 INFO - PROCESS | 2307 | |3;mootools.html;1207.2877002568487;1427.514645020693;1622.8964304273097;1808.5840256740942;1856.9350072747457;7516.849663006737;7783.688652453895;8004.519728816268;8459.196376344253;8476.279516241118;6499.35006499351;8242.34061275098;8270.586470676457;8347.749567512968;8369.83260334793;2246.58465166945;2287.7597852225526;2290.9656355154684;2293.1286111277773;2303.0557471436714;2287.1880482428746;2321.721393432782;2336.194013065498;2338.567365037465;2348.424635964191;2263.094762095159;2286.9771302287013;2288.084766093559;2315.0623997281127;2317.154238702878;2262.083856038291;2263.0495192019307;2274.1358283852114;2282.5206706591553;2286.0741399733133;2243.1476039105037;2282.988585057081;2287.3938406322336;2321.3848330192513;2322.512272422793;8312.085670576233;8351.749447516584;8382.748517544484;8400.117987611335;8412.957935210285;4977.328060711794;5139.0749665060275;5146.536811686966;5147.382314122329;5154.92267615986;3135.216195951012;3211.3577284543185;3323.7008669219886;3381.8140002299865;3391.2200193955528;980.9950950245203;1001.5142655811925;1017.0338178730162;1026.6355443817413;1035.4926086217774;10298.021687939708;10515.526801293883;10641.73395665107;10740;10803.5678572857;4236.237477254123;4297.548757380492;4386.517483076859;4408.382826404306;4429.9778501107285;8481.279091277187;8556.786080347916;8575.785605359915;8575.871361929576;8576.099509551408;5057.519535644108;5059.114654935445;5059.19052951526;5068.087744206078;5071.366079240095;4199.9370009449885;4497.123061003073;4679.344891715163;4749.572538471554;4751.64362672801;2960.082374463923;3593.9820300898327;3597.226596281812;3611.963880361163;3719.7210209233876;1132.5300000499865;1146.1633007904277;1150.71232191952;1152.7867344541287;1159.3913195572393;758.9051368578928;810.5784991804229;898.4098146281046;903.6566104880103;931.5156118818312;4058.066644671683;4829.551134659588;4931.260310953314;5068.949310506921;5715.885682286331;368.9594144644087;411.2351027089611;428.01342904604564;431.5490312623316;431.5813660749131;2920.6349206349205;3828.2917660232947;3878.3406820840523;3942.8817135485983;4012;9579.473128977974;9847.950760246153;9924.354916930377;9928.305018648625;9947.651832185838;9876.901230987742;9901.405915645084;9917.404955702681;9953.80092398148;10026.147777438999;7388.963055184689;7633.503822251536;7790.415718821111;7863.13505514393;7962.840743185104;4686.531346865286;5235.016040856675;5760.222369980167;5775.8556036099435;5899.852503687443;9060.048694886942;9118.635254589743;9194.034626364402;9299.023602521638;9316.34785565004;9129.5891684873;9138.360314777901;9235.353525253167;9329.440233586007;9428.764280893032;6362.981922892315;6480.125183100221;6522.445592124723;6691.230508491391;6933.7226510939;7713.961430192813;7880.014998125234;7912.169222231813;7920.485168464032;7924.088729796147;6921.065656136358;7038.049863268393;7042.964785176041;7068.399186069241;7167.498275120692;5573.359063707563;6894.655267236518;6974.442044636518;7008.439324854102;7024.6136462493005;6551.901721474086;6612.570182938093;6684.6991885364305;6686.3313668632745;6698.765543205965;4170.47869016373;4857.611391088633;4862.95137048625;4875.463698993179;4939.678920870276;4766.785494652819;4793.5685788279225;4930.556249937523;4959.454460009469;5065.113605119163 07:55:48 INFO - PROCESS | 2307 | |4;prototype.html;296.94061187762446;349.4408945686901;360.525908430414;361.33875008734003;362.8367234744362;4507.661925355599;5016.072026675068;5136.33227680402;5267;5427.810026649068;4778.928316075253;5077.314562534057;5213.973930130344;5275.472452754722;5292.523672869441;3754.8122593870335;3904.8438062477467;4131.421600975866;4141.56513566075;4145.797718661584;3411.420058590033;3730.6455886690856;4142.964258935266;4150.83396664133;4175.686823488235;3788.7347885648014;3804.630333080089;3941.960580394202;3991.600839916014;4007.238624661305;3467.4452087666104;3534.939518144572;3654.488371627974;3988.7207895447186;3993.600639935983;2745.835249884993;3396.371671240828;3441.397755392821;3458.3774920514297;3491.9127021824656;3802.201537677091;4345.760983145926;4819.16871588794;4963.8262660806695;5049.939512702337;4243.045314804175;4564.7032942858605;4573.977130114328;4591.1965406053805;4601.976990115028;4645.372874661911;5038.74031492127;5289.809792796628;5562.582806289544;5636.718164091779;3525.307852230918;3645.9270814583824;3803.220339830328;3822.503074600312;3824.808759562011;5597.804076857331;5762.971185144047;5820.592558520905;5825.621334613236;5826.300843898717;3248.480243161083;3855.7300988931065;3861.5053376694136;3868.825902834379;3898.5516665583255;3295.489199174132;3652.160003199279;3702.852115844097;3915.667168290727;3947.2894878921497;4346.47842258931;4409.625181859514;4419.966053552282;4491.303847903515;4540.318952157137;4892.3884514435695;5040.067587496325;5582.241593897909;5588.469095435927;5595.692236926927;1001.4041645221082;1200.3218181727295;1204.1691233049169;1219.676785651803;1262.5959692898184;724.3915111306528;859.4585411191034;860.9354298427643;866.1814585217036;872.7381785464336;4621.376114224604;5103.57580149426;5147.562457191106;5178.084108879739;5214.270002199695;4458.843940462133;4717.457492388351;4825.021741086138;5303.756994404538;5539.667619942817;5383.2194331821665;5405.7837686492885;5420.205855900886;5455.345358556999;5503.752331145108;2460.766227208412;2910.8399038052685;2929.9012870173683;2938.6032885560603;2947.985260073686;5015.8212819987275;5627.409122042209;5676.460736230051;5777.393373695785;5809.489098470676;4961.82633607822;5441.374241962146;5751.405371642723;5777.046787280052;5820.748539064121;4747.240441529339;5143.819966301162;5368.161764338517;5778.537716982547;5864.560157988082;4741.67657847659;4982.7259500727805;5164.561012313845;5489.780408783764;5584.357798853184;4807.053143476897;5454.4545545445135;5483.506484416422;5496.450354964471;5573.52625026861;5475.986942415666;5594.216809646734;5687.980766827882;5857.4435428634215;5900.822975310747;3049.7865149439326;3255.690709382605;3388.7458440617547;3649.7371629589825;3658.414653655402;4925.261210818406;5014.774335155;5427.3215848019;5512.759629083424;5606.2431571738925;4437.933430998473;5390.380106287827;5403.567714582902;5424.83725488236;5451.936872309861;4588.659783510367;4923.163062279493;5050.9291190611675;5407.675539467645;5412.269343638558;4750.429948406213;4865.878353041202;4991.600671946163;5321.525490646868;5326.520613144836;4931.309616653743;5010.549050585465;5619.747111379916;5650.474371919641;5664.660120392789;4805.870620404133;5249.396319423316;5275.709835959059;5425.376081750649;5457.481539253765 07:55:48 INFO - PROCESS | 2307 | |5;yui.html;655.2235600813035;694.1704662927801;695.3498478922209;713.4791602130445;715.7423327602065;12836.550720724776;15138.621534461645;15192.696146077085;15484.845151548481;15536.300866461008;13894.583162505116;14067.226302553356;14084.718305633882;14262.286885655727;14326.498572549963;860.4149178558578;888.7644774134859;892.1970226795871;892.5269607108243;893.2898345815092;854.0989256334565;879.6481407437012;880.7665968518315;888.7911340834899;896.278495810872;938.713692323841;939.5349302095473;940.7507010642186;940.9294302927274;941.8163458125669;922.3635691372965;926.666400095965;931.9720408387759;934.434667026446;935.6444551070583;690.7962151165418;699.3705664901578;702.9947175538978;703.5989485992986;703.9788806335766;13973.441062357493;14932;15023.248837558187;15045.172515511642;15166.848331516654;13722.725545489135;14069.859301406957;14082.647933801634;14100.153990760484;14151.64620884486;11426.200165988384;11480.138989575731;11541.5960441385;11621.07031437483;12145.939270303592;2830.7169283071735;3519.296140771856;3633.618470060632;3648.233870887117;3677.7609455385314;89441.4223431062;92179.53910230406;100125;101076.48385274227;101133.4943325286;10025.749356266151;10317.329373590692;10425.113865321533;10485.580576776843;10697.251192416456;20767.961601920146;20848.37454876326;20878.269260575806;21033.89483052575;21066.2626808061;7476.775696729107;7572.356349710226;7595.962020189863;7597.936288919555;7728.613569321511;4222.59885310895;4296.978515107405;4303.33298338758;4385.605295523418;4424.469063712375;3406.897793066162;3468.791872487659;3483.076984599083;3486.633903440153;3500.0899766061007;540.3407842432305;639.4117411980989;639.8784230996189;647.2039391548328;657.3820608627874;463.84924899407827;535.884784771276;580.796721147595;590.9422134379498;619.6715740657369;8169.223923727236;8540.53027083504;8797.416465036355;8831.955840220886;8861.202491775772;502.6305665335975;565.3131445293988;596.9641821490725;601.8615718384708;614.3641331222163;3360.4119279126057;4076.1236334188293;4210.642095421924;4377.649788016951;4478.081993191388;91487.34050638034;99466.5026674862;102334.48832755789;102940;104303.95696042942;57364.99222527191;58700;68178.65910670414;70145;86652;68458;76688;80724.99999999882;81140.59429702931;81744.59127704323;8415.284700800501;8461.95769021151;8485.703000394957;8523.957380213307;8540.44487108336;52586;52600.473995259556;53305.46694533005;53986;55133;70529.29470705228;73713.26286737063;73889;75272.62363688147;76703;10981.945090274497;11052.834207486734;11077.556897724;11129.220954533104;11363.977242048255;11960.342181180118;11995.940020299842;12178.45196966121;12234.75530489403;12450;11399.601013964471;11571.479283432098;11843.28940263587;11981.341026243641;12125.090618203494;11299.3785341807;11577.363245021605;11837.289762614271;11869.940650296694;12008.63974080779;11265.605703800655;11464.4267786612;11466.369349685847;11619.128565357463;11839.58561450345;9302.906970930475;9540.904590954002;9591;9623.56693948788;10142.594296228068;6833.384995350442;7557.584332861526;7731;8984.23633991118;9718.222542196467 07:55:48 INFO - PROCESS | 2307 | __end_tp_report 07:55:48 INFO - PROCESS | 2307 | __start_cc_report 07:55:48 INFO - PROCESS | 2307 | _x_x_mozilla_cycle_collect,374 07:55:48 INFO - PROCESS | 2307 | __end_cc_report 07:55:48 INFO - PROCESS | 2307 | __startTimestamp1482422148569__endTimestamp 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | ------- Summary: start ------- 07:55:48 INFO - PROCESS | 2307 | Number of tests: 6 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | [#0] dojo.html Cycles:165 Average:5512.01 Median:5677.23 stddev:681.85 (12.0%) stddev-sans-first:661.02 07:55:48 INFO - PROCESS | 2307 | Values: 3277.5 3287.0 3307.8 3323.2 3328.1 5407.1 5466.0 5469.3 5474.6 5515.5 4560.3 5609.7 5614.3 5619.2 5657.7 5034.9 5070.7 5082.4 5177.5 5200.8 3839.6 5180.7 5186.3 5208.8 5234.4 4087.4 4391.9 5168.2 5183.5 5213.1 5027.6 5084.7 5100.6 5118.7 5134.4 4957.4 5055.6 5058.5 5075.2 5142.4 4216.7 5493.6 5554.3 5558.6 5621.8 6092.7 6110.4 6124.8 6132.2 6135.7 5919.4 5930.4 5937.0 5960.8 6046.9 5521.8 5644.9 5657.6 5677.2 5772.5 5145.6 6144.6 6202.2 6208.4 6229.8 6053.0 6080.6 6099.9 6103.2 6114.0 5436.6 5450.5 5472.2 5524.4 6059.4 5003.6 5997.6 6035.7 6081.6 6109.5 4987.5 5197.2 5991.2 6016.3 6053.7 4559.2 4719.6 4797.3 4916.0 4959.2 3885.1 3973.8 4302.7 4327.0 4388.9 4759.6 5747.1 5751.3 5754.7 5763.9 4729.7 6032.6 6198.0 6205.8 6219.5 4787.6 5602.4 5666.3 5680.5 5730.5 5259.1 5296.0 5304.8 5317.3 5321.0 6145.0 6192.3 6221.6 6231.8 6248.8 6077.2 6117.3 6130.4 6141.3 6142.4 6132.3 6166.1 6182.9 6238.9 6253.7 5919.3 5937.5 5942.0 6103.3 6136.8 6048.9 6124.1 6130.5 6155.4 6183.1 4870.6 6008.7 6012.1 6016.2 6051.8 5293.6 5425.6 5840.0 5851.4 5920.1 5005.3 5629.7 5730.9 5739.1 5743.5 4855.8 6033.6 6037.2 6041.7 6077.9 5790.5 5831.9 5845.3 5846.6 5883.5 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | [#1] ext.html Cycles:180 Average:63369.16 Median:3258.77 stddev:135434.38 (4156.0%) stddev-sans-first:135731.84 07:55:48 INFO - PROCESS | 2307 | Values: 421.8 428.8 491.6 507.2 560.5 36543.8 37657.6 38937.6 39079.6 39085.2 39613.0 40478.6 40524.6 40567.0 40590.0 8293.0 8507.4 9024.2 9351.6 9377.6 11219.6 11497.8 11526.5 11671.9 11674.0 11531.2 11563.9 11567.2 11585.5 11591.4 11361.4 11367.8 11434.4 11442.8 11455.7 8658.0 10914.0 11321.4 11390.8 11400.5 31961.5 38576.6 39540.8 39643.8 39718.6 3257.3 3260.3 3317.3 3369.3 3473.9 27218.0 27730.4 28192.3 28473.3 28474.4 3031.4 3209.5 3218.4 3307.2 3320.8 445794.0 447100.0 452036.5 454019.0 455429.7 43608.8 53219.0 53432.7 53469.0 53564.7 55226.0 55903.7 55923.7 55955.7 56182.9 14879.9 15344.8 15434.2 15435.2 15461.0 10871.2 11141.8 11799.6 12059.9 12147.9 13375.7 16956.6 16969.8 17008.8 17031.5 6334.5 7597.8 7605.8 7620.6 7691.3 826.7 843.8 899.5 983.9 1069.2 28623.3 29693.4 29707.9 30075.4 30207.8 1018.0 1028.8 1034.4 1037.8 1064.1 13541.8 14814.7 15216.7 15464.0 15539.9 559575.0 562226.0 562919.0 563126.0 564621.0 57503.0 57651.7 57735.7 57755.0 57807.7 1200.8 1360.0 1387.0 1397.5 1405.5 23111.9 28252.7 28945.0 29600.7 29794.7 45764.8 46537.8 47496.0 47553.0 47590.8 501606.0 501747.0 505293.0 506479.0 507633.7 24590.9 25154.1 25241.2 25701.8 25988.0 40974.6 41061.6 41484.8 41828.0 41880.6 26818.9 28018.9 31351.8 34631.0 35205.3 28076.0 32211.4 34332.0 35280.3 35489.6 31685.0 33967.2 34182.5 34225.7 35048.5 30585.0 30811.2 30819.0 31069.4 31112.8 22936.0 23441.6 23684.8 23813.5 23832.3 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | [#2] jquery.html Cycles:180 Average:27827.52 Median:305345.00 stddev:55929.81 (18.3%) stddev-sans-first:56048.70 07:55:48 INFO - PROCESS | 2307 | Values: 366.9 371.6 377.3 384.6 400.3 16162.1 18190.6 19642.8 19711.4 19848.5 11451.3 11597.0 11841.3 11842.3 11863.1 5206.8 5755.5 5815.3 5828.3 5852.3 3528.7 3964.0 5235.1 5250.7 5547.8 4864.9 5588.1 5888.4 5889.3 5904.7 5871.6 7173.8 7477.0 7542.3 7703.6 6966.0 7232.6 7284.3 7318.3 7325.5 25092.2 26010.1 26135.0 26376.2 26566.9 2387.4 2425.2 2471.6 2601.5 2953.0 14058.9 15271.7 16246.4 16259.0 16728.0 1936.9 1996.1 2034.7 2035.1 2036.4 131568.0 140674.0 141410.3 143059.0 145373.0 16808.3 20800.4 20943.4 21020.4 22300.6 34146.5 34252.0 34267.7 34280.8 34296.3 10159.2 10355.3 10470.5 10690.5 10701.6 7264.3 8525.6 8569.4 8640.0 8779.9 7855.6 8911.6 9457.2 9761.7 9826.2 1593.8 1670.2 3541.7 3849.4 3908.9 774.7 902.3 953.0 963.6 995.9 19911.5 20167.6 20210.5 20337.1 20451.6 935.9 936.8 960.4 970.6 997.8 10556.1 10951.4 10968.7 10992.4 10998.3 304469.0 306221.0 306295.0 307059.0 307448.0 105974.0 112231.0 114392.0 119626.0 119804.4 927.7 938.8 961.3 962.2 970.5 18284.6 18285.7 18328.4 18364.7 18415.0 50946.5 51600.5 52085.7 52129.7 52182.0 70841.0 73555.6 74089.3 74597.0 75470.6 7092.0 7096.6 7324.7 7430.6 7612.9 10196.7 12033.4 12411.2 12546.6 12627.7 9899.6 11081.7 11172.7 11227.3 11233.4 10640.9 10813.5 10873.3 11273.4 11300.4 10840.6 10935.5 11352.3 11448.2 11525.7 6052.2 6191.4 6911.8 7302.7 7437.3 9003.9 10910.0 10923.5 11172.0 11244.9 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | [#3] mootools.html Cycles:180 Average:5290.74 Median:5059.15 stddev:2937.29 (58.1%) stddev-sans-first:2929.50 07:55:48 INFO - PROCESS | 2307 | Values: 1207.3 1427.5 1622.9 1808.6 1856.9 7516.8 7783.7 8004.5 8459.2 8476.3 6499.4 8242.3 8270.6 8347.7 8369.8 2246.6 2287.8 2291.0 2293.1 2303.1 2287.2 2321.7 2336.2 2338.6 2348.4 2263.1 2287.0 2288.1 2315.1 2317.2 2262.1 2263.0 2274.1 2282.5 2286.1 2243.1 2283.0 2287.4 2321.4 2322.5 8312.1 8351.7 8382.7 8400.1 8413.0 4977.3 5139.1 5146.5 5147.4 5154.9 3135.2 3211.4 3323.7 3381.8 3391.2 981.0 1001.5 1017.0 1026.6 1035.5 10298.0 10515.5 10641.7 10740.0 10803.6 4236.2 4297.5 4386.5 4408.4 4430.0 8481.3 8556.8 8575.8 8575.9 8576.1 5057.5 5059.1 5059.2 5068.1 5071.4 4199.9 4497.1 4679.3 4749.6 4751.6 2960.1 3594.0 3597.2 3612.0 3719.7 1132.5 1146.2 1150.7 1152.8 1159.4 758.9 810.6 898.4 903.7 931.5 4058.1 4829.6 4931.3 5068.9 5715.9 369.0 411.2 428.0 431.5 431.6 2920.6 3828.3 3878.3 3942.9 4012.0 9579.5 9848.0 9924.4 9928.3 9947.7 9876.9 9901.4 9917.4 9953.8 10026.1 7389.0 7633.5 7790.4 7863.1 7962.8 4686.5 5235.0 5760.2 5775.9 5899.9 9060.0 9118.6 9194.0 9299.0 9316.3 9129.6 9138.4 9235.4 9329.4 9428.8 6363.0 6480.1 6522.4 6691.2 6933.7 7714.0 7880.0 7912.2 7920.5 7924.1 6921.1 7038.0 7043.0 7068.4 7167.5 5573.4 6894.7 6974.4 7008.4 7024.6 6551.9 6612.6 6684.7 6686.3 6698.8 4170.5 4857.6 4863.0 4875.5 4939.7 4766.8 4793.6 4930.6 4959.5 5065.1 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | [#4] prototype.html Cycles:180 Average:4395.44 Median:4928.29 stddev:1360.43 (27.6%) stddev-sans-first:1329.01 07:55:48 INFO - PROCESS | 2307 | Values: 296.9 349.4 360.5 361.3 362.8 4507.7 5016.1 5136.3 5267.0 5427.8 4778.9 5077.3 5214.0 5275.5 5292.5 3754.8 3904.8 4131.4 4141.6 4145.8 3411.4 3730.6 4143.0 4150.8 4175.7 3788.7 3804.6 3942.0 3991.6 4007.2 3467.4 3534.9 3654.5 3988.7 3993.6 2745.8 3396.4 3441.4 3458.4 3491.9 3802.2 4345.8 4819.2 4963.8 5049.9 4243.0 4564.7 4574.0 4591.2 4602.0 4645.4 5038.7 5289.8 5562.6 5636.7 3525.3 3645.9 3803.2 3822.5 3824.8 5597.8 5763.0 5820.6 5825.6 5826.3 3248.5 3855.7 3861.5 3868.8 3898.6 3295.5 3652.2 3702.9 3915.7 3947.3 4346.5 4409.6 4420.0 4491.3 4540.3 4892.4 5040.1 5582.2 5588.5 5595.7 1001.4 1200.3 1204.2 1219.7 1262.6 724.4 859.5 860.9 866.2 872.7 4621.4 5103.6 5147.6 5178.1 5214.3 4458.8 4717.5 4825.0 5303.8 5539.7 5383.2 5405.8 5420.2 5455.3 5503.8 2460.8 2910.8 2929.9 2938.6 2948.0 5015.8 5627.4 5676.5 5777.4 5809.5 4961.8 5441.4 5751.4 5777.0 5820.7 4747.2 5143.8 5368.2 5778.5 5864.6 4741.7 4982.7 5164.6 5489.8 5584.4 4807.1 5454.5 5483.5 5496.5 5573.5 5476.0 5594.2 5688.0 5857.4 5900.8 3049.8 3255.7 3388.7 3649.7 3658.4 4925.3 5014.8 5427.3 5512.8 5606.2 4437.9 5390.4 5403.6 5424.8 5451.9 4588.7 4923.2 5050.9 5407.7 5412.3 4750.4 4865.9 4991.6 5321.5 5326.5 4931.3 5010.5 5619.7 5650.5 5664.7 4805.9 5249.4 5275.7 5425.4 5457.5 07:55:48 INFO - PROCESS | 2307 | 07:55:48 INFO - PROCESS | 2307 | [#5] yui.html Cycles:180 Average:19282.31 Median:52952.97 stddev:27897.64 (52.7%) stddev-sans-first:27940.84 07:55:48 INFO - PROCESS | 2307 | Values: 655.2 694.2 695.3 713.5 715.7 12836.6 15138.6 15192.7 15484.8 15536.3 13894.6 14067.2 14084.7 14262.3 14326.5 860.4 888.8 892.2 892.5 893.3 854.1 879.6 880.8 888.8 896.3 938.7 939.5 940.8 940.9 941.8 922.4 926.7 932.0 934.4 935.6 690.8 699.4 703.0 703.6 704.0 13973.4 14932.0 15023.2 15045.2 15166.8 13722.7 14069.9 14082.6 14100.2 14151.6 11426.2 11480.1 11541.6 11621.1 12145.9 2830.7 3519.3 3633.6 3648.2 3677.8 89441.4 92179.5 100125.0 101076.5 101133.5 10025.7 10317.3 10425.1 10485.6 10697.3 20768.0 20848.4 20878.3 21033.9 21066.3 7476.8 7572.4 7596.0 7597.9 7728.6 4222.6 4297.0 4303.3 4385.6 4424.5 3406.9 3468.8 3483.1 3486.6 3500.1 540.3 639.4 639.9 647.2 657.4 463.8 535.9 580.8 590.9 619.7 8169.2 8540.5 8797.4 8832.0 8861.2 502.6 565.3 597.0 601.9 614.4 3360.4 4076.1 4210.6 4377.6 4478.1 91487.3 99466.5 102334.5 102940.0 104304.0 57365.0 58700.0 68178.7 70145.0 86652.0 68458.0 76688.0 80725.0 81140.6 81744.6 8415.3 8462.0 8485.7 8524.0 8540.4 52586.0 52600.5 53305.5 53986.0 55133.0 70529.3 73713.3 73889.0 75272.6 76703.0 10981.9 11052.8 11077.6 11129.2 11364.0 11960.3 11995.9 12178.5 12234.8 12450.0 11399.6 11571.5 11843.3 11981.3 12125.1 11299.4 11577.4 11837.3 11869.9 12008.6 11265.6 11464.4 11466.4 11619.1 11839.6 9302.9 9540.9 9591.0 9623.6 10142.6 6833.4 7557.6 7731.0 8984.2 9718.2 07:55:48 INFO - PROCESS | 2307 | -------- Summary: end -------- 07:55:48 INFO - PROCESS | 2307 | 07:55:49 INFO - TEST-INFO | 2307: exit 0 07:55:49 INFO - TEST-OK | dromaeo_css | took 1115517ms 07:55:49 INFO - TEST-START | kraken 07:55:49 INFO - operating with platform_type : mac_ 07:55:49 INFO - Initialising browser for kraken test... 07:55:49 INFO - TEST-INFO | started process 2311 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmphNLu6f/profile http://localhost:49410/getInfo.html) 07:55:52 INFO - PROCESS | 2311 | __metrics Screen width/height:1600/1200 07:55:52 INFO - PROCESS | 2311 | colorDepth:24 07:55:52 INFO - PROCESS | 2311 | Browser inner width/height: 1024/689 07:55:52 INFO - PROCESS | 2311 | __metrics 07:55:52 INFO - PROCESS | 2311 | 2016-12-22 07:55:52.324 plugin-container[2313:285553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 07:55:52 INFO - PROCESS | 2311 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:52 INFO - PROCESS | 2311 | 2016-12-22 07:55:52.325 plugin-container[2313:285553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:55:52 INFO - PROCESS | 2311 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:52 INFO - PROCESS | 2311 | 2016-12-22 07:55:52.325 plugin-container[2313:285553] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:52 ERROR - PROCESS | 2311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3247: TypeError: this.tabs is undefined 07:55:53 INFO - TEST-INFO | 2311: exit 0 07:55:53 INFO - Browser initialized. 07:55:53 INFO - Running cycle 1/1 for kraken test... 07:55:53 INFO - TEST-INFO | started process 2314 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmphNLu6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:55 INFO - PROCESS | 2314 | 2016-12-22 07:55:55.658 plugin-container[2315:285676] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444f, name = 'com.apple.tsm.portname' 07:55:55 INFO - PROCESS | 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:55 INFO - PROCESS | 2314 | 2016-12-22 07:55:55.658 plugin-container[2315:285676] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:55:55 INFO - PROCESS | 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:55 INFO - PROCESS | 2314 | 2016-12-22 07:55:55.658 plugin-container[2315:285676] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:56:05 INFO - PROCESS | 2314 | RSS: Main: 235630592 07:56:05 INFO - PROCESS | 2314 | 07:56:08 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49410/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:09 INFO - PROCESS | 2314 | RSS: Main: 248074240 07:56:09 INFO - PROCESS | 2314 | 07:56:11 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49410/tests/kraken/driver.html?testName=audio-dft) 07:56:12 INFO - PROCESS | 2314 | RSS: Main: 255614976 07:56:12 INFO - PROCESS | 2314 | 07:56:15 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49410/tests/kraken/driver.html?testName=audio-fft) 07:56:16 INFO - PROCESS | 2314 | RSS: Main: 258179072 07:56:16 INFO - PROCESS | 2314 | 07:56:17 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49410/tests/kraken/driver.html?testName=audio-oscillator) 07:56:18 INFO - PROCESS | 2314 | RSS: Main: 259493888 07:56:18 INFO - PROCESS | 2314 | 07:56:20 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:21 INFO - PROCESS | 2314 | RSS: Main: 259842048 07:56:21 INFO - PROCESS | 2314 | 07:56:24 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49410/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:24 INFO - PROCESS | 2314 | RSS: Main: 267550720 07:56:24 INFO - PROCESS | 2314 | 07:56:27 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49410/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:28 INFO - PROCESS | 2314 | RSS: Main: 267116544 07:56:28 INFO - PROCESS | 2314 | 07:56:31 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49410/tests/kraken/driver.html?testName=json-parse-financial) 07:56:32 INFO - PROCESS | 2314 | RSS: Main: 266567680 07:56:32 INFO - PROCESS | 2314 | 07:56:33 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:34 INFO - PROCESS | 2314 | RSS: Main: 265510912 07:56:34 INFO - PROCESS | 2314 | 07:56:36 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:36 INFO - PROCESS | 2314 | RSS: Main: 265605120 07:56:36 INFO - PROCESS | 2314 | 07:56:39 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:39 INFO - PROCESS | 2314 | RSS: Main: 265584640 07:56:39 INFO - PROCESS | 2314 | 07:56:42 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:43 INFO - PROCESS | 2314 | RSS: Main: 265641984 07:56:43 INFO - PROCESS | 2314 | 07:56:46 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:47 INFO - PROCESS | 2314 | RSS: Main: 266108928 07:56:47 INFO - PROCESS | 2314 | 07:56:48 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:49410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49410/tests/kraken/driver.html?testName=ai-astar) 07:56:49 INFO - PROCESS | 2314 | RSS: Main: 266878976 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | __start_tp_report 07:56:49 INFO - PROCESS | 2314 | _x_x_mozilla_page_load 07:56:49 INFO - PROCESS | 2314 | _x_x_mozilla_page_load_details 07:56:49 INFO - PROCESS | 2314 | |i|pagename|runs| 07:56:49 INFO - PROCESS | 2314 | |0;ai-astar;114;123;163;163;119;117;117;118;118;117 07:56:49 INFO - PROCESS | 2314 | |1;audio-beat-detection;145;114;111;148;113;112;125;110;132;111 07:56:49 INFO - PROCESS | 2314 | |2;audio-dft;193;199;197;206;226;194;197;199;199;196 07:56:49 INFO - PROCESS | 2314 | |3;audio-fft;80;60;64;78;52;51;53;78;91;84 07:56:49 INFO - PROCESS | 2314 | |4;audio-oscillator;83;70;84;71;70;71;82;70;72;84 07:56:49 INFO - PROCESS | 2314 | |5;imaging-gaussian-blur;92;133;137;85;89;82;122;124;88;86 07:56:49 INFO - PROCESS | 2314 | |6;imaging-darkroom;96;115;123;95;95;94;96;95;95;95 07:56:49 INFO - PROCESS | 2314 | |7;imaging-desaturate;93;138;84;140;153;105;99;137;94;98 07:56:49 INFO - PROCESS | 2314 | |8;json-parse-financial;55;58;56;56;58;58;58;56;58;58 07:56:49 INFO - PROCESS | 2314 | |9;json-stringify-tinderbox;69;69;76;79;103;103;108;81;73;72 07:56:49 INFO - PROCESS | 2314 | |10;stanford-crypto-aes;90;89;90;88;90;93;89;90;90;90 07:56:49 INFO - PROCESS | 2314 | |11;stanford-crypto-ccm;140;140;136;139;141;139;141;199;221;153 07:56:49 INFO - PROCESS | 2314 | |12;stanford-crypto-pbkdf2;177;238;245;227;176;175;178;172;173;176 07:56:49 INFO - PROCESS | 2314 | |13;stanford-crypto-sha256-iterative;67;69;69;66;70;68;69;66;68;69 07:56:49 INFO - PROCESS | 2314 | __end_tp_report 07:56:49 INFO - PROCESS | 2314 | __start_cc_report 07:56:49 INFO - PROCESS | 2314 | _x_x_mozilla_cycle_collect,940 07:56:49 INFO - PROCESS | 2314 | __end_cc_report 07:56:49 INFO - PROCESS | 2314 | __startTimestamp1482422209127__endTimestamp 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | ------- Summary: start ------- 07:56:49 INFO - PROCESS | 2314 | Number of tests: 14 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#0] ai-astar Cycles:10 Average:126.90 Median:118.50 stddev:19.16 (16.2%) stddev-sans-first:19.74 07:56:49 INFO - PROCESS | 2314 | Values: 114.0 123.0 163.0 163.0 119.0 117.0 117.0 118.0 118.0 117.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:119.50 stddev:14.70 (12.3%) stddev-sans-first:13.05 07:56:49 INFO - PROCESS | 2314 | Values: 145.0 114.0 111.0 148.0 113.0 112.0 125.0 110.0 132.0 111.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#2] audio-dft Cycles:10 Average:200.60 Median:199.00 stddev:9.61 (4.8%) stddev-sans-first:9.79 07:56:49 INFO - PROCESS | 2314 | Values: 193.0 199.0 197.0 206.0 226.0 194.0 197.0 199.0 199.0 196.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#3] audio-fft Cycles:10 Average:69.10 Median:78.00 stddev:14.78 (19.0%) stddev-sans-first:15.14 07:56:49 INFO - PROCESS | 2314 | Values: 80.0 60.0 64.0 78.0 52.0 51.0 53.0 78.0 91.0 84.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.00 stddev:6.55 (8.5%) stddev-sans-first:6.39 07:56:49 INFO - PROCESS | 2314 | Values: 83.0 70.0 84.0 71.0 70.0 71.0 82.0 70.0 72.0 84.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#5] imaging-gaussian-blur Cycles:10 Average:103.80 Median:85.50 stddev:22.23 (26.0%) stddev-sans-first:23.16 07:56:49 INFO - PROCESS | 2314 | Values: 92.0 133.0 137.0 85.0 89.0 82.0 122.0 124.0 88.0 86.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:95.00 stddev:10.26 (10.8%) stddev-sans-first:10.78 07:56:49 INFO - PROCESS | 2314 | Values: 96.0 115.0 123.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#7] imaging-desaturate Cycles:10 Average:114.10 Median:88.50 stddev:24.96 (28.2%) stddev-sans-first:25.27 07:56:49 INFO - PROCESS | 2314 | Values: 93.0 138.0 84.0 140.0 153.0 105.0 99.0 137.0 94.0 98.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:1.20 (2.1%) stddev-sans-first:1.00 07:56:49 INFO - PROCESS | 2314 | Values: 55.0 58.0 56.0 56.0 58.0 58.0 58.0 56.0 58.0 58.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#9] json-stringify-tinderbox Cycles:10 Average:83.30 Median:72.50 stddev:15.30 (21.1%) stddev-sans-first:15.33 07:56:49 INFO - PROCESS | 2314 | Values: 69.0 69.0 76.0 79.0 103.0 103.0 108.0 81.0 73.0 72.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:90.00 stddev:1.29 (1.4%) stddev-sans-first:1.36 07:56:49 INFO - PROCESS | 2314 | Values: 90.0 89.0 90.0 88.0 90.0 93.0 89.0 90.0 90.0 90.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#11] stanford-crypto-ccm Cycles:10 Average:154.90 Median:141.00 stddev:29.83 (21.2%) stddev-sans-first:31.15 07:56:49 INFO - PROCESS | 2314 | Values: 140.0 140.0 136.0 139.0 141.0 139.0 141.0 199.0 221.0 153.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:177.50 stddev:30.01 (16.9%) stddev-sans-first:31.21 07:56:49 INFO - PROCESS | 2314 | Values: 177.0 238.0 245.0 227.0 176.0 175.0 178.0 172.0 173.0 176.0 07:56:49 INFO - PROCESS | 2314 | 07:56:49 INFO - PROCESS | 2314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.39 07:56:49 INFO - PROCESS | 2314 | Values: 67.0 69.0 69.0 66.0 70.0 68.0 69.0 66.0 68.0 69.0 07:56:49 INFO - PROCESS | 2314 | -------- Summary: end -------- 07:56:49 INFO - PROCESS | 2314 | 07:56:50 INFO - TEST-INFO | 2314: exit 0 07:56:50 INFO - TEST-OK | kraken | took 60940ms 07:56:50 INFO - SUITE-END | took 1176s 07:56:50 INFO - Completed test suite (00:19:36) 07:56:50 INFO - javascript benchmark 07:56:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7050.732638762316, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.4592192288274, 3286.967130328697, 3307.751918606105, 3323.185819474229, 3328.1346849819047, 5407.134858422653, 5466.043442397579, 5469.316335458063, 5474.616776825624, 5515.531179849718, 4560.338750881128, 5609.691466969315, 5614.29821272341, 5619.241402410673, 5657.717114144297, 5034.899302013958, 5070.72111033893, 5082.364704411949, 5177.456367081459, 5200.791968321262, 3839.577646458887, 5180.740962951856, 5186.299849520305, 5208.843734687946, 5234.37187537496, 4087.448194493735, 4391.8581168896, 5168.198929165986, 5183.481651834824, 5213.113770658978, 5027.648064635477, 5084.694918304914, 5100.566451851597, 5118.667286626357, 5134.358205224347, 4957.429895562021, 5055.595552355802, 5058.46886076964, 5075.187969924795, 5142.3829140503, 4216.746995180299, 5493.587980901449, 5554.2779438672715, 5558.638688485235, 5621.7751289948355, 6092.66490343031, 6110.388961103854, 6124.816255512342, 6132.172156758869, 6135.69321533926, 5919.378465261172, 5930.436608522184, 5937.0, 5960.761569537213, 6046.939530604725, 5521.779128834842, 5644.943550564483, 5657.57568182388, 5677.233573467529, 5772.509336706343, 5145.588352931756, 6144.56988010835, 6202.162708034448, 6208.410201030895, 6229.750809967551, 6052.969735151296, 6080.604760690541, 6099.939000610026, 6103.176071230416, 6113.96943015291, 5436.646617969819, 5450.5367043800925, 5472.2338872557875, 5524.4199359067525, 6059.36376680451, 5003.624728145331, 5997.580169388189, 6035.728392222272, 6081.57428979976, 6109.5112391008615, 4987.476314986947, 5197.179159341562, 5991.221141251696, 6016.338202797689, 6053.727582258809, 4559.156556037144, 4719.551642593948, 4797.256425254021, 4915.95084049155, 4959.20652695567, 3885.1452680410266, 3973.8013099344917, 4302.698811083257, 4327.0, 4388.9122217556105, 4759.595434388047, 5747.08046712524, 5751.338596061423, 5754.6547207167705, 5763.9135412968835, 4729.716217026989, 6032.577719559677, 6198.008318668992, 6205.844853878599, 6219.47134493564, 4787.593054590398, 5602.439756024446, 5666.291713535808, 5680.5455563554815, 5730.541556675456, 5259.132243179909, 5296.04671159195, 5304.787808487695, 5317.282166907496, 5321.0, 6144.969275153596, 6192.256929168529, 6221.595596286227, 6231.75072997075, 6248.75004999804, 6077.179580756541, 6117.327094019565, 6130.398136742091, 6141.293751218667, 6142.416470435302, 6132.294322189991, 6166.105914642441, 6182.876342473215, 6238.906416403848, 6253.656048917172, 5919.260092488439, 5937.495312898452, 5941.970290148522, 6103.30736498198, 6136.825445958321, 6048.879022419439, 6124.14262003311, 6130.52043589939, 6155.415235552616, 6183.134361189527, 4870.610351171968, 6008.699565021644, 6012.098185272244, 6016.2479690038745, 6051.75792968294, 5293.602979776455, 5425.593080519056, 5839.970800145972, 5851.356350801493, 5920.111983202554, 5005.34930459038, 5629.746661400165, 5730.885382292247, 5739.110437882135, 5743.511801496919, 4855.781489832895, 6033.577649564489, 6037.215162029084, 6041.728122234422, 6077.878442431215, 5790.536757059341, 5831.854203644773, 5845.269341332333, 5846.649201047951, 5883.499902508163], "value": 5472.333078948066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.7701352762744, 428.78132152602166, 491.60671462829725, 507.2214151277789, 560.5319558168928, 36543.817280913594, 37657.62342376579, 38937.61062389375, 39079.60920390795, 39085.218295634106, 39613.0, 40478.59521404785, 40524.59475405245, 40567.0, 40590.0, 8293.046299675523, 8507.361947853904, 9024.23294020009, 9351.57917893693, 9377.578008989612, 11219.60731374402, 11497.770044599103, 11526.538938442452, 11671.941640291829, 11673.999999999958, 11531.192816502848, 11563.884361156406, 11567.248128871639, 11585.478653460572, 11591.362475063868, 11361.375124368156, 11367.772644547145, 11434.371109588968, 11442.828357574643, 11455.713607159805, 8658.0, 10914.017738403581, 11321.433928303552, 11390.772184556345, 11400.543978240861, 31961.52057719136, 38576.614233857865, 39540.80229598862, 39643.810685679186, 39718.60281397178, 3257.2833976525126, 3260.250142467246, 3317.336532693471, 3369.326134773031, 3473.9131521711906, 27218.04736834221, 27730.445391092064, 28192.295192620142, 28473.28816779597, 28474.430511389863, 3031.378567393679, 3209.47043737783, 3218.372417378612, 3307.2393349529502, 3320.8173550454717, 445794.0, 447100.0, 452036.47963520273, 454019.0, 455429.72285138693, 43608.78195609065, 53219.0, 53432.73283633557, 53469.0, 53564.73217633887, 55226.0, 55903.72048139733, 55923.720381397834, 55955.720221399446, 56182.87634247292, 14879.92560037193, 15344.769828452581, 15434.228288585526, 15435.15106669144, 15461.0, 10871.184661150288, 11141.832872506919, 11799.587014454624, 12059.939700301442, 12147.878521214852, 13375.665608359674, 16956.558692511273, 16969.83030169707, 17008.829911700726, 17031.48905532836, 6334.461570766536, 7597.848043039219, 7605.809854753676, 7620.618969051525, 7691.269329413697, 826.6817275349034, 843.8143608406141, 899.469313105271, 983.896690847465, 1069.198101423932, 28623.284417889718, 29693.40613187724, 29707.851460742557, 30075.397655401997, 30207.848960755495, 1017.97455063624, 1028.8096702110133, 1034.4000479721744, 1037.7716902281486, 1064.1114669251108, 13541.796873046913, 14814.703705925822, 15216.695666086616, 15464.0, 15539.912206145462, 559575.0, 562226.0, 562919.0, 563126.0, 564621.0, 57503.0, 57651.711741441024, 57735.71132144312, 57755.0, 57807.71096144492, 1200.8078707406949, 1359.9796003059962, 1386.9861301386857, 1397.4619771388088, 1405.5080721747306, 23111.88444057769, 28252.71747282501, 28945.0, 29600.703992959796, 29794.70205298006, 45764.771176143906, 46537.767311164585, 47496.0, 47553.0, 47590.76204618955, 501606.0, 501747.0, 505293.0, 506479.0, 507633.6984616562, 24590.893409796245, 25154.11960581371, 25241.24276271715, 25701.843417046653, 25988.0, 40974.59025409708, 41061.58938410697, 41484.75545733633, 41827.9543011415, 41880.58119418767, 26818.865905671126, 28018.859905701156, 31351.84324078365, 34631.0, 35205.29589408249, 28076.017339393024, 32211.35577288488, 34332.0, 35280.29439411146, 35489.64510354863, 31685.04944851658, 33967.15082122868, 34182.487262691575, 34225.65774342225, 35048.47427288542, 30585.0, 30811.229719257197, 30819.0, 31069.378612428078, 31112.844435777675, 22936.0, 23441.648375274042, 23684.763152368945, 23813.523729524964, 23832.285031449082], "value": 19018.029838441107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8862652577701, 371.6487918916623, 377.31893931453715, 384.56544105161163, 400.3034719587916, 16162.11108389038, 18190.636187276246, 19642.803571964294, 19711.408657740256, 19848.503787405323, 11451.312921224733, 11597.0, 11841.289522628627, 11842.348670823101, 11863.050955923527, 5206.791728330872, 5755.510781583571, 5815.273090863642, 5828.300603927534, 5852.297724273072, 3528.7353448491335, 3964.048628329195, 5235.057689615867, 5250.713575174088, 5547.750351234184, 4864.854054378375, 5588.133839254901, 5888.411158884121, 5889.263842019747, 5904.7047647617665, 5871.618344807595, 7173.820654483654, 7476.962615186916, 7542.321191092828, 7703.614819259071, 6966.0, 7232.638368081627, 7284.307990740871, 7318.34134927859, 7325.450591205681, 25092.247232583053, 26010.08964686246, 26135.0, 26376.20871373862, 26566.86716566424, 2387.4270175158013, 2425.151197081025, 2471.5778537033807, 2601.4797040591766, 2952.9852350738324, 14058.859411405858, 15271.694566108616, 16246.431374901822, 16259.0, 16728.0, 1936.932207372735, 1996.0518753592073, 2034.6947957806299, 2035.1248962945926, 2036.3585470576868, 131568.0, 140674.0, 141410.2929485356, 143059.0, 145373.0, 16808.310670292696, 20800.375988720363, 20943.371698848754, 21020.369388918356, 22300.553988920456, 34146.48780268298, 34252.0, 34267.657323426945, 34280.80017199386, 34296.314073718386, 10159.238057145743, 10355.326903751382, 10470.47647617616, 10690.51892664832, 10701.625443109453, 7264.309890560388, 8525.616347264388, 8569.35729820266, 8640.006399264039, 8779.868301975475, 7855.6464959076975, 8911.574148136267, 9457.243420526342, 9761.707148785548, 9826.222908206237, 1593.8246792852776, 1670.2316934210157, 3541.7166626669805, 3849.40334248192, 3908.90227744303, 774.6939958716275, 902.309733054214, 953.0, 963.6001059560344, 995.8854731705802, 19911.502212444517, 20167.596648066956, 20210.494737631678, 20337.084831182634, 20451.590968180553, 935.8876934767871, 936.765808547863, 960.4477425480377, 970.6263088710897, 997.7655251016006, 10556.102731267774, 10951.397673127894, 10968.670939871816, 10992.406101115454, 10998.285111467729, 304469.0, 306221.0, 306295.0, 307059.0, 307448.0, 105974.0, 112231.0, 114392.0, 119626.0, 119804.40097799455, 927.6567669962158, 938.779386844091, 961.3222678011984, 962.153305091515, 970.5195928015678, 18284.634307313514, 18285.725714114033, 18328.358507452176, 18364.72452913234, 18415.0, 50946.49053509418, 51600.48399515957, 52085.7395713019, 52129.70184174143, 52181.95636087181, 70841.0, 73555.63222183855, 74089.2591074104, 74597.0, 75470.5661792276, 7092.0, 7096.584069647128, 7324.7070117196845, 7430.591317477591, 7612.885806712793, 10196.694099177037, 12033.398330083635, 12411.193272437262, 12546.633416458853, 12627.684307892376, 9899.554520046759, 11081.667549973514, 11172.738119605392, 11227.27022743519, 11233.38216398106, 10640.8935910643, 10813.459327033774, 10873.347599144077, 11273.379964102052, 11300.378479183724, 10840.620578279722, 10935.453227338443, 11352.318860868374, 11448.198626096093, 11525.711857203636, 6052.243469566304, 6191.4118158774845, 6911.7558839409385, 7302.707891684273, 7437.293457121565, 9003.909960900308, 10910.018098371185, 10923.508442119964, 11172.0, 11244.887551124384], "value": 10054.187719920359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.2877002568487, 1427.514645020693, 1622.8964304273097, 1808.5840256740942, 1856.9350072747457, 7516.849663006737, 7783.688652453895, 8004.519728816268, 8459.196376344253, 8476.279516241118, 6499.35006499351, 8242.34061275098, 8270.586470676457, 8347.749567512968, 8369.83260334793, 2246.58465166945, 2287.7597852225526, 2290.9656355154684, 2293.1286111277773, 2303.0557471436714, 2287.1880482428746, 2321.721393432782, 2336.194013065498, 2338.567365037465, 2348.424635964191, 2263.094762095159, 2286.9771302287013, 2288.084766093559, 2315.0623997281127, 2317.154238702878, 2262.083856038291, 2263.0495192019307, 2274.1358283852114, 2282.5206706591553, 2286.0741399733133, 2243.1476039105037, 2282.988585057081, 2287.3938406322336, 2321.3848330192513, 2322.512272422793, 8312.085670576233, 8351.749447516584, 8382.748517544484, 8400.117987611335, 8412.957935210285, 4977.328060711794, 5139.0749665060275, 5146.536811686966, 5147.382314122329, 5154.92267615986, 3135.216195951012, 3211.3577284543185, 3323.7008669219886, 3381.8140002299865, 3391.2200193955528, 980.9950950245203, 1001.5142655811925, 1017.0338178730162, 1026.6355443817413, 1035.4926086217774, 10298.021687939708, 10515.526801293883, 10641.73395665107, 10740.0, 10803.5678572857, 4236.237477254123, 4297.548757380492, 4386.517483076859, 4408.382826404306, 4429.9778501107285, 8481.279091277187, 8556.786080347916, 8575.785605359915, 8575.871361929576, 8576.099509551408, 5057.519535644108, 5059.114654935445, 5059.19052951526, 5068.087744206078, 5071.366079240095, 4199.9370009449885, 4497.123061003073, 4679.344891715163, 4749.572538471554, 4751.64362672801, 2960.082374463923, 3593.9820300898327, 3597.226596281812, 3611.963880361163, 3719.7210209233876, 1132.5300000499865, 1146.1633007904277, 1150.71232191952, 1152.7867344541287, 1159.3913195572393, 758.9051368578928, 810.5784991804229, 898.4098146281046, 903.6566104880103, 931.5156118818312, 4058.066644671683, 4829.551134659588, 4931.260310953314, 5068.949310506921, 5715.885682286331, 368.9594144644087, 411.2351027089611, 428.01342904604564, 431.5490312623316, 431.5813660749131, 2920.6349206349205, 3828.2917660232947, 3878.3406820840523, 3942.8817135485983, 4012.0, 9579.473128977974, 9847.950760246153, 9924.354916930377, 9928.305018648625, 9947.651832185838, 9876.901230987742, 9901.405915645084, 9917.404955702681, 9953.80092398148, 10026.147777438999, 7388.963055184689, 7633.503822251536, 7790.415718821111, 7863.13505514393, 7962.840743185104, 4686.531346865286, 5235.016040856675, 5760.222369980167, 5775.8556036099435, 5899.852503687443, 9060.048694886942, 9118.635254589743, 9194.034626364402, 9299.023602521638, 9316.34785565004, 9129.5891684873, 9138.360314777901, 9235.353525253167, 9329.440233586007, 9428.764280893032, 6362.981922892315, 6480.125183100221, 6522.445592124723, 6691.230508491391, 6933.7226510939, 7713.961430192813, 7880.014998125234, 7912.169222231813, 7920.485168464032, 7924.088729796147, 6921.065656136358, 7038.049863268393, 7042.964785176041, 7068.399186069241, 7167.498275120692, 5573.359063707563, 6894.655267236518, 6974.442044636518, 7008.439324854102, 7024.6136462493005, 6551.901721474086, 6612.570182938093, 6684.6991885364305, 6686.3313668632745, 6698.765543205965, 4170.47869016373, 4857.611391088633, 4862.95137048625, 4875.463698993179, 4939.678920870276, 4766.785494652819, 4793.5685788279225, 4930.556249937523, 4959.454460009469, 5065.113605119163], "value": 4208.293698883131, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.94061187762446, 349.4408945686901, 360.525908430414, 361.33875008734003, 362.8367234744362, 4507.661925355599, 5016.072026675068, 5136.33227680402, 5267.0, 5427.810026649068, 4778.928316075253, 5077.314562534057, 5213.973930130344, 5275.472452754722, 5292.523672869441, 3754.8122593870335, 3904.8438062477467, 4131.421600975866, 4141.56513566075, 4145.797718661584, 3411.420058590033, 3730.6455886690856, 4142.964258935266, 4150.83396664133, 4175.686823488235, 3788.7347885648014, 3804.630333080089, 3941.960580394202, 3991.600839916014, 4007.238624661305, 3467.4452087666104, 3534.939518144572, 3654.488371627974, 3988.7207895447186, 3993.600639935983, 2745.835249884993, 3396.371671240828, 3441.397755392821, 3458.3774920514297, 3491.9127021824656, 3802.201537677091, 4345.760983145926, 4819.16871588794, 4963.8262660806695, 5049.939512702337, 4243.045314804175, 4564.7032942858605, 4573.977130114328, 4591.1965406053805, 4601.976990115028, 4645.372874661911, 5038.74031492127, 5289.809792796628, 5562.582806289544, 5636.718164091779, 3525.307852230918, 3645.9270814583824, 3803.220339830328, 3822.503074600312, 3824.808759562011, 5597.804076857331, 5762.971185144047, 5820.592558520905, 5825.621334613236, 5826.300843898717, 3248.480243161083, 3855.7300988931065, 3861.5053376694136, 3868.825902834379, 3898.5516665583255, 3295.489199174132, 3652.160003199279, 3702.852115844097, 3915.667168290727, 3947.2894878921497, 4346.47842258931, 4409.625181859514, 4419.966053552282, 4491.303847903515, 4540.318952157137, 4892.3884514435695, 5040.067587496325, 5582.241593897909, 5588.469095435927, 5595.692236926927, 1001.4041645221082, 1200.3218181727295, 1204.1691233049169, 1219.676785651803, 1262.5959692898184, 724.3915111306528, 859.4585411191034, 860.9354298427643, 866.1814585217036, 872.7381785464336, 4621.376114224604, 5103.57580149426, 5147.562457191106, 5178.084108879739, 5214.270002199695, 4458.843940462133, 4717.457492388351, 4825.021741086138, 5303.756994404538, 5539.667619942817, 5383.2194331821665, 5405.7837686492885, 5420.205855900886, 5455.345358556999, 5503.752331145108, 2460.766227208412, 2910.8399038052685, 2929.9012870173683, 2938.6032885560603, 2947.985260073686, 5015.8212819987275, 5627.409122042209, 5676.460736230051, 5777.393373695785, 5809.489098470676, 4961.82633607822, 5441.374241962146, 5751.405371642723, 5777.046787280052, 5820.748539064121, 4747.240441529339, 5143.819966301162, 5368.161764338517, 5778.537716982547, 5864.560157988082, 4741.67657847659, 4982.7259500727805, 5164.561012313845, 5489.780408783764, 5584.357798853184, 4807.053143476897, 5454.4545545445135, 5483.506484416422, 5496.450354964471, 5573.52625026861, 5475.986942415666, 5594.216809646734, 5687.980766827882, 5857.4435428634215, 5900.822975310747, 3049.7865149439326, 3255.690709382605, 3388.7458440617547, 3649.7371629589825, 3658.414653655402, 4925.261210818406, 5014.774335155, 5427.3215848019, 5512.759629083424, 5606.2431571738925, 4437.933430998473, 5390.380106287827, 5403.567714582902, 5424.83725488236, 5451.936872309861, 4588.659783510367, 4923.163062279493, 5050.9291190611675, 5407.675539467645, 5412.269343638558, 4750.429948406213, 4865.878353041202, 4991.600671946163, 5321.525490646868, 5326.520613144836, 4931.309616653743, 5010.549050585465, 5619.747111379916, 5650.474371919641, 5664.660120392789, 4805.870620404133, 5249.396319423316, 5275.709835959059, 5425.376081750649, 5457.481539253765], "value": 3970.2431071092115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2235600813035, 694.1704662927801, 695.3498478922209, 713.4791602130445, 715.7423327602065, 12836.550720724776, 15138.621534461645, 15192.696146077085, 15484.845151548481, 15536.300866461008, 13894.583162505116, 14067.226302553356, 14084.718305633882, 14262.286885655727, 14326.498572549963, 860.4149178558578, 888.7644774134859, 892.1970226795871, 892.5269607108243, 893.2898345815092, 854.0989256334565, 879.6481407437012, 880.7665968518315, 888.7911340834899, 896.278495810872, 938.713692323841, 939.5349302095473, 940.7507010642186, 940.9294302927274, 941.8163458125669, 922.3635691372965, 926.666400095965, 931.9720408387759, 934.434667026446, 935.6444551070583, 690.7962151165418, 699.3705664901578, 702.9947175538978, 703.5989485992986, 703.9788806335766, 13973.441062357493, 14932.0, 15023.248837558187, 15045.172515511642, 15166.848331516654, 13722.725545489135, 14069.859301406957, 14082.647933801634, 14100.153990760484, 14151.64620884486, 11426.200165988384, 11480.138989575731, 11541.5960441385, 11621.07031437483, 12145.939270303592, 2830.7169283071735, 3519.296140771856, 3633.618470060632, 3648.233870887117, 3677.7609455385314, 89441.4223431062, 92179.53910230406, 100125.0, 101076.48385274227, 101133.4943325286, 10025.749356266151, 10317.329373590692, 10425.113865321533, 10485.580576776843, 10697.251192416456, 20767.961601920146, 20848.37454876326, 20878.269260575806, 21033.89483052575, 21066.2626808061, 7476.775696729107, 7572.356349710226, 7595.962020189863, 7597.936288919555, 7728.613569321511, 4222.59885310895, 4296.978515107405, 4303.33298338758, 4385.605295523418, 4424.469063712375, 3406.897793066162, 3468.791872487659, 3483.076984599083, 3486.633903440153, 3500.0899766061007, 540.3407842432305, 639.4117411980989, 639.8784230996189, 647.2039391548328, 657.3820608627874, 463.84924899407827, 535.884784771276, 580.796721147595, 590.9422134379498, 619.6715740657369, 8169.223923727236, 8540.53027083504, 8797.416465036355, 8831.955840220886, 8861.202491775772, 502.6305665335975, 565.3131445293988, 596.9641821490725, 601.8615718384708, 614.3641331222163, 3360.4119279126057, 4076.1236334188293, 4210.642095421924, 4377.649788016951, 4478.081993191388, 91487.34050638034, 99466.5026674862, 102334.48832755789, 102940.0, 104303.95696042942, 57364.99222527191, 58700.0, 68178.65910670414, 70145.0, 86652.0, 68458.0, 76688.0, 80724.99999999882, 81140.59429702931, 81744.59127704323, 8415.284700800501, 8461.95769021151, 8485.703000394957, 8523.957380213307, 8540.44487108336, 52586.0, 52600.473995259556, 53305.46694533005, 53986.0, 55133.0, 70529.29470705228, 73713.26286737063, 73889.0, 75272.62363688147, 76703.0, 10981.945090274497, 11052.834207486734, 11077.556897724, 11129.220954533104, 11363.977242048255, 11960.342181180118, 11995.940020299842, 12178.45196966121, 12234.75530489403, 12450.0, 11399.601013964471, 11571.479283432098, 11843.28940263587, 11981.341026243641, 12125.090618203494, 11299.3785341807, 11577.363245021605, 11837.289762614271, 11869.940650296694, 12008.63974080779, 11265.605703800655, 11464.4267786612, 11466.369349685847, 11619.128565357463, 11839.58561450345, 9302.906970930475, 9540.904590954002, 9591.0, 9623.56693948788, 10142.594296228068, 6833.384995350442, 7557.584332861526, 7731.0, 8984.23633991118, 9718.222542196467], "value": 7026.630259483249, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 123.0, 163.0, 163.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 111.0, 148.0, 113.0, 112.0, 125.0, 110.0, 132.0, 111.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 199.0, 197.0, 206.0, 226.0, 194.0, 197.0, 199.0, 199.0, 196.0], "value": 200.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 64.0, 78.0, 52.0, 51.0, 53.0, 78.0, 91.0, 84.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 84.0, 71.0, 70.0, 71.0, 82.0, 70.0, 72.0, 84.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 133.0, 137.0, 85.0, 89.0, 82.0, 122.0, 124.0, 88.0, 86.0], "value": 103.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 115.0, 123.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 138.0, 84.0, 140.0, 153.0, 105.0, 99.0, 137.0, 94.0, 98.0], "value": 114.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 56.0, 58.0, 58.0, 58.0, 56.0, 58.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 76.0, 79.0, 103.0, 103.0, 108.0, 81.0, 73.0, 72.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 88.0, 90.0, 93.0, 89.0, 90.0, 90.0, 90.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 136.0, 139.0, 141.0, 139.0, 141.0, 199.0, 221.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 238.0, 245.0, 227.0, 176.0, 175.0, 178.0, 172.0, 173.0, 176.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 66.0, 70.0, 68.0, 69.0, 66.0, 68.0, 69.0], "value": 68.1, "unit": "score"}]}]} 07:56:50 INFO - Return code: 0 07:56:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:50 ERROR - # TBPL SUCCESS # 07:56:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:50 INFO - 2016-12-22 07:56:50.492 screenresolution[2319:286063] starting screenresolution argv=screenresolution get 07:56:50 INFO - 2016-12-22 07:56:50.495 screenresolution[2319:286063] Display 0: 1600x1200x32@60 07:56:50 INFO - 2016-12-22 07:56:50.501 screenresolution[2320:286066] starting screenresolution argv=screenresolution list 07:56:50 INFO - Available Modes on Display 0 07:56:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:50 INFO - Intel Iris: 07:56:50 INFO - Chipset Model: Intel Iris 07:56:50 INFO - Type: GPU 07:56:50 INFO - Bus: Built-In 07:56:50 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:50 INFO - Vendor: Intel (0x8086) 07:56:50 INFO - Device ID: 0x0a2e 07:56:50 INFO - Revision ID: 0x0009 07:56:50 INFO - Displays: 07:56:50 INFO - Display: 07:56:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:50 INFO - Display Serial Number: 1600x1200 60 07:56:50 INFO - Main Display: Yes 07:56:50 INFO - Mirror: Off 07:56:50 INFO - Online: Yes 07:56:50 INFO - Rotation: Supported 07:56:50 INFO - Return code: 0 07:56:50 INFO - Running post-action listener: _resource_record_post_action 07:56:50 INFO - [mozharness: 2016-12-22 15:56:50.739976Z] Finished run-tests step (success) 07:56:50 INFO - Running post-run listener: _resource_record_post_run 07:56:50 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 1060864; Write bytes: 557012480; Read time: 11; Write time: 1992 07:56:50 INFO - TinderboxPrint: CPU usage
54.6% 07:56:50 INFO - TinderboxPrint: I/O read bytes / time
1,060,864 / 11 07:56:50 INFO - TinderboxPrint: I/O write bytes / time
557,012,480 / 1,992 07:56:50 INFO - TinderboxPrint: CPU idle
2,180.2 (45.4%) 07:56:50 INFO - TinderboxPrint: CPU system
968.9 (20.2%) 07:56:50 INFO - TinderboxPrint: CPU user
1,648.6 (34.4%) 07:56:50 INFO - TinderboxPrint: Swap in / out
250,089,472 / 0 07:56:50 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245467648; Write bytes: 239876096; Read time: 18087; Write time: 503 07:56:50 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 1015808; Write bytes: 302468608; Read time: 10; Write time: 1440 07:56:51 INFO - Running post-run listener: _upload_blobber_files 07:56:51 INFO - Blob upload gear active. 07:56:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:52 INFO - (blobuploader) - INFO - Done attempting. 07:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:54 INFO - (blobuploader) - INFO - Done attempting. 07:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:55 INFO - (blobuploader) - INFO - Done attempting. 07:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:57 INFO - (blobuploader) - INFO - Done attempting. 07:56:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:57 INFO - Return code: 0 07:56:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f5e0454b7963e629605e7443c09c832055e9034f9723af7961253d35760c65b8180459351130858db1df6ae2a9ee658cd38acfdade6646c1d9814470fe9d24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db3c6158e7da01a8650fe6000d50e9078775eb211e93c1bc023f131460189fb2eac18c3ca7f1467e57599655f6d3c265ce0e86fc8dba47e63165cafd87d2416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98ed60867f1fdf26832854064a8b9b54fde991c1659942a5cacd09cb6e171bf21d6d00e12ab2de6b5e35e196560137535712729265ac102bd7e0b69ae3ad6b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbdf94ec4faba1af47379f85f5a3c53e90c10bd6ae0aa09e626f58647136c2101c121b743e3adffd89bb522502342f12597a6f515e6733ad42194cf6defc70d"} 07:56:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:57 INFO - Contents: 07:56:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f5e0454b7963e629605e7443c09c832055e9034f9723af7961253d35760c65b8180459351130858db1df6ae2a9ee658cd38acfdade6646c1d9814470fe9d24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db3c6158e7da01a8650fe6000d50e9078775eb211e93c1bc023f131460189fb2eac18c3ca7f1467e57599655f6d3c265ce0e86fc8dba47e63165cafd87d2416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98ed60867f1fdf26832854064a8b9b54fde991c1659942a5cacd09cb6e171bf21d6d00e12ab2de6b5e35e196560137535712729265ac102bd7e0b69ae3ad6b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbdf94ec4faba1af47379f85f5a3c53e90c10bd6ae0aa09e626f58647136c2101c121b743e3adffd89bb522502342f12597a6f515e6733ad42194cf6defc70d"} 07:56:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:57 INFO - Copying logs to upload dir... 07:56:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.987780 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-22 07:56:57.678800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 07:56:57.682419) ========= 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.Qy7inS2MSo/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.RfphjGPyHF/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/e7f5e0454b7963e629605e7443c09c832055e9034f9723af7961253d35760c65b8180459351130858db1df6ae2a9ee658cd38acfdade6646c1d9814470fe9d24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db3c6158e7da01a8650fe6000d50e9078775eb211e93c1bc023f131460189fb2eac18c3ca7f1467e57599655f6d3c265ce0e86fc8dba47e63165cafd87d2416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98ed60867f1fdf26832854064a8b9b54fde991c1659942a5cacd09cb6e171bf21d6d00e12ab2de6b5e35e196560137535712729265ac102bd7e0b69ae3ad6b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbdf94ec4faba1af47379f85f5a3c53e90c10bd6ae0aa09e626f58647136c2101c121b743e3adffd89bb522502342f12597a6f515e6733ad42194cf6defc70d"} build_url:https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011106 build_url: 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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/e7f5e0454b7963e629605e7443c09c832055e9034f9723af7961253d35760c65b8180459351130858db1df6ae2a9ee658cd38acfdade6646c1d9814470fe9d24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7db3c6158e7da01a8650fe6000d50e9078775eb211e93c1bc023f131460189fb2eac18c3ca7f1467e57599655f6d3c265ce0e86fc8dba47e63165cafd87d2416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98ed60867f1fdf26832854064a8b9b54fde991c1659942a5cacd09cb6e171bf21d6d00e12ab2de6b5e35e196560137535712729265ac102bd7e0b69ae3ad6b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bbdf94ec4faba1af47379f85f5a3c53e90c10bd6ae0aa09e626f58647136c2101c121b743e3adffd89bb522502342f12597a6f515e6733ad42194cf6defc70d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 07:56:57.716292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:56:57.716617) ========= 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.Qy7inS2MSo/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.RfphjGPyHF/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005325 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:56:57.765689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 07:56:57.765987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 07:56:57.766333) ========= ========= Total master_lag: 0.30 =========