builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0149 starttime: 1491133328.19 results: success (0) buildid: 20170402030202 builduid: 9f9704ef7d9d48469f84a8647184be40 revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:08.186085) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:08.186693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:08.187080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:08.215326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:08.215747) ========= 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.iB3bWQRR1k/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.qMAVoptvjg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-02 04:42:08-- 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% 12.9M=0.001s 2017-04-02 04:42:08 (12.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.798173 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.041203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.041580) ========= 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.iB3bWQRR1k/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.qMAVoptvjg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.035055 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:09.162649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-02 04:42:09.163048) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iB3bWQRR1k/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.qMAVoptvjg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-02 04:42:09,179 truncating revision to first 12 chars 2017-04-02 04:42:09,179 Setting DEBUG logging. 2017-04-02 04:42:09,179 attempt 1/10 2017-04-02 04:42:09,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a3f514cf849?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 04:42:12,369 unpacking tar archive at: mozilla-central-7a3f514cf849/testing/mozharness/ program finished with exit code 0 elapsedTime=3.466577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-02 04:42:12.653787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.654176) ========= script_repo_revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.654627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.654934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 04:42:12.674805) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 36 secs) (at 2017-04-02 04:42:12.675147) ========= /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.iB3bWQRR1k/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.qMAVoptvjg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:42:12 INFO - MultiFileLogger online at 20170402 04:42:12 in /builds/slave/test 04:42:12 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 04:42:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:12 INFO - {'append_to_log': False, 04:42:12 INFO - 'base_work_dir': '/builds/slave/test', 04:42:12 INFO - 'blob_upload_branch': 'Firefox', 04:42:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:12 INFO - 'branch': 'Firefox', 04:42:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:12 INFO - 'config_files': ('talos/mac_config.py',), 04:42:12 INFO - 'default_actions': ('clobber', 04:42:12 INFO - 'read-buildbot-config', 04:42:12 INFO - 'download-and-extract', 04:42:12 INFO - 'populate-webroot', 04:42:12 INFO - 'create-virtualenv', 04:42:12 INFO - 'install', 04:42:12 INFO - 'run-tests'), 04:42:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:12 INFO - 'download_minidump_stackwalk': True, 04:42:12 INFO - 'download_symbols': 'ondemand', 04:42:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:12 INFO - 'gecko_profile': False, 04:42:12 INFO - 'gecko_profile_interval': 0, 04:42:12 INFO - 'installer_path': 'installer.exe', 04:42:12 INFO - 'log_level': 'info', 04:42:12 INFO - 'log_name': 'talos', 04:42:12 INFO - 'log_to_console': True, 04:42:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:12 INFO - 'opt_config_files': (), 04:42:12 INFO - 'pip_index': False, 04:42:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:12 INFO - 'cmd': ('bash', 04:42:12 INFO - '-c', 04:42:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:12 INFO - 'enabled': True, 04:42:12 INFO - 'halt_on_failure': False, 04:42:12 INFO - 'name': 'check_screen_resolution'},), 04:42:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:12 INFO - 'cmd': ('bash', 04:42:12 INFO - '-c', 04:42:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:12 INFO - 'enabled': True, 04:42:12 INFO - 'halt_on_failure': False, 04:42:12 INFO - 'name': 'check_screen_resolution'},), 04:42:12 INFO - 'run_cmd_checks_enabled': True, 04:42:12 INFO - 'suite': 'dromaeojs-e10s', 04:42:12 INFO - 'system_bits': '32', 04:42:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:12 INFO - 'title': 't-yosemite-r7-0149', 04:42:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:12 INFO - 'use_talos_json': True, 04:42:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:12 INFO - 'work_dir': 'build'} 04:42:12 INFO - [mozharness: 2017-04-02 11:42:12.804350Z] Running clobber step. 04:42:12 INFO - Running pre-action listener: _resource_record_pre_action 04:42:12 INFO - Running main action method: clobber 04:42:12 INFO - rmtree: /builds/slave/test/build 04:42:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:15 INFO - Running post-action listener: _resource_record_post_action 04:42:15 INFO - [mozharness: 2017-04-02 11:42:15.432724Z] Finished clobber step (success) 04:42:15 INFO - [mozharness: 2017-04-02 11:42:15.432959Z] Running read-buildbot-config step. 04:42:15 INFO - Running pre-action listener: _resource_record_pre_action 04:42:15 INFO - Running main action method: read_buildbot_config 04:42:15 INFO - Using buildbot properties: 04:42:15 INFO - { 04:42:15 INFO - "project": "", 04:42:15 INFO - "product": "firefox", 04:42:15 INFO - "script_repo_revision": "production", 04:42:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:42:15 INFO - "repository": "", 04:42:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:42:15 INFO - "buildid": "20170402030202", 04:42:15 INFO - "stage_platform": "macosx64", 04:42:15 INFO - "basedir": "/builds/slave/test", 04:42:15 INFO - "nightly_build": "True", 04:42:15 INFO - "buildnumber": 12, 04:42:15 INFO - "slavename": "t-yosemite-r7-0149", 04:42:15 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:42:15 INFO - "platform": "yosemite_r7", 04:42:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:42:15 INFO - "branch": "mozilla-central", 04:42:15 INFO - "repo_path": "mozilla-central", 04:42:15 INFO - "revision": "7a3f514cf8490d271ee373a1d2999e4ea4dee2d7", 04:42:15 INFO - "pgo_build": "False", 04:42:15 INFO - "builduid": "9f9704ef7d9d48469f84a8647184be40", 04:42:15 INFO - "slavebuilddir": "test" 04:42:15 INFO - } 04:42:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:42:15 INFO - Running post-action listener: _resource_record_post_action 04:42:15 INFO - [mozharness: 2017-04-02 11:42:15.438842Z] Finished read-buildbot-config step (success) 04:42:15 INFO - [mozharness: 2017-04-02 11:42:15.439000Z] Running download-and-extract step. 04:42:15 INFO - Running pre-action listener: _resource_record_pre_action 04:42:15 INFO - Running main action method: download_and_extract 04:42:15 INFO - mkdir: /builds/slave/test/build/tests 04:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:15 INFO - trying https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:15 INFO - Downloading https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:17 INFO - Downloaded 1325 bytes. 04:42:17 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:17 INFO - Using the following test package requirements: 04:42:17 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:42:17 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:42:17 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:17 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:42:17 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'jsshell-mac.zip'], 04:42:17 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:42:17 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:42:17 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:42:17 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:42:17 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:42:17 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:18 INFO - Expected file size: 52518396 04:42:18 INFO - Obtained file size: 52518396 04:42:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:35 INFO - Fetch https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:37 INFO - Expected file size: 52518396 04:42:37 INFO - Obtained file size: 52518396 04:42:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:42:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:52 INFO - Fetch https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:42:54 INFO - Expected file size: 14404152 04:42:54 INFO - Obtained file size: 14404152 04:42:54 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')]} 04:42:54 INFO - trying https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:43:26 INFO - retry: attempt #1 caught exception: '' 04:43:26 INFO - retry: Failed, sleeping 30 seconds before retrying 04:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #2 04:44:00 INFO - Downloaded 75666717 bytes. 04:44:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:00 INFO - mkdir: /builds/slave/test/properties 04:44:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:00 INFO - Contents: 04:44:00 INFO - build_url:https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:01 INFO - Running post-action listener: _resource_record_post_action 04:44:01 INFO - Running post-action listener: set_extra_try_arguments 04:44:01 INFO - [mozharness: 2017-04-02 11:44:01.937686Z] Finished download-and-extract step (success) 04:44:01 INFO - [mozharness: 2017-04-02 11:44:01.937833Z] Running populate-webroot step. 04:44:01 INFO - Running pre-action listener: _resource_record_pre_action 04:44:01 INFO - Running main action method: populate_webroot 04:44:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:01 INFO - '--tppagecycles', 04:44:01 INFO - '7'], 04:44:01 INFO - 'tests': ['tsvgm']}}, 04:44:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['damp', 'tps']}, 04:44:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'tests': ['damp', 'tps']}, 04:44:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['dromaeo_dom']}, 04:44:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['basic_compositor_video']}, 04:44:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['a11yr', 04:44:01 INFO - 'ts_paint', 04:44:01 INFO - 'tpaint', 04:44:01 INFO - 'sessionrestore', 04:44:01 INFO - 'sessionrestore_no_auto_restore', 04:44:01 INFO - 'tabpaint']}, 04:44:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:01 INFO - 'ts_paint', 04:44:01 INFO - 'tpaint', 04:44:01 INFO - 'sessionrestore', 04:44:01 INFO - 'sessionrestore_no_auto_restore', 04:44:01 INFO - 'tabpaint']}, 04:44:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:01 INFO - 'ts_paint', 04:44:01 INFO - 'tpaint', 04:44:01 INFO - 'sessionrestore', 04:44:01 INFO - 'sessionrestore_no_auto_restore', 04:44:01 INFO - 'tabpaint']}, 04:44:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:01 INFO - 'ts_paint', 04:44:01 INFO - 'tpaint', 04:44:01 INFO - 'sessionrestore', 04:44:01 INFO - 'sessionrestore_no_auto_restore', 04:44:01 INFO - 'tabpaint']}, 04:44:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['a11yr', 04:44:01 INFO - 'ts_paint', 04:44:01 INFO - 'tpaint', 04:44:01 INFO - 'sessionrestore', 04:44:01 INFO - 'sessionrestore_no_auto_restore', 04:44:01 INFO - 'tabpaint']}, 04:44:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['a11yr', 04:44:01 INFO - 'ts_paint', 04:44:01 INFO - 'tpaint', 04:44:01 INFO - 'sessionrestore', 04:44:01 INFO - 'sessionrestore_no_auto_restore', 04:44:01 INFO - 'tabpaint']}, 04:44:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['tsvgx', 04:44:01 INFO - 'tsvgr_opacity', 04:44:01 INFO - 'tart', 04:44:01 INFO - 'tscrollx', 04:44:01 INFO - 'cart', 04:44:01 INFO - 'tsvg_static']}, 04:44:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:01 INFO - 'tsvgr_opacity', 04:44:01 INFO - 'tart', 04:44:01 INFO - 'tscrollx', 04:44:01 INFO - 'cart', 04:44:01 INFO - 'tsvg_static']}, 04:44:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'talos_options': ['--disable-e10s'], 04:44:01 INFO - 'tests': ['tp5o']}, 04:44:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:44:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'talos_options': ['--disable-e10s', 04:44:01 INFO - '--xperf_path', 04:44:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:01 INFO - 'tests': ['tp5n']}, 04:44:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:44:01 INFO - 'talos_options': ['--xperf_path', 04:44:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:01 INFO - 'tests': ['tp5n']}}, 04:44:01 INFO - 'talos.zip': {'path': '', 04:44:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:01 INFO - Running post-action listener: _resource_record_post_action 04:44:01 INFO - [mozharness: 2017-04-02 11:44:01.956355Z] Finished populate-webroot step (success) 04:44:01 INFO - [mozharness: 2017-04-02 11:44:01.956495Z] Running create-virtualenv step. 04:44:01 INFO - Running pre-action listener: _resource_record_pre_action 04:44:01 INFO - Running main action method: create_virtualenv 04:44:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:44:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:02 INFO - Using real prefix '/tools/python27' 04:44:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:05 INFO - Installing pip.................done. 04:44:05 INFO - Return code: 0 04:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:44:05 INFO - Reading from file tmpfile_stdout 04:44:05 INFO - Output received: 04:44:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:44:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:07 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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:07 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 04:44:07 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 04:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:07 INFO - 'HOME': '/Users/cltbld', 04:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:07 INFO - 'LOGNAME': 'cltbld', 04:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:07 INFO - 'MOZ_NO_REMOTE': '1', 04:44:07 INFO - 'NO_EM_RESTART': '1', 04:44:07 INFO - 'PAGER': '/bin/cat', 04:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:07 INFO - 'PWD': '/builds/slave/test', 04:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:07 INFO - 'SHELL': '/bin/bash', 04:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:07 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:07 INFO - 'USER': 'cltbld', 04:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:07 INFO - 'XPC_FLAGS': '0x0', 04:44:07 INFO - 'XPC_SERVICE_NAME': '0', 04:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:07 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 04:44:07 INFO - Cleaning up... 04:44:07 INFO - Return code: 0 04:44:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44:07 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')]} 04:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:07 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')]} 04:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:07 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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:07 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 04:44:07 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 04:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:07 INFO - 'HOME': '/Users/cltbld', 04:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:07 INFO - 'LOGNAME': 'cltbld', 04:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:07 INFO - 'MOZ_NO_REMOTE': '1', 04:44:07 INFO - 'NO_EM_RESTART': '1', 04:44:07 INFO - 'PAGER': '/bin/cat', 04:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:07 INFO - 'PWD': '/builds/slave/test', 04:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:07 INFO - 'SHELL': '/bin/bash', 04:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:07 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:07 INFO - 'USER': 'cltbld', 04:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:07 INFO - 'XPC_FLAGS': '0x0', 04:44:07 INFO - 'XPC_SERVICE_NAME': '0', 04:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:08 INFO - Downloading/unpacking psutil>=3.1.1 04:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:13 INFO - Installing collected packages: psutil 04:44:13 INFO - Running setup.py install for psutil 04:44:13 INFO - building 'psutil._psutil_osx' extension 04:44:13 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 04:44:13 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 04:44:13 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 04:44:13 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 04:44:13 INFO - building 'psutil._psutil_posix' extension 04:44:13 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 04:44:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:44:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:44:14 INFO - ^ 04:44:14 INFO - 1 warning generated. 04:44:14 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 04:44:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:14 INFO - Successfully installed psutil 04:44:14 INFO - Cleaning up... 04:44:14 INFO - Return code: 0 04:44:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:14 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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:14 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 04:44:14 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 04:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:14 INFO - 'HOME': '/Users/cltbld', 04:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:14 INFO - 'LOGNAME': 'cltbld', 04:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:14 INFO - 'MOZ_NO_REMOTE': '1', 04:44:14 INFO - 'NO_EM_RESTART': '1', 04:44:14 INFO - 'PAGER': '/bin/cat', 04:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:14 INFO - 'PWD': '/builds/slave/test', 04:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:14 INFO - 'SHELL': '/bin/bash', 04:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:14 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:14 INFO - 'USER': 'cltbld', 04:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:14 INFO - 'XPC_FLAGS': '0x0', 04:44:14 INFO - 'XPC_SERVICE_NAME': '0', 04:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:14 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 04:44:14 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 04:44:14 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 04:44:14 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 04:44:14 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 04:44:14 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 04:44:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:17 INFO - Installing collected packages: mozsystemmonitor 04:44:17 INFO - Running setup.py install for mozsystemmonitor 04:44:18 INFO - Successfully installed mozsystemmonitor 04:44:18 INFO - Cleaning up... 04:44:18 INFO - Return code: 0 04:44:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:44:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:18 INFO - 'HOME': '/Users/cltbld', 04:44:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:18 INFO - 'LOGNAME': 'cltbld', 04:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:18 INFO - 'MOZ_NO_REMOTE': '1', 04:44:18 INFO - 'NO_EM_RESTART': '1', 04:44:18 INFO - 'PAGER': '/bin/cat', 04:44:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:18 INFO - 'PWD': '/builds/slave/test', 04:44:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:18 INFO - 'SHELL': '/bin/bash', 04:44:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:18 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:18 INFO - 'USER': 'cltbld', 04:44:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:18 INFO - 'XPC_FLAGS': '0x0', 04:44:18 INFO - 'XPC_SERVICE_NAME': '0', 04:44:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:18 INFO - Downloading/unpacking jsonschema==2.5.1 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:22 INFO - warning: no files found matching '*.txt' 04:44:22 INFO - no previously-included directories found matching 'build' 04:44:22 INFO - no previously-included directories found matching 'dist' 04:44:22 INFO - no previously-included directories found matching '.git*' 04:44:22 INFO - Installing collected packages: jsonschema, functools32 04:44:22 INFO - Running setup.py install for functools32 04:44:22 INFO - warning: no files found matching '*.txt' 04:44:22 INFO - no previously-included directories found matching 'build' 04:44:22 INFO - no previously-included directories found matching 'dist' 04:44:22 INFO - no previously-included directories found matching '.git*' 04:44:22 INFO - Successfully installed jsonschema functools32 04:44:22 INFO - Cleaning up... 04:44:22 INFO - Return code: 0 04:44:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:22 INFO - 'HOME': '/Users/cltbld', 04:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:22 INFO - 'LOGNAME': 'cltbld', 04:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:22 INFO - 'MOZ_NO_REMOTE': '1', 04:44:22 INFO - 'NO_EM_RESTART': '1', 04:44:22 INFO - 'PAGER': '/bin/cat', 04:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:22 INFO - 'PWD': '/builds/slave/test', 04:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:22 INFO - 'SHELL': '/bin/bash', 04:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:22 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:22 INFO - 'USER': 'cltbld', 04:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:22 INFO - 'XPC_FLAGS': '0x0', 04:44:22 INFO - 'XPC_SERVICE_NAME': '0', 04:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:22 INFO - Cleaning up... 04:44:22 INFO - Return code: 0 04:44:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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', '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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44: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 blobuploader==1.2.4 04:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:22 INFO - 'HOME': '/Users/cltbld', 04:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:22 INFO - 'LOGNAME': 'cltbld', 04:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:22 INFO - 'MOZ_NO_REMOTE': '1', 04:44:22 INFO - 'NO_EM_RESTART': '1', 04:44:22 INFO - 'PAGER': '/bin/cat', 04:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:22 INFO - 'PWD': '/builds/slave/test', 04:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:22 INFO - 'SHELL': '/bin/bash', 04:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:22 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:22 INFO - 'USER': 'cltbld', 04:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:22 INFO - 'XPC_FLAGS': '0x0', 04:44:22 INFO - 'XPC_SERVICE_NAME': '0', 04:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:27 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 04:44:27 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 04:44:27 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 04:44:27 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 04:44:27 INFO - Downloading docopt-0.6.1.tar.gz 04:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:27 INFO - Running setup.py install for blobuploader 04:44:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:27 INFO - Running setup.py install for requests 04:44:28 INFO - Running setup.py install for docopt 04:44:28 INFO - Successfully installed blobuploader requests docopt 04:44:28 INFO - Cleaning up... 04:44:28 INFO - Return code: 0 04:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:28 INFO - 'HOME': '/Users/cltbld', 04:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:28 INFO - 'LOGNAME': 'cltbld', 04:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:28 INFO - 'MOZ_NO_REMOTE': '1', 04:44:28 INFO - 'NO_EM_RESTART': '1', 04:44:28 INFO - 'PAGER': '/bin/cat', 04:44:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:28 INFO - 'PWD': '/builds/slave/test', 04:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:28 INFO - 'SHELL': '/bin/bash', 04:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:28 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:28 INFO - 'USER': 'cltbld', 04:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:28 INFO - 'XPC_FLAGS': '0x0', 04:44:28 INFO - 'XPC_SERVICE_NAME': '0', 04:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:28 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-uwU5pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:28 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-7jdcE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:28 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-W7Fbn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-HUXm3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ylRlrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-FCmY7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-sQXetr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-xW_hbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-xpSD9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-EoSQoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-9hykPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-XcGg3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:29 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-GjXSaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-xz4o7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-AsXzN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-kfqESU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:30 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-LZTSkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:30 INFO - Running setup.py install for manifestparser 04:44:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:30 INFO - Running setup.py install for mozcrash 04:44:30 INFO - Running setup.py install for mozdebug 04:44:30 INFO - Running setup.py install for mozdevice 04:44:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for mozfile 04:44:31 INFO - Running setup.py install for mozhttpd 04:44:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for mozinfo 04:44:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for mozInstall 04:44:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for mozleak 04:44:31 INFO - Running setup.py install for mozlog 04:44:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for moznetwork 04:44:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozprocess 04:44:32 INFO - Running setup.py install for mozprofile 04:44:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozrunner 04:44:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozscreenshot 04:44:32 INFO - Running setup.py install for moztest 04:44:32 INFO - Running setup.py install for mozversion 04:44:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:33 INFO - Cleaning up... 04:44:33 INFO - Return code: 0 04:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:33 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')]} 04:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:33 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')]} 04:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:33 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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:33 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 04:44:33 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 04:44:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:33 INFO - 'HOME': '/Users/cltbld', 04:44:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:33 INFO - 'LOGNAME': 'cltbld', 04:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:33 INFO - 'MOZ_NO_REMOTE': '1', 04:44:33 INFO - 'NO_EM_RESTART': '1', 04:44:33 INFO - 'PAGER': '/bin/cat', 04:44:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:33 INFO - 'PWD': '/builds/slave/test', 04:44:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:33 INFO - 'SHELL': '/bin/bash', 04:44:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:33 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:33 INFO - 'USER': 'cltbld', 04:44:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:33 INFO - 'XPC_FLAGS': '0x0', 04:44:33 INFO - 'XPC_SERVICE_NAME': '0', 04:44:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-3kZbF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-rUlHOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-aZvtnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-l5DP74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-zHvUHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-aRUIWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:33 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-MRbNfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:34 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)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-BNofRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ztrKh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-qliT5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-4oYOrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-eHExMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-a3LBbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Q51Rpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-TrP7uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:34 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-3lBEPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:35 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ZzzVtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:38 INFO - Downloading blessings-1.6.tar.gz 04:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:38 INFO - Installing collected packages: blessings 04:44:38 INFO - Running setup.py install for blessings 04:44:38 INFO - Successfully installed blessings 04:44:38 INFO - Cleaning up... 04:44:38 INFO - Return code: 0 04:44:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:38 INFO - Reading from file tmpfile_stdout 04:44:38 INFO - Current package versions: 04:44:38 INFO - blessings == 1.6 04:44:38 INFO - blobuploader == 1.2.4 04:44:38 INFO - docopt == 0.6.1 04:44:38 INFO - functools32 == 3.2.3-2 04:44:38 INFO - jsonschema == 2.5.1 04:44:38 INFO - manifestparser == 1.1 04:44:38 INFO - mozInstall == 1.12 04:44:38 INFO - mozcrash == 1.0 04:44:38 INFO - mozdebug == 0.1 04:44:38 INFO - mozdevice == 0.49 04:44:38 INFO - mozfile == 1.2 04:44:38 INFO - mozhttpd == 0.7 04:44:38 INFO - mozinfo == 0.9 04:44:38 INFO - mozleak == 0.1 04:44:38 INFO - mozlog == 3.4 04:44:38 INFO - moznetwork == 0.27 04:44:38 INFO - mozprocess == 0.25 04:44:38 INFO - mozprofile == 0.28 04:44:38 INFO - mozrunner == 6.13 04:44:38 INFO - mozscreenshot == 0.1 04:44:38 INFO - mozsystemmonitor == 0.3 04:44:38 INFO - moztest == 0.8 04:44:38 INFO - mozversion == 1.4 04:44:38 INFO - psutil == 3.1.1 04:44:38 INFO - requests == 1.2.3 04:44:38 INFO - wsgiref == 0.1.2 04:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:38 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 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:38 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 04:44:38 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 04:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:38 INFO - 'HOME': '/Users/cltbld', 04:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:38 INFO - 'LOGNAME': 'cltbld', 04:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:38 INFO - 'MOZ_NO_REMOTE': '1', 04:44:38 INFO - 'NO_EM_RESTART': '1', 04:44:38 INFO - 'PAGER': '/bin/cat', 04:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:38 INFO - 'PWD': '/builds/slave/test', 04:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:38 INFO - 'SHELL': '/bin/bash', 04:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:38 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:38 INFO - 'USER': 'cltbld', 04:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:38 INFO - 'XPC_FLAGS': '0x0', 04:44:38 INFO - 'XPC_SERVICE_NAME': '0', 04:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:39 INFO - Cleaning up... 04:44:39 INFO - Return code: 0 04:44:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106841b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106844768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05c8460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, '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.iB3bWQRR1k/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.qMAVoptvjg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 04:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:39 INFO - 'HOME': '/Users/cltbld', 04:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:39 INFO - 'LOGNAME': 'cltbld', 04:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:39 INFO - 'MOZ_NO_REMOTE': '1', 04:44:39 INFO - 'NO_EM_RESTART': '1', 04:44:39 INFO - 'PAGER': '/bin/cat', 04:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:39 INFO - 'PWD': '/builds/slave/test', 04:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:39 INFO - 'SHELL': '/bin/bash', 04:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:44:39 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:39 INFO - 'USER': 'cltbld', 04:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:39 INFO - 'XPC_FLAGS': '0x0', 04:44:39 INFO - 'XPC_SERVICE_NAME': '0', 04:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:39 INFO - Cleaning up... 04:44:39 INFO - Return code: 0 04:44:39 INFO - Running post-action listener: _resource_record_post_action 04:44:39 INFO - Running post-action listener: _start_resource_monitoring 04:44:39 INFO - Starting resource monitoring. 04:44:39 INFO - [mozharness: 2017-04-02 11:44:39.493406Z] Finished create-virtualenv step (success) 04:44:39 INFO - [mozharness: 2017-04-02 11:44:39.494309Z] Running install step. 04:44:39 INFO - Running pre-action listener: _resource_record_pre_action 04:44:39 INFO - Running main action method: install 04:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:39 INFO - Reading from file tmpfile_stdout 04:44:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:39 INFO - Reading from file tmpfile_stdout 04:44:39 INFO - Output received: 04:44:39 INFO - Usage: mozinstall [options] installer 04:44:39 INFO - Options: 04:44:39 INFO - -h, --help show this help message and exit 04:44:39 INFO - -d DEST, --destination=DEST 04:44:39 INFO - Directory to install application into. [default: 04:44:39 INFO - "/builds/slave/test"] 04:44:39 INFO - --app=APP Application being installed. [default: firefox] 04:44:39 INFO - mkdir: /builds/slave/test/build/application 04:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:45:00 INFO - Reading from file tmpfile_stdout 04:45:00 INFO - Output received: 04:45:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:45:00 INFO - Running post-action listener: _resource_record_post_action 04:45:00 INFO - [mozharness: 2017-04-02 11:45:00.740559Z] Finished install step (success) 04:45:00 INFO - [mozharness: 2017-04-02 11:45:00.740703Z] Running run-tests step. 04:45:00 INFO - Running pre-action listener: _resource_record_pre_action 04:45:00 INFO - Running main action method: run_tests 04:45:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:00 INFO - 2017-04-02 04:45:00.753 screenresolution[1678:15635] starting screenresolution argv=screenresolution get 04:45:00 INFO - 2017-04-02 04:45:00.756 screenresolution[1678:15635] Display 0: 1600x1200x32@60 04:45:00 INFO - 2017-04-02 04:45:00.761 screenresolution[1679:15637] starting screenresolution argv=screenresolution list 04:45:00 INFO - Available Modes on Display 0 04:45:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:00 INFO - Intel Iris: 04:45:00 INFO - Chipset Model: Intel Iris 04:45:00 INFO - Type: GPU 04:45:00 INFO - Bus: Built-In 04:45:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:00 INFO - Vendor: Intel (0x8086) 04:45:00 INFO - Device ID: 0x0a2e 04:45:00 INFO - Revision ID: 0x0009 04:45:00 INFO - Displays: 04:45:00 INFO - Display: 04:45:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:00 INFO - Display Serial Number: 1600x1200 60 04:45:00 INFO - Main Display: Yes 04:45:00 INFO - Mirror: Off 04:45:00 INFO - Online: Yes 04:45:00 INFO - Rotation: Supported 04:45:01 INFO - Return code: 0 04:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:01 INFO - Python 2.7.3 04:45:01 INFO - Return code: 0 04:45:01 INFO - grabbing minidump binary from tooltool 04:45:01 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')]} 04:45:01 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 0x10661fd30>, '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 0x106546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106614be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:01 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 04:45:01 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 04:45:01 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 04:45:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:01 INFO - Return code: 0 04:45:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:45:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:01 INFO - ENV: RUST_BACKTRACE is now 1 04:45:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:45:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:01 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/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 04:45:01 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/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0149 --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 04:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iB3bWQRR1k/Render', 04:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:01 INFO - 'HOME': '/Users/cltbld', 04:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:01 INFO - 'LOGNAME': 'cltbld', 04:45:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:01 INFO - 'MOZ_NO_REMOTE': '1', 04:45:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:01 INFO - 'NO_EM_RESTART': '1', 04:45:01 INFO - 'PAGER': '/bin/cat', 04:45:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:01 INFO - 'PWD': '/builds/slave/test', 04:45:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:01 INFO - 'RUST_BACKTRACE': '1', 04:45:01 INFO - 'SHELL': '/bin/bash', 04:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qMAVoptvjg/Listeners', 04:45:01 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 04:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:01 INFO - 'USER': 'cltbld', 04:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:01 INFO - 'XPC_FLAGS': '0x0', 04:45:01 INFO - 'XPC_SERVICE_NAME': '0', 04:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:01 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/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 04:45:01 INFO - mozversion application_buildid: 20170402030202 04:45:01 INFO - mozversion application_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 04:45:01 INFO - mozversion application_display_name: Nightly 04:45:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:01 INFO - mozversion application_name: Firefox 04:45:01 INFO - mozversion application_remotingname: firefox 04:45:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:45:01 INFO - mozversion application_vendor: Mozilla 04:45:01 INFO - mozversion application_version: 55.0a1 04:45:01 INFO - mozversion platform_buildid: 20170402030202 04:45:01 INFO - mozversion platform_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 04:45:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:45:01 INFO - mozversion platform_version: 55.0a1 04:45:01 INFO - using testdate: 1491133501 04:45:01 INFO - actual date: 1491133501 04:45:01 INFO - starting webserver on 'localhost:49257' 04:45:01 INFO - SUITE-START | Running 2 tests 04:45:01 INFO - TEST-START | dromaeo_css 04:45:01 INFO - operating with platform_type : mac_ 04:45:01 INFO - Initialising browser for dromaeo_css test... 04:45:01 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpodj34W/profile http://localhost:49257/getInfo.html) 04:45:05 INFO - PID 1689 | 2017-04-02 04:45:05.176 plugin-container[1692:15840] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d43, name = 'com.apple.tsm.portname' 04:45:05 INFO - PID 1689 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:05 INFO - PID 1689 | 2017-04-02 04:45:05.177 plugin-container[1692:15840] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9517, name = 'com.apple.CFPasteboardClient' 04:45:05 INFO - PID 1689 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:05 INFO - PID 1689 | 2017-04-02 04:45:05.177 plugin-container[1692:15840] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:05 INFO - PID 1689 | __metrics Screen width/height:1600/1200 04:45:05 INFO - PID 1689 | colorDepth:24 04:45:05 INFO - PID 1689 | Browser inner width/height: 1024/689 04:45:05 INFO - PID 1689 | __metrics 04:45:05 ERROR - PID 1689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:45:06 INFO - TEST-INFO | 1689: exit 0 04:45:06 INFO - Browser initialized. 04:45:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:06 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpodj34W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:08 INFO - PID 1694 | 2017-04-02 04:45:08.458 plugin-container[1695:15976] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:45:08 INFO - PID 1694 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:08 INFO - PID 1694 | 2017-04-02 04:45:08.458 plugin-container[1695:15976] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:45:08 INFO - PID 1694 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:08 INFO - PID 1694 | 2017-04-02 04:45:08.458 plugin-container[1695:15976] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:18 INFO - PID 1694 | RSS: Main: 228839424 04:45:18 INFO - PID 1694 | 04:48:21 INFO - PID 1694 | Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49257/tests/dromaeo/cssquery-ext.html) 04:48:24 INFO - PID 1694 | RSS: Main: 253329408 04:48:24 INFO - PID 1694 | 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | A coding exception was thrown and uncaught in a Task. 04:50:06 INFO - PID 1694 | 04:50:06 ERROR - PID 1694 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:06 INFO - PID 1694 | Full stack: 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | A coding exception was thrown and uncaught in a Task. 04:50:06 INFO - PID 1694 | 04:50:06 ERROR - PID 1694 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:06 INFO - PID 1694 | Full stack: 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | A coding exception was thrown and uncaught in a Task. 04:50:06 INFO - PID 1694 | 04:50:06 ERROR - PID 1694 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:06 INFO - PID 1694 | Full stack: 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | ************************* 04:50:06 INFO - PID 1694 | A coding exception was thrown and uncaught in a Task. 04:50:06 INFO - PID 1694 | 04:50:06 ERROR - PID 1694 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:06 INFO - PID 1694 | Full stack: 04:50:06 INFO - PID 1694 | ************************* 04:51:26 INFO - PID 1694 | Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-ext.html (next: http://localhost:49257/tests/dromaeo/cssquery-jquery.html) 04:51:26 INFO - PID 1694 | RSS: Main: 260743168 04:51:26 INFO - PID 1694 | 04:54:28 INFO - PID 1694 | Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49257/tests/dromaeo/cssquery-mootools.html) 04:54:29 INFO - PID 1694 | RSS: Main: 273903616 04:54:29 INFO - PID 1694 | 04:57:31 INFO - PID 1694 | Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49257/tests/dromaeo/cssquery-prototype.html) 04:57:32 INFO - PID 1694 | RSS: Main: 266223616 04:57:32 INFO - PID 1694 | 05:00:35 INFO - PID 1694 | Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49257/tests/dromaeo/cssquery-yui.html) 05:00:35 INFO - PID 1694 | RSS: Main: 275496960 05:00:35 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-yui.html (next: http://localhost:49257/tests/dromaeo/cssquery-dojo.html) 05:03:38 INFO - PID 1694 | RSS: Main: 270385152 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | __start_tp_report 05:03:38 INFO - PID 1694 | _x_x_mozilla_page_load 05:03:38 INFO - PID 1694 | _x_x_mozilla_page_load_details 05:03:38 INFO - PID 1694 | |i|pagename|runs| 05:03:38 INFO - PID 1694 | |0;dojo.html;2723.6186933829267;2816.760575351095;3604.8377822997963;3610.332088563616;3626.6192049834767;6145.569810113294;6203.937960620392;6208.503319734422;6234.5324100692405;6272.278687950893;4932.482089380617;6124.960759790124;6191.195144631203;6197.19436473259;6237.5009999200065;4918.458969513351;5361.035013697543;5420.07858664028;5497.642653227527;5620.718964051781;5480.150576660624;5506;5571.387147413781;5603.691796951166;5636.915446268309;5403;5453.182022696587;5526.392096869341;5544.861378465571;5654.745536450849;5510.972445137749;5541.224228607998;5549.278593782823;5553.555715542747;5586.608937374385;5485.588580856452;5492.176173573956;5492.5605951523785;5497.39528651848;5507.091329930557;5378.91931621026;6037.1246169305205;6161.106639537287;6162.7534898604;6212.627242365427;6734.966325168391;6778;6783.152105986752;6784.864302713968;6797.694103765293;6862.416694580967;6882.931170688279;6887.5178737488395;6890.517663763539;6899.689513971884;6186.948218802814;6212.378762123752;6297.464715499188;6304.117423560705;6339.714712837887;6961.860762784716;6966.5471744336455;6989.196242432084;7011.754588589375;7107.786766397016;5663.263775709132;5783.71081445926;6265.091561723524;6383.904241436289;6521.869562608721;6788.389044985975;6844.21291551468;6870.45036397087;6873;6875;6424.71088801005;6502.60984340941;6736.292689267654;6755.121834161528;6766.627835469097;6693.665316734144;6717.899231511531;6755.121834161626;6806.8638627228165;6819;5391.191321301758;5401.297831281908;5406.567474602022;5415.729213539386;5440.939016891668;4709.740964246931;4741.857744267678;4774.785134668949;4788.832390866303;4829.9034019319415;6220.937790622126;6335.366463353628;6399.968000159969;6441.774537891151;6457.096006559085;5992.880142397127;6717.059611654372;6885.965570172117;6907.758228461979;6937.098177236927;5405.567554595702;6423.518236132309;6431.935680643133;6453.45145662624;6468.353164683494;5882.205902203148;5963.403659634002;6013.4888534474185;6048.213732214872;6051.971164901977;7036.226015138331;7038.824029399306;7039.472039596948;7047.577145371294;7059.5058345915295;6792;6798.252192258748;6833;6834.419074378535;6870.106886104774;6755.088063111417;6830.248672645906;7020.929790702027;7024.683889225099;7060.43516518667;6745.089412929388;6751.426128779109;6763.7632682855865;6768.661566921536;6783.118194634666;6473.611583304828;6817.318268173143;6852.040714299902;6863.313668633096;6870.553414028072;6388.87222255543;6397.776077837253;6429.710663020269;6510.837229069311;6585.703643335965;6613.933860661525;6622.337766223339;6641.867162656817;6646.169228846395;6648.83377915556;6347.17486726741;6382.234131904202;6435.613863168225;6486.54594178403;6495.805125846232;6322.209723784527;6402.871942561216;6557.2131344239;6566.179227596551;6577.835554111186;6464.127342808849;6495.837604059936;6506.707198175999;6517.576357536935;6518.2504012037325 05:03:38 INFO - PID 1694 | |1;ext.html;724.5906063074364;733.2117973178835;831.4013909984812;1109.6615532262667;1291.5221368093808;32580.837095814517;38344.61655383445;39743.801280993626;39744.80127599358;39791.40312895309;31229.531557026607;38304.85085447434;39240.607593924055;39448;39771;8124.146964568724;8290.502569845828;8536.87194692077;8785.560721963908;8800.207981281683;8674.696385626505;8766.780830479225;8789.208971192591;8796.47221166729;8797.516136612483;8703.95648021759;8719.04090550039;8778.385513014091;8809.823803523926;8815.735527934172;8692.521911294876;8737.43206691563;8754.212120909116;8776.429532080394;8782.824343513093;8633.481991080493;8700.042995270514;8710.99823520297;8717.302615790784;8729.563521823948;38428.80785596082;38535;38700.41949370762;38764.22471550553;38815;3086.7067628575473;3112.1286039908637;3122.3443076953868;3143.4813255812765;3222.2105584132037;28394.85802570974;28404.863805447756;28438.715612844022;29043.273918152005;29061.273468163254;2798.7760979121826;2827.2507785436874;2883.3941895538865;2893.85530723463;2911.170316459799;271542;293919.5304023488;349119;349175;351071;50077.74961125244;50103;50257.74871125694;50274;50306.49693503091;52347.73826130845;52439.73780131075;52488.212676809875;52547;52733.7363313181;14637.92681036588;14741.92629036848;14763.704725905422;14769.483068092564;14794.556163315117;11917.940410298066;11969.46137423818;11992.340421276738;11998.940005299917;12000.279983201035;12479.750404992032;13542.052056356157;13555.254461004739;13602.93198534001;13676.905847532174;5877.44164304399;5931.199288096138;5940.61386009908;5941.673207973517;5969.31352894414;983.1151963233004;984.7833476635129;985.8619793228954;996.4270544436978;1025.144004756037;23480.882595586914;23663.171788987303;23860.88069559676;23900.880495597412;24003.399915002265;996.6611352140162;1020.1685626214611;1105.701460605632;1126.9380184089953;1136.7158210447387;11378.54485820558;11956.684764675878;12088.516459341703;12169.026477881749;12177;449563.256551152;458633;467244;468908;468967;54240.45759542433;54534.63663408367;54964;55219;56138.877222455325;1416.964575885611;1421.7938398932304;1437;1461.795348651211;1503.8345781963976;24947.75052249454;28051.298717532223;28079.298017549725;28892.42215155727;28925.56611650785;29915.700842991293;35528.93413197608;37438.81280593688;37506.437403438424;37682.81158594299;388457.0577147096;391186;392155;392270;393430;30252.82345353706;30615.693843062174;30832.383352333276;30879.845600771852;30959;39365.86574188754;40400.98997525086;40443;40493.39259911163;40632.18735625212;28015.71984280131;28448.857755711088;28571.28571785722;29234.269143271587;29441.705582943898;28399.148025559265;28886;29028.709712903445;29348.55977160387;29404.411911762072;32787.508187376734;33173.50239746358;33731.83134084314;33908.49137262894;33915.4912676315;28596.42807143887;28881.277968050967;29375.559366609945;29455;29672;21987.23044693428;22828.31515054551;23576.76423235746;23668.763312366656;23993 05:03:38 INFO - PID 1694 | |2;jquery.html;419.1805021183586;421.9162027541752;433.3824300371969;443.11156131955437;447.47198305998927;18723.906380468077;19938.900305498453;21507.569848603038;22167;22422.88788556057;22257.44356391091;22647.320580382613;23341.066357345684;23458.64812027821;23470.41323966902;6382;6391.169148010752;6584.440322572563;6604.801855944305;6611.867762644768;4787.976060119712;4865.70805751656;4897.118518666639;4905.950940490585;4908.43552991407;4726.550977657117;4741.620670346364;4747.264174053027;4755.215389460752;4765.666403351766;4666.883327916812;6327.24073111225;6378.808635740912;6449.419552240321;6461.515386346043;5313.840584782462;5719.28508936383;5720.885582288331;5739.167820666022;5761.942380576224;27572.172834814988;28008.299792505146;28189;28618.713812861813;29113.417731645248;1880.3888736160666;1995.1520603743352;2041.1631231195138;2046.4065421027883;2063.8452116091203;16008.359665613478;16668.249928753114;16816.411425600167;17169.055701936388;17894.10529473521;1633.9101349425778;1739.4520725971279;1817.1913498493175;1832.2945665918585;1902.2295970132118;148061.25969370193;163098.1845090767;163176.9999999988;163299.9999999988;165358;10400.635977740743;12725.745485090247;12809.871901280869;12984;13059.542915997894;16468.83531164697;16487.67024659524;16498.34006639745;16506.917465412596;16524.421645242357;7442.7395041173295;8758.167974042455;8946.552672366355;9070.501122438198;9115.498647574446;7617.69529218825;8055.395845311625;8531.919410338789;8568.10034946334;8709.690317679242;7105.89341159883;7896;8008.119106898236;8036.718714844952;8042.557659328793;1869.7101949197895;2181.7709140540333;2201.1525562658494;2201.9889900550716;2375.0618505690154;922.2253307221965;923.819855128257;925.3245131054233;953.3088510829593;959.6065613098596;17161.570960726083;18106.728399074025;20202;20500.69248961267;21137.682934755685;906.3836591118103;967.3663750243602;995.5669283861544;1000.5247507434057;1008.7326858382535;10409.167266618653;11117.388543630179;11136.38749868765;11151.442427878574;11166;668590;764012;769657;773333;783971;151409;153968;162651.5602265967;162797;167536.97389078347;1086.4241951765578;1093.1855767453299;1203.9879601204052;1222.180160958075;1256.2588073036952;20433.59132817365;21679.458013549156;22641.433964151027;22657.320280391614;22877.542449151257;48639.02721945612;52942.67643308948;61600;64714;66231;86778.56610717159;87618.63912260543;88980;89250.55374723085;90580;8672.219500245008;8855.114488551093;8871.467711937305;8933.955330223567;9066.365354425126;13242.337883105614;13258.867411325764;13584.93207533956;13787.655308617364;13945.233012184428;10876.564937402416;11254.76197618245;11637.59268425635;12020.579279725167;12057.457414416196;10399.596054532542;11085.667429977113;11118.277311974696;11464.082873369944;11494.137939654727;10005.949970250102;11415.458913046965;11790.587329443772;11858.703532411759;12091.153619246568;8665.610047547749;8772.868406973774;8817.911820881709;8850.114988501098;8930.955345223232;9941.65204217849;11553.13351498624;11560.884391155982;11987.700307492383;11988.580399685969 05:03:38 INFO - PID 1694 | |3;mootools.html;1300.9349532523372;1468.3556905004846;1474.2776039740531;1484.8047321905867;1506.1189204315478;9329.346945713794;10587.364758114509;10938.507767150477;10986.945065274662;11316.660500185008;11030.22788404812;11154.776904461905;11221.495032723527;11223.551057957693;11236.775264494705;2453.791427728641;2473.0355161487037;2473.5794914864427;2475.900963961439;2476.3190122716305;2127.1597718901025;2346.9178578749747;2461.9753802462014;2465.3959779853963;2467.7532246775268;2409.132712223607;2444.1445494077107;2453.717822450414;2462.4336402627405;2466.7779899809016;2326.0463210083785;2359.0681680736184;2415.1184817541557;2427.1626288930293;2429.708434987795;1964.980350196494;2344.8358614896965;2347.8826058696995;2348.8120950323932;2356.988215058931;10942.835857462145;11135;11136;11165.274257173258;11165.72085697856;6150.7847225346895;6354.9364506354805;6372.522060845455;6373.107764912916;6387.169667943184;3940.8817735467983;3966.920661586781;4044.2922488564677;4075.3683179107284;4092.6112019358116;1115.1636272795404;1140.8174692049315;1143.9704266160438;1152.4065106470175;1174.1370092981651;13849.86150138506;14189;15214.08715477064;15362.770978321707;15366.30851611669;5303.973480132575;5439.238506609078;5473.397926228112;5477.534409575151;5485.286912701403;11421.257618254787;11596.420178991017;11633;11668.474918628512;11690.947814696718;6085.391460853879;6242.469390101802;6263.185785847811;6273.341299163522;6277.183966084471;5790.71046447676;5901;5914.763409463573;5935.554833387427;5953.136795164677;4033.5361433435532;4217.325227963511;4279.7646129462555;4301.913961720748;4315.395844581761;1057.6404022632341;1250.6435665835193;1250.8311377963857;1265.044891107208;1267.866873978219;642.5116911147561;777.6306254529167;794.85692575337;796.6016991504248;816.5794615772882;6712.83217919556;6881;7042.7887163385185;7085.610291433917;7090.645467726697;910.7814124610046;916.6058594804165;917.312015988009;924.4499522783933;930.7114794413618;4151.875443736692;4160.563140870226;4162.542120366757;4212.810423530948;4381.430414046217;13545.661358466117;14062.156270623795;14076.929615351857;14103;14139.080959737585;11405;12797.424115914806;13341.93329033368;13438.059335846398;13841.792373114411;9976.201903847676;10004.899951000543;10024.849627255597;10160.831504376943;10162.441065741456;5531.751071201725;6131.724072416841;6378.075179099097;6454.223874332866;6505.60966342021;11814.881851181723;12150.027997760335;12171.452284647035;12175.965042971093;12314.13801033919;11685.298882067103;12043.518259269531;12420.503179872703;12423.937880310541;12747.107702460738;8012.5192488450875;8291.046529648926;8373;8439.240468357877;8482.491050536988;7820.452568320163;9096.727098187064;9495.525223738923;10114;10133.695989120339;8627.094155113622;8660.913390866262;8717.389782715149;8759.299256059372;8773.824523509622;7177.318154775288;7249.710011599477;8454.915450845412;8483.915160848312;8551.358648101294;7749.7287594933905;7836.92163078362;7873.566953817595;7914.802129946797;7918.366530677416;5799.130130480462;5854.882902342015;5978.282606087298;6032.065029920369;6039.818805435844;5922.644641321534;5983.282006159115;6119.969400152971;6153.600255734165;6208.658523781055 05:03:38 INFO - PID 1694 | |4;prototype.html;369.5491500369549;388.31462468742654;399.46272263805173;407.45197709081276;410.93630487274464;6183.628982261068;6250.3748425661215;6302.495800335973;6394.520410969179;6427.646479443629;5742.626729262595;6174.548980989475;6294.779682711106;6316.336784637616;6329.905051424233;3957.76253424794;3993.8202780874785;4160.54234034256;4573.199690054244;4636.890214952188;3868.941965870514;4048.5951404859575;4640.651951103664;4654.557817007396;4676.158291507527;4607.884802879938;4608.5852273295395;4615.3077038444335;4629.560191781792;4635.327877457767;3806.90482737931;4491.698601527891;4533.093381323749;4636.09596128755;4642.701862578012;3460.8269586520573;3936.350502167139;3955.239918236386;3957.703172262063;3979.5224573051128;4664.65015123867;5122.76947537358;6239.875202495925;6243.625382477066;6333.524985626096;5408;5506.421825708323;5512.200730893998;5516;5797.652140871562;5999.250093738283;6323.241211054703;6814.761483348108;6859.416949559293;6956.373926346602;4890.926636100461;4892.9510704892855;4896.779644915951;4907.497176440042;4914.434839993375;6945.603766700531;6986.930130698679;7214.639268036577;7237.200469753369;7250.564966101998;4355.954570902961;4375.890602734893;4700.6474514410875;4751.786169622375;4762.9523704763205;4823.903521929542;4837.814735389782;4839.661223714376;4841.3222148899185;4860.246661767432;4914.508549145057;5408.323959505062;5531.25328080712;5584.246126772834;5723.998300297431;5037.697738135724;5950.732217050243;6863.759768408082;6871.381575658214;6921.723131074801;1482.4366740638488;1750.291132091505;1758.2878934031737;1760.850327722158;1763.206557049333;1127.8326931625727;1148.5405837665;1193.6478738772082;1207.6799648093263;1222.040698052025;5702.144678298288;6498.675066246763;6502.479801615859;6528.477721782246;6593.901091483632;5859.747839948869;6592.714420688016;7020.648967551602;7067.399271061914;7074.787756367317;5481.862953426196;6483.448906842971;6493.610383376918;6511.413972742381;6511.706973186218;2861.7567506761743;3054.389122175574;3607.873724419685;3689.5203623529305;3699.5190625218547;6744.651069785964;7229.89155162673;7248.492605517668;7288.105092675943;7306.794378927524;6061;6640.746034443088;6757.526973111835;7294.598797066213;7318.414526837841;6340.365963403623;6917.412019978358;6979.93020069803;7272.527285726411;7290.19327558883;5960.582759206987;7066.5160316332085;7073.82315442118;7084.539504932163;7097.183823860116;6043.365446628217;6392.3927226913365;6614.404703576702;6617.37874220819;6927.653617319013;7106.614210229162;7156.85686286261;7258.383037441877;7314.890276645748;7351.926480735338;4957.256411538298;4988.575971042502;4991.600671946163;4994.80020799164;5009.974950125372;6784.525083244125;6995.510314277952;6998.685059172248;7039.366457018893;7062.364387205176;5835;6334.307919134441;6793.0450254139605;6814.829629259309;6848.828779280558;5886.264216972879;6183.96985477122;6230.345813689497;6740.9325906740305;6823.577629941497;6539.673016349258;6575;6609.372109649576;6609.405153536205;6646.933530664632;6550.377714117151;6733.878828169111;6750.594964302158;6783.18601767791;6783.59298442095;5830.387809280134;6345.333739957238;6542.54202205841;6564.5076619254705;6644.601323920387 05:03:38 INFO - PID 1694 | |5;yui.html;689.7758228575714;742.7771668499453;743.8698227810136;744.7021191523392;754.6717178027558;15278.618034549141;16332.591685207875;16338.428155014577;16356.345746170155;16405.917970410148;14962.775558366606;15148.318325675344;15150.090994540335;15168.393264269416;15186.240687965612;938.9483778168461;965.4496936746023;972.8200282947641;998.1415982255255;1003.4781913405025;1014.9594016239341;1022.7136401807469;1023.8720159980003;1027.573556973855;1032.5250384822991;1048.051513380392;1050.322541960435;1069.0218450118132;1072.485207100592;1074.382230217624;1065.6962765611802;1066.5520481397755;1067.0023528001266;1070.7804899995483;1073.3506228731621;792.1484404265437;794.320855668401;794.9920500794976;795.7692269241913;804.5896592737746;16257.512274631661;16562.337506499727;16724.331026758915;16762.83237167625;16808.243629036722;14867.033642813183;14881.627959301104;14914.627134321729;14968.550943471713;15264.389424423121;11091.279066860629;11533.365664888428;11547.942260288644;11618.651440456715;12016.69958251042;3091.938161236763;3093.7060979207163;3118.438681037412;3159.4628913084603;3226.6128064632394;70364.6481767593;98738;99422.50288748583;99574.99999999927;100477.4976125122;11275.887241127648;11497.54009839597;11793.469293881795;11887.40562971848;11935.522579096913;23801.523969520513;24045.677487738343;24169.758302417104;24223;24259.878700606383;7769.961150194213;7929.365650747926;7955.8408831823035;8032.15662355456;8206.58967051657;3995.6403923647013;4122.113745544722;4183.5398106208295;4205.600467955539;4220.894477638022;4107.527634322091;4195.958040419557;4198.8110535026;4227.852025179165;4233.216854881795;728.839655275849;834.9749507514784;851.8679604661287;854.8461276970205;870.5038128266954;571.6084482129671;579.9391063938226;581.0644861772543;584.0334246821517;597.9551533634908;9143.314251431037;10256.692299231036;10411.94794026025;10432.947835260775;10727.570897164182;556.4796914884515;569.2116418760047;586.352080950552;595.4570306675299;597.2534332084894;4557.156925968707;4814.8796280093275;4821.228603423436;4825.227963525819;4848.151573474628;99131.50434247927;99144.50427747959;103663;105397.47301263445;106241;60388.28252728638;80312.59843700861;83021;84869.15130848736;85115.57442212873;74661.50676986539;75536.62231688916;75994.24005759982;76263;77877.61061194658;8135.227153420416;10767.300125491818;10976.451177440937;11011.61459348919;11224.831627525431;36851.81574092113;37012.81493592515;37580;38421.6157838418;39147.217055658155;48749;48951.510484894694;49034.26448603202;49416.752916236626;50035.24947125723;13645.385957631732;13852.384166434922;13882.652933676738;13923.23422211788;13929;12069.939650301692;14736;14757.631059223606;14780.48268310604;14803.0378025428;11859.940700296444;12118.394080296126;13733.381997809922;13867.375968081662;14423.3509492071;13221.603351899459;13415.798763018367;13545.255010974492;13595.591048914781;14299.714005720036;13405.32973351309;13461;13494;13765.724685506033;14540.636484087983;9817.361871478332;9870.753231169278;9965.950170249102;10077.388796955951;10162.593496260362;9169.679061232824;9418.95290523543;10374.792504150026;10633.043026127685;11227.831582526433 05:03:38 INFO - PID 1694 | __end_tp_report 05:03:38 INFO - PID 1694 | __start_cc_report 05:03:38 INFO - PID 1694 | _x_x_mozilla_cycle_collect,424 05:03:38 INFO - PID 1694 | __end_cc_report 05:03:38 INFO - PID 1694 | __startTimestamp1491134618626__endTimestamp 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | ------- Summary: start ------- 05:03:38 INFO - PID 1694 | Number of tests: 6 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | [#0] dojo.html Cycles:165 Average:6197.91 Median:6429.71 stddev:789.00 (12.3%) stddev-sans-first:742.86 05:03:38 INFO - PID 1694 | Values: 2723.6 2816.8 3604.8 3610.3 3626.6 6145.6 6203.9 6208.5 6234.5 6272.3 4932.5 6125.0 6191.2 6197.2 6237.5 4918.5 5361.0 5420.1 5497.6 5620.7 5480.2 5506.0 5571.4 5603.7 5636.9 5403.0 5453.2 5526.4 5544.9 5654.7 5511.0 5541.2 5549.3 5553.6 5586.6 5485.6 5492.2 5492.6 5497.4 5507.1 5378.9 6037.1 6161.1 6162.8 6212.6 6735.0 6778.0 6783.2 6784.9 6797.7 6862.4 6882.9 6887.5 6890.5 6899.7 6186.9 6212.4 6297.5 6304.1 6339.7 6961.9 6966.5 6989.2 7011.8 7107.8 5663.3 5783.7 6265.1 6383.9 6521.9 6788.4 6844.2 6870.5 6873.0 6875.0 6424.7 6502.6 6736.3 6755.1 6766.6 6693.7 6717.9 6755.1 6806.9 6819.0 5391.2 5401.3 5406.6 5415.7 5440.9 4709.7 4741.9 4774.8 4788.8 4829.9 6220.9 6335.4 6400.0 6441.8 6457.1 5992.9 6717.1 6886.0 6907.8 6937.1 5405.6 6423.5 6431.9 6453.5 6468.4 5882.2 5963.4 6013.5 6048.2 6052.0 7036.2 7038.8 7039.5 7047.6 7059.5 6792.0 6798.3 6833.0 6834.4 6870.1 6755.1 6830.2 7020.9 7024.7 7060.4 6745.1 6751.4 6763.8 6768.7 6783.1 6473.6 6817.3 6852.0 6863.3 6870.6 6388.9 6397.8 6429.7 6510.8 6585.7 6613.9 6622.3 6641.9 6646.2 6648.8 6347.2 6382.2 6435.6 6486.5 6495.8 6322.2 6402.9 6557.2 6566.2 6577.8 6464.1 6495.8 6506.7 6517.6 6518.3 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | [#1] ext.html Cycles:180 Average:52543.18 Median:33911.99 stddev:105361.98 (310.7%) stddev-sans-first:105585.72 05:03:38 INFO - PID 1694 | Values: 724.6 733.2 831.4 1109.7 1291.5 32580.8 38344.6 39743.8 39744.8 39791.4 31229.5 38304.9 39240.6 39448.0 39771.0 8124.1 8290.5 8536.9 8785.6 8800.2 8674.7 8766.8 8789.2 8796.5 8797.5 8704.0 8719.0 8778.4 8809.8 8815.7 8692.5 8737.4 8754.2 8776.4 8782.8 8633.5 8700.0 8711.0 8717.3 8729.6 38428.8 38535.0 38700.4 38764.2 38815.0 3086.7 3112.1 3122.3 3143.5 3222.2 28394.9 28404.9 28438.7 29043.3 29061.3 2798.8 2827.3 2883.4 2893.9 2911.2 271542.0 293919.5 349119.0 349175.0 351071.0 50077.7 50103.0 50257.7 50274.0 50306.5 52347.7 52439.7 52488.2 52547.0 52733.7 14637.9 14741.9 14763.7 14769.5 14794.6 11917.9 11969.5 11992.3 11998.9 12000.3 12479.8 13542.1 13555.3 13602.9 13676.9 5877.4 5931.2 5940.6 5941.7 5969.3 983.1 984.8 985.9 996.4 1025.1 23480.9 23663.2 23860.9 23900.9 24003.4 996.7 1020.2 1105.7 1126.9 1136.7 11378.5 11956.7 12088.5 12169.0 12177.0 449563.3 458633.0 467244.0 468908.0 468967.0 54240.5 54534.6 54964.0 55219.0 56138.9 1417.0 1421.8 1437.0 1461.8 1503.8 24947.8 28051.3 28079.3 28892.4 28925.6 29915.7 35528.9 37438.8 37506.4 37682.8 388457.1 391186.0 392155.0 392270.0 393430.0 30252.8 30615.7 30832.4 30879.8 30959.0 39365.9 40401.0 40443.0 40493.4 40632.2 28015.7 28448.9 28571.3 29234.3 29441.7 28399.1 28886.0 29028.7 29348.6 29404.4 32787.5 33173.5 33731.8 33908.5 33915.5 28596.4 28881.3 29375.6 29455.0 29672.0 21987.2 22828.3 23576.8 23668.8 23993.0 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | [#2] jquery.html Cycles:180 Average:42474.68 Median:22767.43 stddev:126142.44 (554.0%) stddev-sans-first:126456.77 05:03:38 INFO - PID 1694 | Values: 419.2 421.9 433.4 443.1 447.5 18723.9 19938.9 21507.6 22167.0 22422.9 22257.4 22647.3 23341.1 23458.6 23470.4 6382.0 6391.2 6584.4 6604.8 6611.9 4788.0 4865.7 4897.1 4906.0 4908.4 4726.6 4741.6 4747.3 4755.2 4765.7 4666.9 6327.2 6378.8 6449.4 6461.5 5313.8 5719.3 5720.9 5739.2 5761.9 27572.2 28008.3 28189.0 28618.7 29113.4 1880.4 1995.2 2041.2 2046.4 2063.8 16008.4 16668.2 16816.4 17169.1 17894.1 1633.9 1739.5 1817.2 1832.3 1902.2 148061.3 163098.2 163177.0 163300.0 165358.0 10400.6 12725.7 12809.9 12984.0 13059.5 16468.8 16487.7 16498.3 16506.9 16524.4 7442.7 8758.2 8946.6 9070.5 9115.5 7617.7 8055.4 8531.9 8568.1 8709.7 7105.9 7896.0 8008.1 8036.7 8042.6 1869.7 2181.8 2201.2 2202.0 2375.1 922.2 923.8 925.3 953.3 959.6 17161.6 18106.7 20202.0 20500.7 21137.7 906.4 967.4 995.6 1000.5 1008.7 10409.2 11117.4 11136.4 11151.4 11166.0 668590.0 764012.0 769657.0 773333.0 783971.0 151409.0 153968.0 162651.6 162797.0 167537.0 1086.4 1093.2 1204.0 1222.2 1256.3 20433.6 21679.5 22641.4 22657.3 22877.5 48639.0 52942.7 61600.0 64714.0 66231.0 86778.6 87618.6 88980.0 89250.6 90580.0 8672.2 8855.1 8871.5 8934.0 9066.4 13242.3 13258.9 13584.9 13787.7 13945.2 10876.6 11254.8 11637.6 12020.6 12057.5 10399.6 11085.7 11118.3 11464.1 11494.1 10005.9 11415.5 11790.6 11858.7 12091.2 8665.6 8772.9 8817.9 8850.1 8931.0 9941.7 11553.1 11560.9 11987.7 11988.6 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | [#3] mootools.html Cycles:180 Average:6719.75 Median:3953.90 stddev:4099.60 (103.7%) stddev-sans-first:4090.88 05:03:38 INFO - PID 1694 | Values: 1300.9 1468.4 1474.3 1484.8 1506.1 9329.3 10587.4 10938.5 10986.9 11316.7 11030.2 11154.8 11221.5 11223.6 11236.8 2453.8 2473.0 2473.6 2475.9 2476.3 2127.2 2346.9 2462.0 2465.4 2467.8 2409.1 2444.1 2453.7 2462.4 2466.8 2326.0 2359.1 2415.1 2427.2 2429.7 1965.0 2344.8 2347.9 2348.8 2357.0 10942.8 11135.0 11136.0 11165.3 11165.7 6150.8 6354.9 6372.5 6373.1 6387.2 3940.9 3966.9 4044.3 4075.4 4092.6 1115.2 1140.8 1144.0 1152.4 1174.1 13849.9 14189.0 15214.1 15362.8 15366.3 5304.0 5439.2 5473.4 5477.5 5485.3 11421.3 11596.4 11633.0 11668.5 11690.9 6085.4 6242.5 6263.2 6273.3 6277.2 5790.7 5901.0 5914.8 5935.6 5953.1 4033.5 4217.3 4279.8 4301.9 4315.4 1057.6 1250.6 1250.8 1265.0 1267.9 642.5 777.6 794.9 796.6 816.6 6712.8 6881.0 7042.8 7085.6 7090.6 910.8 916.6 917.3 924.4 930.7 4151.9 4160.6 4162.5 4212.8 4381.4 13545.7 14062.2 14076.9 14103.0 14139.1 11405.0 12797.4 13341.9 13438.1 13841.8 9976.2 10004.9 10024.8 10160.8 10162.4 5531.8 6131.7 6378.1 6454.2 6505.6 11814.9 12150.0 12171.5 12176.0 12314.1 11685.3 12043.5 12420.5 12423.9 12747.1 8012.5 8291.0 8373.0 8439.2 8482.5 7820.5 9096.7 9495.5 10114.0 10133.7 8627.1 8660.9 8717.4 8759.3 8773.8 7177.3 7249.7 8454.9 8483.9 8551.4 7749.7 7836.9 7873.6 7914.8 7918.4 5799.1 5854.9 5978.3 6032.1 6039.8 5922.6 5983.3 6120.0 6153.6 6208.7 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | [#4] prototype.html Cycles:180 Average:5479.58 Median:6179.09 stddev:1711.57 (27.7%) stddev-sans-first:1672.85 05:03:38 INFO - PID 1694 | Values: 369.5 388.3 399.5 407.5 410.9 6183.6 6250.4 6302.5 6394.5 6427.6 5742.6 6174.5 6294.8 6316.3 6329.9 3957.8 3993.8 4160.5 4573.2 4636.9 3868.9 4048.6 4640.7 4654.6 4676.2 4607.9 4608.6 4615.3 4629.6 4635.3 3806.9 4491.7 4533.1 4636.1 4642.7 3460.8 3936.4 3955.2 3957.7 3979.5 4664.7 5122.8 6239.9 6243.6 6333.5 5408.0 5506.4 5512.2 5516.0 5797.7 5999.3 6323.2 6814.8 6859.4 6956.4 4890.9 4893.0 4896.8 4907.5 4914.4 6945.6 6986.9 7214.6 7237.2 7250.6 4356.0 4375.9 4700.6 4751.8 4763.0 4823.9 4837.8 4839.7 4841.3 4860.2 4914.5 5408.3 5531.3 5584.2 5724.0 5037.7 5950.7 6863.8 6871.4 6921.7 1482.4 1750.3 1758.3 1760.9 1763.2 1127.8 1148.5 1193.6 1207.7 1222.0 5702.1 6498.7 6502.5 6528.5 6593.9 5859.7 6592.7 7020.6 7067.4 7074.8 5481.9 6483.4 6493.6 6511.4 6511.7 2861.8 3054.4 3607.9 3689.5 3699.5 6744.7 7229.9 7248.5 7288.1 7306.8 6061.0 6640.7 6757.5 7294.6 7318.4 6340.4 6917.4 6979.9 7272.5 7290.2 5960.6 7066.5 7073.8 7084.5 7097.2 6043.4 6392.4 6614.4 6617.4 6927.7 7106.6 7156.9 7258.4 7314.9 7351.9 4957.3 4988.6 4991.6 4994.8 5010.0 6784.5 6995.5 6998.7 7039.4 7062.4 5835.0 6334.3 6793.0 6814.8 6848.8 5886.3 6184.0 6230.3 6740.9 6823.6 6539.7 6575.0 6609.4 6609.4 6646.9 6550.4 6733.9 6750.6 6783.2 6783.6 5830.4 6345.3 6542.5 6564.5 6644.6 05:03:38 INFO - PID 1694 | 05:03:38 INFO - PID 1694 | [#5] yui.html Cycles:180 Average:19159.90 Median:24196.38 stddev:26706.58 (110.4%) stddev-sans-first:26745.48 05:03:38 INFO - PID 1694 | Values: 689.8 742.8 743.9 744.7 754.7 15278.6 16332.6 16338.4 16356.3 16405.9 14962.8 15148.3 15150.1 15168.4 15186.2 938.9 965.4 972.8 998.1 1003.5 1015.0 1022.7 1023.9 1027.6 1032.5 1048.1 1050.3 1069.0 1072.5 1074.4 1065.7 1066.6 1067.0 1070.8 1073.4 792.1 794.3 795.0 795.8 804.6 16257.5 16562.3 16724.3 16762.8 16808.2 14867.0 14881.6 14914.6 14968.6 15264.4 11091.3 11533.4 11547.9 11618.7 12016.7 3091.9 3093.7 3118.4 3159.5 3226.6 70364.6 98738.0 99422.5 99575.0 100477.5 11275.9 11497.5 11793.5 11887.4 11935.5 23801.5 24045.7 24169.8 24223.0 24259.9 7770.0 7929.4 7955.8 8032.2 8206.6 3995.6 4122.1 4183.5 4205.6 4220.9 4107.5 4196.0 4198.8 4227.9 4233.2 728.8 835.0 851.9 854.8 870.5 571.6 579.9 581.1 584.0 598.0 9143.3 10256.7 10411.9 10432.9 10727.6 556.5 569.2 586.4 595.5 597.3 4557.2 4814.9 4821.2 4825.2 4848.2 99131.5 99144.5 103663.0 105397.5 106241.0 60388.3 80312.6 83021.0 84869.2 85115.6 74661.5 75536.6 75994.2 76263.0 77877.6 8135.2 10767.3 10976.5 11011.6 11224.8 36851.8 37012.8 37580.0 38421.6 39147.2 48749.0 48951.5 49034.3 49416.8 50035.2 13645.4 13852.4 13882.7 13923.2 13929.0 12069.9 14736.0 14757.6 14780.5 14803.0 11859.9 12118.4 13733.4 13867.4 14423.4 13221.6 13415.8 13545.3 13595.6 14299.7 13405.3 13461.0 13494.0 13765.7 14540.6 9817.4 9870.8 9966.0 10077.4 10162.6 9169.7 9419.0 10374.8 10633.0 11227.8 05:03:38 INFO - PID 1694 | -------- Summary: end -------- 05:03:38 INFO - PID 1694 | 05:03:39 INFO - TEST-INFO | 1694: exit 0 05:03:39 INFO - TEST-OK | dromaeo_css | took 1117950ms 05:03:39 INFO - TEST-START | kraken 05:03:39 INFO - operating with platform_type : mac_ 05:03:39 INFO - Initialising browser for kraken test... 05:03:39 INFO - TEST-INFO | started process 1701 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpLw38Cl/profile http://localhost:49257/getInfo.html) 05:03:41 INFO - PID 1701 | 2017-04-02 05:03:41.946 plugin-container[1703:18334] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x892b, name = 'com.apple.tsm.portname' 05:03:41 INFO - PID 1701 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:41 INFO - PID 1701 | 2017-04-02 05:03:41.947 plugin-container[1703:18334] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 05:03:41 INFO - PID 1701 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:41 INFO - PID 1701 | 2017-04-02 05:03:41.948 plugin-container[1703:18334] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:42 INFO - PID 1701 | __metrics Screen width/height:1600/1200 05:03:42 INFO - PID 1701 | colorDepth:24 05:03:42 INFO - PID 1701 | Browser inner width/height: 1024/689 05:03:42 INFO - PID 1701 | __metrics 05:03:42 ERROR - PID 1701 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 05:03:42 INFO - TEST-INFO | 1701: exit 0 05:03:42 INFO - Browser initialized. 05:03:42 INFO - Running cycle 1/1 for kraken test... 05:03:42 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpLw38Cl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:45 INFO - PID 1704 | 2017-04-02 05:03:45.354 plugin-container[1705:18467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 05:03:45 INFO - PID 1704 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:45 INFO - PID 1704 | 2017-04-02 05:03:45.354 plugin-container[1705:18467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 05:03:45 INFO - PID 1704 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:45 INFO - PID 1704 | 2017-04-02 05:03:45.354 plugin-container[1705:18467] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:55 INFO - PID 1704 | RSS: Main: 228945920 05:03:55 INFO - PID 1704 | 05:03:58 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:59 INFO - PID 1704 | RSS: Main: 243965952 05:03:59 INFO - PID 1704 | 05:04:01 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-dft) 05:04:02 INFO - PID 1704 | RSS: Main: 251834368 05:04:02 INFO - PID 1704 | 05:04:05 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-fft) 05:04:06 INFO - PID 1704 | RSS: Main: 254111744 05:04:06 INFO - PID 1704 | 05:04:08 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-oscillator) 05:04:09 INFO - PID 1704 | RSS: Main: 255164416 05:04:09 INFO - PID 1704 | 05:04:11 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:11 INFO - PID 1704 | RSS: Main: 256884736 05:04:11 INFO - PID 1704 | 05:04:15 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49257/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:15 INFO - PID 1704 | RSS: Main: 262569984 05:04:15 INFO - PID 1704 | 05:04:19 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49257/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:19 INFO - PID 1704 | RSS: Main: 263073792 05:04:19 INFO - PID 1704 | 05:04:23 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49257/tests/kraken/driver.html?testName=json-parse-financial) 05:04:23 INFO - PID 1704 | RSS: Main: 262615040 05:04:23 INFO - PID 1704 | 05:04:25 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:25 INFO - PID 1704 | RSS: Main: 262197248 05:04:25 INFO - PID 1704 | 05:04:27 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:28 INFO - PID 1704 | RSS: Main: 262025216 05:04:28 INFO - PID 1704 | 05:04:30 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:31 INFO - PID 1704 | RSS: Main: 262156288 05:04:31 INFO - PID 1704 | 05:04:34 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:35 INFO - PID 1704 | RSS: Main: 262557696 05:04:35 INFO - PID 1704 | 05:04:38 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:39 INFO - PID 1704 | RSS: Main: 259735552 05:04:39 INFO - PID 1704 | 05:04:40 INFO - PID 1704 | Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49257/tests/kraken/driver.html?testName=ai-astar) 05:04:41 INFO - PID 1704 | RSS: Main: 263163904 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | __start_tp_report 05:04:41 INFO - PID 1704 | _x_x_mozilla_page_load 05:04:41 INFO - PID 1704 | _x_x_mozilla_page_load_details 05:04:41 INFO - PID 1704 | |i|pagename|runs| 05:04:41 INFO - PID 1704 | |0;ai-astar;111;122;164;184;135;124;122;169;162;125 05:04:41 INFO - PID 1704 | |1;audio-beat-detection;141;103;151;195;125;116;119;117;138;132 05:04:41 INFO - PID 1704 | |2;audio-dft;221;224;226;220;230;217;211;212;209;214 05:04:41 INFO - PID 1704 | |3;audio-fft;82;61;59;91;62;59;58;62;89;76 05:04:41 INFO - PID 1704 | |4;audio-oscillator;90;71;86;73;72;83;73;72;102;121 05:04:41 INFO - PID 1704 | |5;imaging-gaussian-blur;129;107;100;138;92;94;92;107;134;115 05:04:41 INFO - PID 1704 | |6;imaging-darkroom;100;102;102;101;100;102;102;100;101;149 05:04:41 INFO - PID 1704 | |7;imaging-desaturate;123;162;146;101;100;101;93;161;106;108 05:04:41 INFO - PID 1704 | |8;json-parse-financial;52;51;51;51;52;53;52;52;53;53 05:04:41 INFO - PID 1704 | |9;json-stringify-tinderbox;60;62;67;72;67;60;59;57;70;61 05:04:41 INFO - PID 1704 | |10;stanford-crypto-aes;85;85;88;100;89;89;89;87;87;86 05:04:41 INFO - PID 1704 | |11;stanford-crypto-ccm;179;167;148;151;139;146;147;150;233;176 05:04:41 INFO - PID 1704 | |12;stanford-crypto-pbkdf2;177;196;198;210;229;194;196;192;224;247 05:04:41 INFO - PID 1704 | |13;stanford-crypto-sha256-iterative;71;70;72;72;72;69;79;70;70;72 05:04:41 INFO - PID 1704 | __end_tp_report 05:04:41 INFO - PID 1704 | __start_cc_report 05:04:41 INFO - PID 1704 | _x_x_mozilla_cycle_collect,1036 05:04:41 INFO - PID 1704 | __end_cc_report 05:04:41 INFO - PID 1704 | __startTimestamp1491134681075__endTimestamp 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | ------- Summary: start ------- 05:04:41 INFO - PID 1704 | Number of tests: 14 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#0] ai-astar Cycles:10 Average:141.80 Median:148.50 stddev:25.39 (17.1%) stddev-sans-first:24.36 05:04:41 INFO - PID 1704 | Values: 111.0 122.0 164.0 184.0 135.0 124.0 122.0 169.0 162.0 125.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:135.00 stddev:25.73 (19.1%) stddev-sans-first:27.15 05:04:41 INFO - PID 1704 | Values: 141.0 103.0 151.0 195.0 125.0 116.0 119.0 117.0 138.0 132.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#2] audio-dft Cycles:10 Average:218.40 Median:220.50 stddev:6.98 (3.2%) stddev-sans-first:7.34 05:04:41 INFO - PID 1704 | Values: 221.0 224.0 226.0 220.0 230.0 217.0 211.0 212.0 209.0 214.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#3] audio-fft Cycles:10 Average:69.90 Median:69.00 stddev:13.24 (19.2%) stddev-sans-first:13.30 05:04:41 INFO - PID 1704 | Values: 82.0 61.0 59.0 91.0 62.0 59.0 58.0 62.0 89.0 76.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:73.00 stddev:16.44 (22.5%) stddev-sans-first:17.31 05:04:41 INFO - PID 1704 | Values: 90.0 71.0 86.0 73.0 72.0 83.0 73.0 72.0 102.0 121.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:136.00 stddev:17.52 (12.9%) stddev-sans-first:17.30 05:04:41 INFO - PID 1704 | Values: 129.0 107.0 100.0 138.0 92.0 94.0 92.0 107.0 134.0 115.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:102.00 stddev:15.17 (14.9%) stddev-sans-first:15.94 05:04:41 INFO - PID 1704 | Values: 100.0 102.0 102.0 101.0 100.0 102.0 102.0 100.0 101.0 149.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#7] imaging-desaturate Cycles:10 Average:120.10 Median:134.50 stddev:26.50 (19.7%) stddev-sans-first:28.09 05:04:41 INFO - PID 1704 | Values: 123.0 162.0 146.0 101.0 100.0 101.0 93.0 161.0 106.0 108.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 05:04:41 INFO - PID 1704 | Values: 52.0 51.0 51.0 51.0 52.0 53.0 52.0 52.0 53.0 53.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.50 stddev:5.10 (7.9%) stddev-sans-first:5.25 05:04:41 INFO - PID 1704 | Values: 60.0 62.0 67.0 72.0 67.0 60.0 59.0 57.0 70.0 61.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:87.50 stddev:4.33 (4.9%) stddev-sans-first:4.40 05:04:41 INFO - PID 1704 | Values: 85.0 85.0 88.0 100.0 89.0 89.0 89.0 87.0 87.0 86.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#11] stanford-crypto-ccm Cycles:10 Average:163.60 Median:159.00 stddev:27.88 (17.5%) stddev-sans-first:29.01 05:04:41 INFO - PID 1704 | Values: 179.0 167.0 148.0 151.0 139.0 146.0 147.0 150.0 233.0 176.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:206.30 Median:204.00 stddev:21.07 (10.3%) stddev-sans-first:19.49 05:04:41 INFO - PID 1704 | Values: 177.0 196.0 198.0 210.0 229.0 194.0 196.0 192.0 224.0 247.0 05:04:41 INFO - PID 1704 | 05:04:41 INFO - PID 1704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:2.79 (3.9%) stddev-sans-first:2.95 05:04:41 INFO - PID 1704 | Values: 71.0 70.0 72.0 72.0 72.0 69.0 79.0 70.0 70.0 72.0 05:04:41 INFO - PID 1704 | -------- Summary: end -------- 05:04:41 INFO - PID 1704 | 05:04:41 INFO - TEST-INFO | 1704: exit 0 05:04:42 INFO - TEST-OK | kraken | took 62708ms 05:04:42 INFO - SUITE-END | took 1180s 05:04:42 INFO - Completed test suite (00:19:40) 05:04:42 INFO - javascript benchmark 05:04:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7757.016982473076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2723.6186933829267, 2816.760575351095, 3604.8377822997963, 3610.332088563616, 3626.6192049834767, 6145.569810113294, 6203.937960620392, 6208.503319734422, 6234.5324100692405, 6272.278687950893, 4932.482089380617, 6124.960759790124, 6191.195144631203, 6197.19436473259, 6237.5009999200065, 4918.458969513351, 5361.035013697543, 5420.07858664028, 5497.642653227527, 5620.718964051781, 5480.150576660624, 5506.0, 5571.387147413781, 5603.691796951166, 5636.915446268309, 5403.0, 5453.182022696587, 5526.392096869341, 5544.861378465571, 5654.745536450849, 5510.972445137749, 5541.224228607998, 5549.278593782823, 5553.555715542747, 5586.608937374385, 5485.588580856452, 5492.176173573956, 5492.5605951523785, 5497.39528651848, 5507.091329930557, 5378.91931621026, 6037.1246169305205, 6161.106639537287, 6162.7534898604, 6212.627242365427, 6734.966325168391, 6778.0, 6783.152105986752, 6784.864302713968, 6797.694103765293, 6862.416694580967, 6882.931170688279, 6887.5178737488395, 6890.517663763539, 6899.689513971884, 6186.948218802814, 6212.378762123752, 6297.464715499188, 6304.117423560705, 6339.714712837887, 6961.860762784716, 6966.5471744336455, 6989.196242432084, 7011.754588589375, 7107.786766397016, 5663.263775709132, 5783.71081445926, 6265.091561723524, 6383.904241436289, 6521.869562608721, 6788.389044985975, 6844.21291551468, 6870.45036397087, 6873.0, 6875.0, 6424.71088801005, 6502.60984340941, 6736.292689267654, 6755.121834161528, 6766.627835469097, 6693.665316734144, 6717.899231511531, 6755.121834161626, 6806.8638627228165, 6819.0, 5391.191321301758, 5401.297831281908, 5406.567474602022, 5415.729213539386, 5440.939016891668, 4709.740964246931, 4741.857744267678, 4774.785134668949, 4788.832390866303, 4829.9034019319415, 6220.937790622126, 6335.366463353628, 6399.968000159969, 6441.774537891151, 6457.096006559085, 5992.880142397127, 6717.059611654372, 6885.965570172117, 6907.758228461979, 6937.098177236927, 5405.567554595702, 6423.518236132309, 6431.935680643133, 6453.45145662624, 6468.353164683494, 5882.205902203148, 5963.403659634002, 6013.4888534474185, 6048.213732214872, 6051.971164901977, 7036.226015138331, 7038.824029399306, 7039.472039596948, 7047.577145371294, 7059.5058345915295, 6792.0, 6798.252192258748, 6833.0, 6834.419074378535, 6870.106886104774, 6755.088063111417, 6830.248672645906, 7020.929790702027, 7024.683889225099, 7060.43516518667, 6745.089412929388, 6751.426128779109, 6763.7632682855865, 6768.661566921536, 6783.118194634666, 6473.611583304828, 6817.318268173143, 6852.040714299902, 6863.313668633096, 6870.553414028072, 6388.87222255543, 6397.776077837253, 6429.710663020269, 6510.837229069311, 6585.703643335965, 6613.933860661525, 6622.337766223339, 6641.867162656817, 6646.169228846395, 6648.83377915556, 6347.17486726741, 6382.234131904202, 6435.613863168225, 6486.54594178403, 6495.805125846232, 6322.209723784527, 6402.871942561216, 6557.2131344239, 6566.179227596551, 6577.835554111186, 6464.127342808849, 6495.837604059936, 6506.707198175999, 6517.576357536935, 6518.2504012037325], "value": 6139.918686615339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.5906063074364, 733.2117973178835, 831.4013909984812, 1109.6615532262667, 1291.5221368093808, 32580.837095814517, 38344.61655383445, 39743.801280993626, 39744.80127599358, 39791.40312895309, 31229.531557026607, 38304.85085447434, 39240.607593924055, 39448.0, 39771.0, 8124.146964568724, 8290.502569845828, 8536.87194692077, 8785.560721963908, 8800.207981281683, 8674.696385626505, 8766.780830479225, 8789.208971192591, 8796.47221166729, 8797.516136612483, 8703.95648021759, 8719.04090550039, 8778.385513014091, 8809.823803523926, 8815.735527934172, 8692.521911294876, 8737.43206691563, 8754.212120909116, 8776.429532080394, 8782.824343513093, 8633.481991080493, 8700.042995270514, 8710.99823520297, 8717.302615790784, 8729.563521823948, 38428.80785596082, 38535.0, 38700.41949370762, 38764.22471550553, 38815.0, 3086.7067628575473, 3112.1286039908637, 3122.3443076953868, 3143.4813255812765, 3222.2105584132037, 28394.85802570974, 28404.863805447756, 28438.715612844022, 29043.273918152005, 29061.273468163254, 2798.7760979121826, 2827.2507785436874, 2883.3941895538865, 2893.85530723463, 2911.170316459799, 271542.0, 293919.5304023488, 349119.0, 349175.0, 351071.0, 50077.74961125244, 50103.0, 50257.74871125694, 50274.0, 50306.49693503091, 52347.73826130845, 52439.73780131075, 52488.212676809875, 52547.0, 52733.7363313181, 14637.92681036588, 14741.92629036848, 14763.704725905422, 14769.483068092564, 14794.556163315117, 11917.940410298066, 11969.46137423818, 11992.340421276738, 11998.940005299917, 12000.279983201035, 12479.750404992032, 13542.052056356157, 13555.254461004739, 13602.93198534001, 13676.905847532174, 5877.44164304399, 5931.199288096138, 5940.61386009908, 5941.673207973517, 5969.31352894414, 983.1151963233004, 984.7833476635129, 985.8619793228954, 996.4270544436978, 1025.144004756037, 23480.882595586914, 23663.171788987303, 23860.88069559676, 23900.880495597412, 24003.399915002265, 996.6611352140162, 1020.1685626214611, 1105.701460605632, 1126.9380184089953, 1136.7158210447387, 11378.54485820558, 11956.684764675878, 12088.516459341703, 12169.026477881749, 12177.0, 449563.256551152, 458633.0, 467244.0, 468908.0, 468967.0, 54240.45759542433, 54534.63663408367, 54964.0, 55219.0, 56138.877222455325, 1416.964575885611, 1421.7938398932304, 1437.0, 1461.795348651211, 1503.8345781963976, 24947.75052249454, 28051.298717532223, 28079.298017549725, 28892.42215155727, 28925.56611650785, 29915.700842991293, 35528.93413197608, 37438.81280593688, 37506.437403438424, 37682.81158594299, 388457.0577147096, 391186.0, 392155.0, 392270.0, 393430.0, 30252.82345353706, 30615.693843062174, 30832.383352333276, 30879.845600771852, 30959.0, 39365.86574188754, 40400.98997525086, 40443.0, 40493.39259911163, 40632.18735625212, 28015.71984280131, 28448.857755711088, 28571.28571785722, 29234.269143271587, 29441.705582943898, 28399.148025559265, 28886.0, 29028.709712903445, 29348.55977160387, 29404.411911762072, 32787.508187376734, 33173.50239746358, 33731.83134084314, 33908.49137262894, 33915.4912676315, 28596.42807143887, 28881.277968050967, 29375.559366609945, 29455.0, 29672.0, 21987.23044693428, 22828.31515054551, 23576.76423235746, 23668.763312366656, 23993.0], "value": 17678.904887994308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.1805021183586, 421.9162027541752, 433.3824300371969, 443.11156131955437, 447.47198305998927, 18723.906380468077, 19938.900305498453, 21507.569848603038, 22167.0, 22422.88788556057, 22257.44356391091, 22647.320580382613, 23341.066357345684, 23458.64812027821, 23470.41323966902, 6382.0, 6391.169148010752, 6584.440322572563, 6604.801855944305, 6611.867762644768, 4787.976060119712, 4865.70805751656, 4897.118518666639, 4905.950940490585, 4908.43552991407, 4726.550977657117, 4741.620670346364, 4747.264174053027, 4755.215389460752, 4765.666403351766, 4666.883327916812, 6327.24073111225, 6378.808635740912, 6449.419552240321, 6461.515386346043, 5313.840584782462, 5719.28508936383, 5720.885582288331, 5739.167820666022, 5761.942380576224, 27572.172834814988, 28008.299792505146, 28189.0, 28618.713812861813, 29113.417731645248, 1880.3888736160666, 1995.1520603743352, 2041.1631231195138, 2046.4065421027883, 2063.8452116091203, 16008.359665613478, 16668.249928753114, 16816.411425600167, 17169.055701936388, 17894.10529473521, 1633.9101349425778, 1739.4520725971279, 1817.1913498493175, 1832.2945665918585, 1902.2295970132118, 148061.25969370193, 163098.1845090767, 163176.9999999988, 163299.9999999988, 165358.0, 10400.635977740743, 12725.745485090247, 12809.871901280869, 12984.0, 13059.542915997894, 16468.83531164697, 16487.67024659524, 16498.34006639745, 16506.917465412596, 16524.421645242357, 7442.7395041173295, 8758.167974042455, 8946.552672366355, 9070.501122438198, 9115.498647574446, 7617.69529218825, 8055.395845311625, 8531.919410338789, 8568.10034946334, 8709.690317679242, 7105.89341159883, 7896.0, 8008.119106898236, 8036.718714844952, 8042.557659328793, 1869.7101949197895, 2181.7709140540333, 2201.1525562658494, 2201.9889900550716, 2375.0618505690154, 922.2253307221965, 923.819855128257, 925.3245131054233, 953.3088510829593, 959.6065613098596, 17161.570960726083, 18106.728399074025, 20202.0, 20500.69248961267, 21137.682934755685, 906.3836591118103, 967.3663750243602, 995.5669283861544, 1000.5247507434057, 1008.7326858382535, 10409.167266618653, 11117.388543630179, 11136.38749868765, 11151.442427878574, 11166.0, 668590.0, 764012.0, 769657.0, 773333.0, 783971.0, 151409.0, 153968.0, 162651.5602265967, 162797.0, 167536.97389078347, 1086.4241951765578, 1093.1855767453299, 1203.9879601204052, 1222.180160958075, 1256.2588073036952, 20433.59132817365, 21679.458013549156, 22641.433964151027, 22657.320280391614, 22877.542449151257, 48639.02721945612, 52942.67643308948, 61600.0, 64714.0, 66231.0, 86778.56610717159, 87618.63912260543, 88980.0, 89250.55374723085, 90580.0, 8672.219500245008, 8855.114488551093, 8871.467711937305, 8933.955330223567, 9066.365354425126, 13242.337883105614, 13258.867411325764, 13584.93207533956, 13787.655308617364, 13945.233012184428, 10876.564937402416, 11254.76197618245, 11637.59268425635, 12020.579279725167, 12057.457414416196, 10399.596054532542, 11085.667429977113, 11118.277311974696, 11464.082873369944, 11494.137939654727, 10005.949970250102, 11415.458913046965, 11790.587329443772, 11858.703532411759, 12091.153619246568, 8665.610047547749, 8772.868406973774, 8817.911820881709, 8850.114988501098, 8930.955345223232, 9941.65204217849, 11553.13351498624, 11560.884391155982, 11987.700307492383, 11988.580399685969], "value": 10404.974738686582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.9349532523372, 1468.3556905004846, 1474.2776039740531, 1484.8047321905867, 1506.1189204315478, 9329.346945713794, 10587.364758114509, 10938.507767150477, 10986.945065274662, 11316.660500185008, 11030.22788404812, 11154.776904461905, 11221.495032723527, 11223.551057957693, 11236.775264494705, 2453.791427728641, 2473.0355161487037, 2473.5794914864427, 2475.900963961439, 2476.3190122716305, 2127.1597718901025, 2346.9178578749747, 2461.9753802462014, 2465.3959779853963, 2467.7532246775268, 2409.132712223607, 2444.1445494077107, 2453.717822450414, 2462.4336402627405, 2466.7779899809016, 2326.0463210083785, 2359.0681680736184, 2415.1184817541557, 2427.1626288930293, 2429.708434987795, 1964.980350196494, 2344.8358614896965, 2347.8826058696995, 2348.8120950323932, 2356.988215058931, 10942.835857462145, 11135.0, 11136.0, 11165.274257173258, 11165.72085697856, 6150.7847225346895, 6354.9364506354805, 6372.522060845455, 6373.107764912916, 6387.169667943184, 3940.8817735467983, 3966.920661586781, 4044.2922488564677, 4075.3683179107284, 4092.6112019358116, 1115.1636272795404, 1140.8174692049315, 1143.9704266160438, 1152.4065106470175, 1174.1370092981651, 13849.86150138506, 14189.0, 15214.08715477064, 15362.770978321707, 15366.30851611669, 5303.973480132575, 5439.238506609078, 5473.397926228112, 5477.534409575151, 5485.286912701403, 11421.257618254787, 11596.420178991017, 11633.0, 11668.474918628512, 11690.947814696718, 6085.391460853879, 6242.469390101802, 6263.185785847811, 6273.341299163522, 6277.183966084471, 5790.71046447676, 5901.0, 5914.763409463573, 5935.554833387427, 5953.136795164677, 4033.5361433435532, 4217.325227963511, 4279.7646129462555, 4301.913961720748, 4315.395844581761, 1057.6404022632341, 1250.6435665835193, 1250.8311377963857, 1265.044891107208, 1267.866873978219, 642.5116911147561, 777.6306254529167, 794.85692575337, 796.6016991504248, 816.5794615772882, 6712.83217919556, 6881.0, 7042.7887163385185, 7085.610291433917, 7090.645467726697, 910.7814124610046, 916.6058594804165, 917.312015988009, 924.4499522783933, 930.7114794413618, 4151.875443736692, 4160.563140870226, 4162.542120366757, 4212.810423530948, 4381.430414046217, 13545.661358466117, 14062.156270623795, 14076.929615351857, 14103.0, 14139.080959737585, 11405.0, 12797.424115914806, 13341.93329033368, 13438.059335846398, 13841.792373114411, 9976.201903847676, 10004.899951000543, 10024.849627255597, 10160.831504376943, 10162.441065741456, 5531.751071201725, 6131.724072416841, 6378.075179099097, 6454.223874332866, 6505.60966342021, 11814.881851181723, 12150.027997760335, 12171.452284647035, 12175.965042971093, 12314.13801033919, 11685.298882067103, 12043.518259269531, 12420.503179872703, 12423.937880310541, 12747.107702460738, 8012.5192488450875, 8291.046529648926, 8373.0, 8439.240468357877, 8482.491050536988, 7820.452568320163, 9096.727098187064, 9495.525223738923, 10114.0, 10133.695989120339, 8627.094155113622, 8660.913390866262, 8717.389782715149, 8759.299256059372, 8773.824523509622, 7177.318154775288, 7249.710011599477, 8454.915450845412, 8483.915160848312, 8551.358648101294, 7749.7287594933905, 7836.92163078362, 7873.566953817595, 7914.802129946797, 7918.366530677416, 5799.130130480462, 5854.882902342015, 5978.282606087298, 6032.065029920369, 6039.818805435844, 5922.644641321534, 5983.282006159115, 6119.969400152971, 6153.600255734165, 6208.658523781055], "value": 5145.988380966263, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5491500369549, 388.31462468742654, 399.46272263805173, 407.45197709081276, 410.93630487274464, 6183.628982261068, 6250.3748425661215, 6302.495800335973, 6394.520410969179, 6427.646479443629, 5742.626729262595, 6174.548980989475, 6294.779682711106, 6316.336784637616, 6329.905051424233, 3957.76253424794, 3993.8202780874785, 4160.54234034256, 4573.199690054244, 4636.890214952188, 3868.941965870514, 4048.5951404859575, 4640.651951103664, 4654.557817007396, 4676.158291507527, 4607.884802879938, 4608.5852273295395, 4615.3077038444335, 4629.560191781792, 4635.327877457767, 3806.90482737931, 4491.698601527891, 4533.093381323749, 4636.09596128755, 4642.701862578012, 3460.8269586520573, 3936.350502167139, 3955.239918236386, 3957.703172262063, 3979.5224573051128, 4664.65015123867, 5122.76947537358, 6239.875202495925, 6243.625382477066, 6333.524985626096, 5408.0, 5506.421825708323, 5512.200730893998, 5516.0, 5797.652140871562, 5999.250093738283, 6323.241211054703, 6814.761483348108, 6859.416949559293, 6956.373926346602, 4890.926636100461, 4892.9510704892855, 4896.779644915951, 4907.497176440042, 4914.434839993375, 6945.603766700531, 6986.930130698679, 7214.639268036577, 7237.200469753369, 7250.564966101998, 4355.954570902961, 4375.890602734893, 4700.6474514410875, 4751.786169622375, 4762.9523704763205, 4823.903521929542, 4837.814735389782, 4839.661223714376, 4841.3222148899185, 4860.246661767432, 4914.508549145057, 5408.323959505062, 5531.25328080712, 5584.246126772834, 5723.998300297431, 5037.697738135724, 5950.732217050243, 6863.759768408082, 6871.381575658214, 6921.723131074801, 1482.4366740638488, 1750.291132091505, 1758.2878934031737, 1760.850327722158, 1763.206557049333, 1127.8326931625727, 1148.5405837665, 1193.6478738772082, 1207.6799648093263, 1222.040698052025, 5702.144678298288, 6498.675066246763, 6502.479801615859, 6528.477721782246, 6593.901091483632, 5859.747839948869, 6592.714420688016, 7020.648967551602, 7067.399271061914, 7074.787756367317, 5481.862953426196, 6483.448906842971, 6493.610383376918, 6511.413972742381, 6511.706973186218, 2861.7567506761743, 3054.389122175574, 3607.873724419685, 3689.5203623529305, 3699.5190625218547, 6744.651069785964, 7229.89155162673, 7248.492605517668, 7288.105092675943, 7306.794378927524, 6061.0, 6640.746034443088, 6757.526973111835, 7294.598797066213, 7318.414526837841, 6340.365963403623, 6917.412019978358, 6979.93020069803, 7272.527285726411, 7290.19327558883, 5960.582759206987, 7066.5160316332085, 7073.82315442118, 7084.539504932163, 7097.183823860116, 6043.365446628217, 6392.3927226913365, 6614.404703576702, 6617.37874220819, 6927.653617319013, 7106.614210229162, 7156.85686286261, 7258.383037441877, 7314.890276645748, 7351.926480735338, 4957.256411538298, 4988.575971042502, 4991.600671946163, 4994.80020799164, 5009.974950125372, 6784.525083244125, 6995.510314277952, 6998.685059172248, 7039.366457018893, 7062.364387205176, 5835.0, 6334.307919134441, 6793.0450254139605, 6814.829629259309, 6848.828779280558, 5886.264216972879, 6183.96985477122, 6230.345813689497, 6740.9325906740305, 6823.577629941497, 6539.673016349258, 6575.0, 6609.372109649576, 6609.405153536205, 6646.933530664632, 6550.377714117151, 6733.878828169111, 6750.594964302158, 6783.18601767791, 6783.59298442095, 5830.387809280134, 6345.333739957238, 6542.54202205841, 6564.5076619254705, 6644.601323920387], "value": 4954.18797275408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.7758228575714, 742.7771668499453, 743.8698227810136, 744.7021191523392, 754.6717178027558, 15278.618034549141, 16332.591685207875, 16338.428155014577, 16356.345746170155, 16405.917970410148, 14962.775558366606, 15148.318325675344, 15150.090994540335, 15168.393264269416, 15186.240687965612, 938.9483778168461, 965.4496936746023, 972.8200282947641, 998.1415982255255, 1003.4781913405025, 1014.9594016239341, 1022.7136401807469, 1023.8720159980003, 1027.573556973855, 1032.5250384822991, 1048.051513380392, 1050.322541960435, 1069.0218450118132, 1072.485207100592, 1074.382230217624, 1065.6962765611802, 1066.5520481397755, 1067.0023528001266, 1070.7804899995483, 1073.3506228731621, 792.1484404265437, 794.320855668401, 794.9920500794976, 795.7692269241913, 804.5896592737746, 16257.512274631661, 16562.337506499727, 16724.331026758915, 16762.83237167625, 16808.243629036722, 14867.033642813183, 14881.627959301104, 14914.627134321729, 14968.550943471713, 15264.389424423121, 11091.279066860629, 11533.365664888428, 11547.942260288644, 11618.651440456715, 12016.69958251042, 3091.938161236763, 3093.7060979207163, 3118.438681037412, 3159.4628913084603, 3226.6128064632394, 70364.6481767593, 98738.0, 99422.50288748583, 99574.99999999927, 100477.4976125122, 11275.887241127648, 11497.54009839597, 11793.469293881795, 11887.40562971848, 11935.522579096913, 23801.523969520513, 24045.677487738343, 24169.758302417104, 24223.0, 24259.878700606383, 7769.961150194213, 7929.365650747926, 7955.8408831823035, 8032.15662355456, 8206.58967051657, 3995.6403923647013, 4122.113745544722, 4183.5398106208295, 4205.600467955539, 4220.894477638022, 4107.527634322091, 4195.958040419557, 4198.8110535026, 4227.852025179165, 4233.216854881795, 728.839655275849, 834.9749507514784, 851.8679604661287, 854.8461276970205, 870.5038128266954, 571.6084482129671, 579.9391063938226, 581.0644861772543, 584.0334246821517, 597.9551533634908, 9143.314251431037, 10256.692299231036, 10411.94794026025, 10432.947835260775, 10727.570897164182, 556.4796914884515, 569.2116418760047, 586.352080950552, 595.4570306675299, 597.2534332084894, 4557.156925968707, 4814.8796280093275, 4821.228603423436, 4825.227963525819, 4848.151573474628, 99131.50434247927, 99144.50427747959, 103663.0, 105397.47301263445, 106241.0, 60388.28252728638, 80312.59843700861, 83021.0, 84869.15130848736, 85115.57442212873, 74661.50676986539, 75536.62231688916, 75994.24005759982, 76263.0, 77877.61061194658, 8135.227153420416, 10767.300125491818, 10976.451177440937, 11011.61459348919, 11224.831627525431, 36851.81574092113, 37012.81493592515, 37580.0, 38421.6157838418, 39147.217055658155, 48749.0, 48951.510484894694, 49034.26448603202, 49416.752916236626, 50035.24947125723, 13645.385957631732, 13852.384166434922, 13882.652933676738, 13923.23422211788, 13929.0, 12069.939650301692, 14736.0, 14757.631059223606, 14780.48268310604, 14803.0378025428, 11859.940700296444, 12118.394080296126, 13733.381997809922, 13867.375968081662, 14423.3509492071, 13221.603351899459, 13415.798763018367, 13545.255010974492, 13595.591048914781, 14299.714005720036, 13405.32973351309, 13461.0, 13494.0, 13765.724685506033, 14540.636484087983, 9817.361871478332, 9870.753231169278, 9965.950170249102, 10077.388796955951, 10162.593496260362, 9169.679061232824, 9418.95290523543, 10374.792504150026, 10633.043026127685, 11227.831582526433], "value": 7565.499287234121, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1630.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 164.0, 184.0, 135.0, 124.0, 122.0, 169.0, 162.0, 125.0], "value": 141.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 103.0, 151.0, 195.0, 125.0, 116.0, 119.0, 117.0, 138.0, 132.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 224.0, 226.0, 220.0, 230.0, 217.0, 211.0, 212.0, 209.0, 214.0], "value": 218.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 59.0, 91.0, 62.0, 59.0, 58.0, 62.0, 89.0, 76.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 73.0, 72.0, 83.0, 73.0, 72.0, 102.0, 121.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 107.0, 100.0, 138.0, 92.0, 94.0, 92.0, 107.0, 134.0, 115.0], "value": 110.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 102.0, 101.0, 100.0, 102.0, 102.0, 100.0, 101.0, 149.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 162.0, 146.0, 101.0, 100.0, 101.0, 93.0, 161.0, 106.0, 108.0], "value": 120.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 67.0, 72.0, 67.0, 60.0, 59.0, 57.0, 70.0, 61.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 100.0, 89.0, 89.0, 89.0, 87.0, 87.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 167.0, 148.0, 151.0, 139.0, 146.0, 147.0, 150.0, 233.0, 176.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 196.0, 198.0, 210.0, 229.0, 194.0, 196.0, 192.0, 224.0, 247.0], "value": 206.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 72.0, 72.0, 69.0, 79.0, 70.0, 70.0, 72.0], "value": 71.7, "unit": "score"}]}]} 05:04:42 INFO - Return code: 0 05:04:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:42 ERROR - # TBPL SUCCESS # 05:04:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:42 INFO - 2017-04-02 05:04:42.389 screenresolution[1709:18869] starting screenresolution argv=screenresolution get 05:04:42 INFO - 2017-04-02 05:04:42.392 screenresolution[1709:18869] Display 0: 1600x1200x32@60 05:04:42 INFO - 2017-04-02 05:04:42.398 screenresolution[1710:18872] starting screenresolution argv=screenresolution list 05:04:42 INFO - Available Modes on Display 0 05:04:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:42 INFO - Intel Iris: 05:04:42 INFO - Chipset Model: Intel Iris 05:04:42 INFO - Type: GPU 05:04:42 INFO - Bus: Built-In 05:04:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:42 INFO - Vendor: Intel (0x8086) 05:04:42 INFO - Device ID: 0x0a2e 05:04:42 INFO - Revision ID: 0x0009 05:04:42 INFO - Displays: 05:04:42 INFO - Display: 05:04:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:42 INFO - Display Serial Number: 1600x1200 60 05:04:42 INFO - Main Display: Yes 05:04:42 INFO - Mirror: Off 05:04:42 INFO - Online: Yes 05:04:42 INFO - Rotation: Supported 05:04:42 INFO - Return code: 0 05:04:42 INFO - Running post-action listener: _resource_record_post_action 05:04:42 INFO - [mozharness: 2017-04-02 12:04:42.633913Z] Finished run-tests step (success) 05:04:42 INFO - Running post-run listener: _resource_record_post_run 05:04:42 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 34791424; Write bytes: 519242752; Read time: 321; Write time: 1606 05:04:42 INFO - TinderboxPrint: CPU usage
54.3% 05:04:42 INFO - TinderboxPrint: I/O read bytes / time
34,791,424 / 321 05:04:42 INFO - TinderboxPrint: I/O write bytes / time
519,242,752 / 1,606 05:04:42 INFO - TinderboxPrint: CPU idle
2,195.8 (45.7%) 05:04:42 INFO - TinderboxPrint: CPU system
967.3 (20.1%) 05:04:42 INFO - TinderboxPrint: CPU user
1,646.6 (34.2%) 05:04:42 INFO - TinderboxPrint: Swap in / out
242,434,048 / 0 05:04:42 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 211497472; Write bytes: 206338048; Read time: 17276; Write time: 458 05:04:42 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 32714752; Write bytes: 302865408; Read time: 298; Write time: 1118 05:04:43 INFO - Running post-run listener: _upload_blobber_files 05:04:43 INFO - Blob upload gear active. 05:04:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:04:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:04:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:44 INFO - (blobuploader) - INFO - Done attempting. 05:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:45 INFO - (blobuploader) - INFO - Done attempting. 05:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:46 INFO - (blobuploader) - INFO - Done attempting. 05:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:48 INFO - (blobuploader) - INFO - Done attempting. 05:04:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:04:48 INFO - Return code: 0 05:04:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:04:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:04:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976ad6b7bbf5e99a7442c030b281655501621263baaebede7d1a6078e86741278a46ebc6b5ca8805bf59532e81f3d3c0440a327e429902f07734142e7e520655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39996a66478dcfc96c03e4ba90db7b6a7b8a14e6dbf822af8d2710a20576b8a97ca4e74950127aa3572252a5dbe5540a904c50c1fddfd995bf849900db1a755d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bef669410685c37c824a425aedd8a73bba08ed6da418cb1a9957f11058e12c3ab84dcff60ca917976bf20ad14f429533464518813d3c786c6b9ef73c97603dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97980546185d8eda79041887eaad6ad4f8e833a14adca0f3bc9301ee87eb3d4600c349facea69cd8fa001fc25673bfd6bd642691ad94d17d27bc6569f13688e"} 05:04:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:04:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:04:48 INFO - Contents: 05:04:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976ad6b7bbf5e99a7442c030b281655501621263baaebede7d1a6078e86741278a46ebc6b5ca8805bf59532e81f3d3c0440a327e429902f07734142e7e520655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39996a66478dcfc96c03e4ba90db7b6a7b8a14e6dbf822af8d2710a20576b8a97ca4e74950127aa3572252a5dbe5540a904c50c1fddfd995bf849900db1a755d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bef669410685c37c824a425aedd8a73bba08ed6da418cb1a9957f11058e12c3ab84dcff60ca917976bf20ad14f429533464518813d3c786c6b9ef73c97603dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97980546185d8eda79041887eaad6ad4f8e833a14adca0f3bc9301ee87eb3d4600c349facea69cd8fa001fc25673bfd6bd642691ad94d17d27bc6569f13688e"} 05:04:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:04:48 INFO - Copying logs to upload dir... 05:04:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:04:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1356.047180 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 36 secs) (at 2017-04-02 05:04:48.707221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 05:04:48.710587) ========= 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.iB3bWQRR1k/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.qMAVoptvjg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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/976ad6b7bbf5e99a7442c030b281655501621263baaebede7d1a6078e86741278a46ebc6b5ca8805bf59532e81f3d3c0440a327e429902f07734142e7e520655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39996a66478dcfc96c03e4ba90db7b6a7b8a14e6dbf822af8d2710a20576b8a97ca4e74950127aa3572252a5dbe5540a904c50c1fddfd995bf849900db1a755d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bef669410685c37c824a425aedd8a73bba08ed6da418cb1a9957f11058e12c3ab84dcff60ca917976bf20ad14f429533464518813d3c786c6b9ef73c97603dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97980546185d8eda79041887eaad6ad4f8e833a14adca0f3bc9301ee87eb3d4600c349facea69cd8fa001fc25673bfd6bd642691ad94d17d27bc6569f13688e"} build_url:https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/RzM2iQpcROaU35_b1ow6gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976ad6b7bbf5e99a7442c030b281655501621263baaebede7d1a6078e86741278a46ebc6b5ca8805bf59532e81f3d3c0440a327e429902f07734142e7e520655", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39996a66478dcfc96c03e4ba90db7b6a7b8a14e6dbf822af8d2710a20576b8a97ca4e74950127aa3572252a5dbe5540a904c50c1fddfd995bf849900db1a755d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bef669410685c37c824a425aedd8a73bba08ed6da418cb1a9957f11058e12c3ab84dcff60ca917976bf20ad14f429533464518813d3c786c6b9ef73c97603dcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97980546185d8eda79041887eaad6ad4f8e833a14adca0f3bc9301ee87eb3d4600c349facea69cd8fa001fc25673bfd6bd642691ad94d17d27bc6569f13688e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 05:04:48.745320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 05:04:48.745650) ========= 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.iB3bWQRR1k/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.qMAVoptvjg/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.005348 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 05:04:48.796614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 05:04:48.796996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 05:04:48.797381) ========= ========= Total master_lag: 0.19 =========