builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0217 starttime: 1477515298.96 results: success (0) buildid: 20161011025846 builduid: 5120a331d5884b248fd298482f4fffa2 revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:58.964415) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:58.964858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:58.965132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:58.989411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:58.989825) ========= 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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 13:54:59-- 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% 176M=0s 2016-10-26 13:54:59 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:59.134661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:59.134978) ========= 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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.024759 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:59.186678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:59.187052) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --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 45052ddb03a448606ca6ce33f4893a559edebf72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J8vU5iyI6w/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.67Rp4ntsSq/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 13:54:59,270 truncating revision to first 12 chars 2016-10-26 13:54:59,270 Setting DEBUG logging. 2016-10-26 13:54:59,270 attempt 1/10 2016-10-26 13:54:59,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45052ddb03a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:54:59,968 unpacking tar archive at: mozilla-central-45052ddb03a4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958785 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:00.171003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:00.171374) ========= script_repo_revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:00.171780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:00.172047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:00.190369) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-10-26 13:55:00.190776) ========= /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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:00 INFO - MultiFileLogger online at 20161026 13:55:00 in /builds/slave/test 13:55:00 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 13:55:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:00 INFO - {'append_to_log': False, 13:55:00 INFO - 'base_work_dir': '/builds/slave/test', 13:55:00 INFO - 'blob_upload_branch': 'Firefox', 13:55:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:00 INFO - 'branch': 'Firefox', 13:55:00 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:00 INFO - 'config_files': ('talos/mac_config.py',), 13:55:00 INFO - 'default_actions': ('clobber', 13:55:00 INFO - 'read-buildbot-config', 13:55:00 INFO - 'download-and-extract', 13:55:00 INFO - 'populate-webroot', 13:55:00 INFO - 'create-virtualenv', 13:55:00 INFO - 'install', 13:55:00 INFO - 'run-tests'), 13:55:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:00 INFO - 'download_minidump_stackwalk': True, 13:55:00 INFO - 'download_symbols': 'ondemand', 13:55:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:00 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:00 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:00 INFO - 'installer_path': 'installer.exe', 13:55:00 INFO - 'log_level': 'info', 13:55:00 INFO - 'log_name': 'talos', 13:55:00 INFO - 'log_to_console': True, 13:55:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:55:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:55:00 INFO - 'opt_config_files': (), 13:55:00 INFO - 'pip_index': False, 13:55:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:00 INFO - 'cmd': ('bash', 13:55:00 INFO - '-c', 13:55:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:00 INFO - 'enabled': True, 13:55:00 INFO - 'halt_on_failure': False, 13:55:00 INFO - 'name': 'check_screen_resolution'},), 13:55:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:00 INFO - 'cmd': ('bash', 13:55:00 INFO - '-c', 13:55:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:00 INFO - 'enabled': True, 13:55:00 INFO - 'halt_on_failure': False, 13:55:00 INFO - 'name': 'check_screen_resolution'},), 13:55:00 INFO - 'run_cmd_checks_enabled': True, 13:55:00 INFO - 'sps_profile': False, 13:55:00 INFO - 'sps_profile_interval': 0, 13:55:00 INFO - 'suite': 'dromaeojs-e10s', 13:55:00 INFO - 'system_bits': '32', 13:55:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:00 INFO - 'title': 't-yosemite-r7-0217', 13:55:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:00 INFO - 'use_talos_json': True, 13:55:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:00 INFO - 'work_dir': 'build'} 13:55:00 INFO - [mozharness: 2016-10-26 20:55:00.394296Z] Running clobber step. 13:55:00 INFO - Running pre-action listener: _resource_record_pre_action 13:55:00 INFO - Running main action method: clobber 13:55:00 INFO - rmtree: /builds/slave/test/build 13:55:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:02 INFO - Running post-action listener: _resource_record_post_action 13:55:02 INFO - [mozharness: 2016-10-26 20:55:02.652097Z] Finished clobber step (success) 13:55:02 INFO - [mozharness: 2016-10-26 20:55:02.652253Z] Running read-buildbot-config step. 13:55:02 INFO - Running pre-action listener: _resource_record_pre_action 13:55:02 INFO - Running main action method: read_buildbot_config 13:55:02 INFO - Using buildbot properties: 13:55:02 INFO - { 13:55:02 INFO - "project": "", 13:55:02 INFO - "product": "firefox", 13:55:02 INFO - "script_repo_revision": "production", 13:55:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:55:02 INFO - "repository": "", 13:55:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:55:02 INFO - "buildid": "20161011025846", 13:55:02 INFO - "pgo_build": "False", 13:55:02 INFO - "basedir": "/builds/slave/test", 13:55:02 INFO - "buildnumber": 152, 13:55:02 INFO - "slavename": "t-yosemite-r7-0217", 13:55:02 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:55:02 INFO - "platform": "yosemite_r7", 13:55:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:55:02 INFO - "branch": "mozilla-central", 13:55:02 INFO - "repo_path": "mozilla-central", 13:55:02 INFO - "revision": "45052ddb03a448606ca6ce33f4893a559edebf72", 13:55:02 INFO - "stage_platform": "macosx64", 13:55:02 INFO - "builduid": "5120a331d5884b248fd298482f4fffa2", 13:55:02 INFO - "slavebuilddir": "test" 13:55:02 INFO - } 13:55:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:55:02 INFO - Running post-action listener: _resource_record_post_action 13:55:02 INFO - [mozharness: 2016-10-26 20:55:02.655196Z] Finished read-buildbot-config step (success) 13:55:02 INFO - [mozharness: 2016-10-26 20:55:02.655305Z] Running download-and-extract step. 13:55:02 INFO - Running pre-action listener: _resource_record_pre_action 13:55:02 INFO - Running main action method: download_and_extract 13:55:02 INFO - mkdir: /builds/slave/test/build/tests 13:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:02 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:55:08 INFO - Downloaded 1199 bytes. 13:55:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:55:08 INFO - Using the following test package requirements: 13:55:08 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:55:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:55:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:55:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'jsshell-mac.zip'], 13:55:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:55:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:55:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:55:08 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:55:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:55:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:08 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:55:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:55:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:55:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:55:09 INFO - Http code: 200 13:55:09 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 13:55:09 INFO - x-amz-cf-id: o4BiUhWJvNPFiOU1ISkz3whG3SMZ9MFUZcl2N2PrEzP-UdMI9ihwnQ== 13:55:09 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:10 INFO - Expected file size: 16508481 13:55:10 INFO - Obtained file size: 16508481 13:55:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:55:17 INFO - Http code: 200 13:55:17 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 13:55:17 INFO - x-amz-cf-id: bfB4DhhLBSIBanWKmP98ZB-LoWu7w9Cvsz4fNzQdPzRVyxA1NzQgDw== 13:55:17 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:17 INFO - Expected file size: 16508481 13:55:17 INFO - Obtained file size: 16508481 13:55:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:55:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:55:24 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:55:24 INFO - Http code: 200 13:55:24 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 13:55:24 INFO - x-amz-cf-id: A5RZ7Mz01OrzyU_sE6aAOXZlSGyBCjl3KPgP0WkyUx3_vYcS43fdwA== 13:55:24 INFO - x-amz-version-id: h7oaKNhRQzyZtP5vdBlaq4n0FwksjilO 13:55:24 INFO - Expected file size: 14409006 13:55:24 INFO - Obtained file size: 14409006 13:55:25 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')]} 13:55:25 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:25 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:55:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:55:28 INFO - Downloaded 111738529 bytes. 13:55:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:28 INFO - mkdir: /builds/slave/test/properties 13:55:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:28 INFO - Contents: 13:55:28 INFO - build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:28 INFO - Running post-action listener: _resource_record_post_action 13:55:28 INFO - Running post-action listener: set_extra_try_arguments 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.873631Z] Finished download-and-extract step (success) 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.873787Z] Running populate-webroot step. 13:55:28 INFO - Running pre-action listener: _resource_record_pre_action 13:55:28 INFO - Running main action method: populate_webroot 13:55:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:28 INFO - '--tppagecycles', 13:55:28 INFO - '7'], 13:55:28 INFO - 'tests': ['tsvgm']}}, 13:55:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['damp', 'tps']}, 13:55:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'tests': ['damp', 'tps']}, 13:55:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['dromaeo_dom']}, 13:55:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['basic_compositor_video']}, 13:55:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:55:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tsvgx', 13:55:28 INFO - 'tsvgr_opacity', 13:55:28 INFO - 'tart', 13:55:28 INFO - 'tscrollx', 13:55:28 INFO - 'cart']}, 13:55:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:28 INFO - 'tsvgr_opacity', 13:55:28 INFO - 'tart', 13:55:28 INFO - 'tscrollx', 13:55:28 INFO - 'cart']}, 13:55:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tp5o']}, 13:55:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'tests': ['tp5o']}, 13:55:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s', 13:55:28 INFO - '--xperf_path', 13:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:28 INFO - 'tests': ['tp5n']}, 13:55:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--xperf_path', 13:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:28 INFO - 'tests': ['tp5n']}}, 13:55:28 INFO - 'talos.zip': {'path': '', 13:55:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:28 INFO - Running post-action listener: _resource_record_post_action 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.893110Z] Finished populate-webroot step (success) 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.893240Z] Running create-virtualenv step. 13:55:28 INFO - Running pre-action listener: _resource_record_pre_action 13:55:28 INFO - Running main action method: create_virtualenv 13:55:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:28 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 13:55:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:29 INFO - Using real prefix '/tools/python27' 13:55:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:32 INFO - Installing pip.................done. 13:55:32 INFO - Return code: 0 13:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:55:32 INFO - Reading from file tmpfile_stdout 13:55:32 INFO - Output received: 13:55:32 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) 13:55:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:32 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:32 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 13:55:32 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 13:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:32 INFO - 'HOME': '/Users/cltbld', 13:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:32 INFO - 'LOGNAME': 'cltbld', 13:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:32 INFO - 'MOZ_NO_REMOTE': '1', 13:55:32 INFO - 'NO_EM_RESTART': '1', 13:55:32 INFO - 'PAGER': '/bin/cat', 13:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:32 INFO - 'PWD': '/builds/slave/test', 13:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:32 INFO - 'SHELL': '/bin/bash', 13:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:32 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:32 INFO - 'USER': 'cltbld', 13:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:32 INFO - 'XPC_FLAGS': '0x0', 13:55:32 INFO - 'XPC_SERVICE_NAME': '0', 13:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:33 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 13:55:33 INFO - Cleaning up... 13:55:33 INFO - Return code: 0 13:55:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:33 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:33 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 13:55:33 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 13:55:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:33 INFO - 'HOME': '/Users/cltbld', 13:55:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:33 INFO - 'LOGNAME': 'cltbld', 13:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:33 INFO - 'MOZ_NO_REMOTE': '1', 13:55:33 INFO - 'NO_EM_RESTART': '1', 13:55:33 INFO - 'PAGER': '/bin/cat', 13:55:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:33 INFO - 'PWD': '/builds/slave/test', 13:55:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:33 INFO - 'SHELL': '/bin/bash', 13:55:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:33 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:33 INFO - 'USER': 'cltbld', 13:55:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:33 INFO - 'XPC_FLAGS': '0x0', 13:55:33 INFO - 'XPC_SERVICE_NAME': '0', 13:55:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:33 INFO - Downloading/unpacking psutil>=3.1.1 13:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:36 INFO - Installing collected packages: psutil 13:55:36 INFO - Running setup.py install for psutil 13:55:36 INFO - building 'psutil._psutil_osx' extension 13:55:36 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 13:55:37 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 13:55:37 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 13:55:37 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 13:55:37 INFO - building 'psutil._psutil_posix' extension 13:55:37 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 13:55:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:55:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:55:37 INFO - ^ 13:55:37 INFO - 1 warning generated. 13:55:37 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 13:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:37 INFO - Successfully installed psutil 13:55:37 INFO - Cleaning up... 13:55:38 INFO - Return code: 0 13:55:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:38 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 13:55:38 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 13:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:38 INFO - 'HOME': '/Users/cltbld', 13:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:38 INFO - 'LOGNAME': 'cltbld', 13:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:38 INFO - 'MOZ_NO_REMOTE': '1', 13:55:38 INFO - 'NO_EM_RESTART': '1', 13:55:38 INFO - 'PAGER': '/bin/cat', 13:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:38 INFO - 'PWD': '/builds/slave/test', 13:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:38 INFO - 'SHELL': '/bin/bash', 13:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:38 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:38 INFO - 'USER': 'cltbld', 13:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:38 INFO - 'XPC_FLAGS': '0x0', 13:55:38 INFO - 'XPC_SERVICE_NAME': '0', 13:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:55:40 INFO - Installing collected packages: mozsystemmonitor 13:55:40 INFO - Running setup.py install for mozsystemmonitor 13:55:41 INFO - Successfully installed mozsystemmonitor 13:55:41 INFO - Cleaning up... 13:55:41 INFO - Return code: 0 13:55:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55:41 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')]} 13:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:41 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')]} 13:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:41 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:41 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 13:55:41 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 13:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:41 INFO - 'HOME': '/Users/cltbld', 13:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:41 INFO - 'LOGNAME': 'cltbld', 13:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:41 INFO - 'MOZ_NO_REMOTE': '1', 13:55:41 INFO - 'NO_EM_RESTART': '1', 13:55:41 INFO - 'PAGER': '/bin/cat', 13:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:41 INFO - 'PWD': '/builds/slave/test', 13:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:41 INFO - 'SHELL': '/bin/bash', 13:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:41 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:41 INFO - 'USER': 'cltbld', 13:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:41 INFO - 'XPC_FLAGS': '0x0', 13:55:41 INFO - 'XPC_SERVICE_NAME': '0', 13:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:41 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:41 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 13:55:41 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 13:55:41 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 13:55:41 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 13:55:41 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 13:55:41 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 13:55:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:44 INFO - warning: no files found matching '*.txt' 13:55:44 INFO - no previously-included directories found matching 'build' 13:55:44 INFO - no previously-included directories found matching 'dist' 13:55:44 INFO - no previously-included directories found matching '.git*' 13:55:44 INFO - Installing collected packages: jsonschema, functools32 13:55:44 INFO - Running setup.py install for functools32 13:55:44 INFO - warning: no files found matching '*.txt' 13:55:44 INFO - no previously-included directories found matching 'build' 13:55:44 INFO - no previously-included directories found matching 'dist' 13:55:44 INFO - no previously-included directories found matching '.git*' 13:55:44 INFO - Successfully installed jsonschema functools32 13:55:44 INFO - Cleaning up... 13:55:44 INFO - Return code: 0 13:55:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:44 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 13:55:44 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 13:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:44 INFO - 'HOME': '/Users/cltbld', 13:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:44 INFO - 'LOGNAME': 'cltbld', 13:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:44 INFO - 'MOZ_NO_REMOTE': '1', 13:55:44 INFO - 'NO_EM_RESTART': '1', 13:55:44 INFO - 'PAGER': '/bin/cat', 13:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:44 INFO - 'PWD': '/builds/slave/test', 13:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:44 INFO - 'SHELL': '/bin/bash', 13:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:44 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:44 INFO - 'USER': 'cltbld', 13:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:44 INFO - 'XPC_FLAGS': '0x0', 13:55:44 INFO - 'XPC_SERVICE_NAME': '0', 13:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:55:44 INFO - Cleaning up... 13:55:44 INFO - Return code: 0 13:55:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:44 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 13:55:44 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 13:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:44 INFO - 'HOME': '/Users/cltbld', 13:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:44 INFO - 'LOGNAME': 'cltbld', 13:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:44 INFO - 'MOZ_NO_REMOTE': '1', 13:55:44 INFO - 'NO_EM_RESTART': '1', 13:55:44 INFO - 'PAGER': '/bin/cat', 13:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:44 INFO - 'PWD': '/builds/slave/test', 13:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:44 INFO - 'SHELL': '/bin/bash', 13:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:44 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:44 INFO - 'USER': 'cltbld', 13:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:44 INFO - 'XPC_FLAGS': '0x0', 13:55:44 INFO - 'XPC_SERVICE_NAME': '0', 13:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 INFO - Downloading docopt-0.6.1.tar.gz 13:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:49 INFO - Running setup.py install for blobuploader 13:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:49 INFO - Running setup.py install for requests 13:55:49 INFO - Running setup.py install for docopt 13:55:49 INFO - Successfully installed blobuploader requests docopt 13:55:49 INFO - Cleaning up... 13:55:50 INFO - Return code: 0 13:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:50 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:50 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 13:55:50 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 13:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:50 INFO - 'HOME': '/Users/cltbld', 13:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:50 INFO - 'LOGNAME': 'cltbld', 13:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:50 INFO - 'MOZ_NO_REMOTE': '1', 13:55:50 INFO - 'NO_EM_RESTART': '1', 13:55:50 INFO - 'PAGER': '/bin/cat', 13:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:50 INFO - 'PWD': '/builds/slave/test', 13:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:50 INFO - 'SHELL': '/bin/bash', 13:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:50 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:50 INFO - 'USER': 'cltbld', 13:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:50 INFO - 'XPC_FLAGS': '0x0', 13:55:50 INFO - 'XPC_SERVICE_NAME': '0', 13:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-AIMbrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-hjFFEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-FjJZuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-WGfGj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-34gtIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-tbNORK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:50 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-zQmUKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-pHk_Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-MLCO8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ZggBMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-pv4PTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-okvKnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-2tDhqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-hpPoev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Q_b73b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-cnzpfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:51 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-I5TjbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:52 INFO - Running setup.py install for manifestparser 13:55:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Running setup.py install for mozcrash 13:55:52 INFO - Running setup.py install for mozdebug 13:55:52 INFO - Running setup.py install for mozdevice 13:55:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Running setup.py install for mozfile 13:55:52 INFO - Running setup.py install for mozhttpd 13:55:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Running setup.py install for mozinfo 13:55:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozInstall 13:55:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozleak 13:55:53 INFO - Running setup.py install for mozlog 13:55:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for moznetwork 13:55:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozprocess 13:55:53 INFO - Running setup.py install for mozprofile 13:55:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozrunner 13:55:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozscreenshot 13:55:54 INFO - Running setup.py install for moztest 13:55:54 INFO - Running setup.py install for mozversion 13:55:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:54 INFO - Cleaning up... 13:55:54 INFO - Return code: 0 13:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:55:55 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 13:55:55 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 13:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:55 INFO - 'HOME': '/Users/cltbld', 13:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:55 INFO - 'LOGNAME': 'cltbld', 13:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:55 INFO - 'MOZ_NO_REMOTE': '1', 13:55:55 INFO - 'NO_EM_RESTART': '1', 13:55:55 INFO - 'PAGER': '/bin/cat', 13:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:55 INFO - 'PWD': '/builds/slave/test', 13:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:55 INFO - 'SHELL': '/bin/bash', 13:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:55:55 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:55 INFO - 'USER': 'cltbld', 13:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:55 INFO - 'XPC_FLAGS': '0x0', 13:55:55 INFO - 'XPC_SERVICE_NAME': '0', 13:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:55 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Wl4IGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:55 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)) 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:55 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-dENzJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:55 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-123v3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-RGU0PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-rZLJ8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-BO8PMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-dkEFki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-PUP3yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-lyf720-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-T4oEmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-AK7PBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:56 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-XHq1Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-D3tFfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-gBAJmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-d9Xa02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-MvfxWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:57 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-PQULZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:57 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)) 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:55:57 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)) 13:55:57 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:55:57 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:55:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:00 INFO - Downloading blessings-1.6.tar.gz 13:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:56:00 INFO - Installing collected packages: blessings 13:56:00 INFO - Running setup.py install for blessings 13:56:00 INFO - Successfully installed blessings 13:56:00 INFO - Cleaning up... 13:56:00 INFO - Return code: 0 13:56:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:01 INFO - Reading from file tmpfile_stdout 13:56:01 INFO - Current package versions: 13:56:01 INFO - blessings == 1.6 13:56:01 INFO - blobuploader == 1.2.4 13:56:01 INFO - docopt == 0.6.1 13:56:01 INFO - functools32 == 3.2.3-2 13:56:01 INFO - jsonschema == 2.5.1 13:56:01 INFO - manifestparser == 1.1 13:56:01 INFO - mozInstall == 1.12 13:56:01 INFO - mozcrash == 0.17 13:56:01 INFO - mozdebug == 0.1 13:56:01 INFO - mozdevice == 0.48 13:56:01 INFO - mozfile == 1.2 13:56:01 INFO - mozhttpd == 0.7 13:56:01 INFO - mozinfo == 0.9 13:56:01 INFO - mozleak == 0.1 13:56:01 INFO - mozlog == 3.4 13:56:01 INFO - moznetwork == 0.27 13:56:01 INFO - mozprocess == 0.23 13:56:01 INFO - mozprofile == 0.28 13:56:01 INFO - mozrunner == 6.12 13:56:01 INFO - mozscreenshot == 0.1 13:56:01 INFO - mozsystemmonitor == 0.3 13:56:01 INFO - moztest == 0.7 13:56:01 INFO - mozversion == 1.4 13:56:01 INFO - psutil == 3.1.1 13:56:01 INFO - requests == 1.2.3 13:56:01 INFO - wsgiref == 0.1.2 13:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:01 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:56:01 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 13:56:01 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 13:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:01 INFO - 'HOME': '/Users/cltbld', 13:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:01 INFO - 'LOGNAME': 'cltbld', 13:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:01 INFO - 'MOZ_NO_REMOTE': '1', 13:56:01 INFO - 'NO_EM_RESTART': '1', 13:56:01 INFO - 'PAGER': '/bin/cat', 13:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:01 INFO - 'PWD': '/builds/slave/test', 13:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:01 INFO - 'SHELL': '/bin/bash', 13:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:56:01 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:01 INFO - 'USER': 'cltbld', 13:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:01 INFO - 'XPC_FLAGS': '0x0', 13:56:01 INFO - 'XPC_SERVICE_NAME': '0', 13:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 INFO - Cleaning up... 13:56:01 INFO - Return code: 0 13:56:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:01 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 0x10e588490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d1d66ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, '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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 13:56:01 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 13:56:01 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 13:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:01 INFO - 'HOME': '/Users/cltbld', 13:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:01 INFO - 'LOGNAME': 'cltbld', 13:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:01 INFO - 'MOZ_NO_REMOTE': '1', 13:56:01 INFO - 'NO_EM_RESTART': '1', 13:56:01 INFO - 'PAGER': '/bin/cat', 13:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:01 INFO - 'PWD': '/builds/slave/test', 13:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:01 INFO - 'SHELL': '/bin/bash', 13:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:56:01 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:01 INFO - 'USER': 'cltbld', 13:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:01 INFO - 'XPC_FLAGS': '0x0', 13:56:01 INFO - 'XPC_SERVICE_NAME': '0', 13:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:56:01 INFO - Cleaning up... 13:56:01 INFO - Return code: 0 13:56:01 INFO - Running post-action listener: _resource_record_post_action 13:56:01 INFO - Running post-action listener: _start_resource_monitoring 13:56:01 INFO - Starting resource monitoring. 13:56:01 INFO - [mozharness: 2016-10-26 20:56:01.851083Z] Finished create-virtualenv step (success) 13:56:01 INFO - [mozharness: 2016-10-26 20:56:01.851882Z] Running install step. 13:56:01 INFO - Running pre-action listener: _resource_record_pre_action 13:56:01 INFO - Running main action method: install 13:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:02 INFO - Reading from file tmpfile_stdout 13:56:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:56:02 INFO - Reading from file tmpfile_stdout 13:56:02 INFO - Output received: 13:56:02 INFO - Usage: mozinstall [options] installer 13:56:02 INFO - Options: 13:56:02 INFO - -h, --help show this help message and exit 13:56:02 INFO - -d DEST, --destination=DEST 13:56:02 INFO - Directory to install application into. [default: 13:56:02 INFO - "/builds/slave/test"] 13:56:02 INFO - --app=APP Application being installed. [default: firefox] 13:56:02 INFO - mkdir: /builds/slave/test/build/application 13:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:56:37 INFO - Reading from file tmpfile_stdout 13:56:37 INFO - Output received: 13:56:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:56:37 INFO - Running post-action listener: _resource_record_post_action 13:56:37 INFO - [mozharness: 2016-10-26 20:56:37.029760Z] Finished install step (success) 13:56:37 INFO - [mozharness: 2016-10-26 20:56:37.029916Z] Running run-tests step. 13:56:37 INFO - Running pre-action listener: _resource_record_pre_action 13:56:37 INFO - Running main action method: run_tests 13:56:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:56:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:56:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:56:37 INFO - 2016-10-26 13:56:37.044 screenresolution[1647:7774] starting screenresolution argv=screenresolution get 13:56:37 INFO - 2016-10-26 13:56:37.047 screenresolution[1647:7774] Display 0: 1600x1200x32@60 13:56:37 INFO - 2016-10-26 13:56:37.052 screenresolution[1648:7776] starting screenresolution argv=screenresolution list 13:56:37 INFO - Available Modes on Display 0 13:56:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:56:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:56:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:56:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:56:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:56:37 INFO - Intel Iris: 13:56:37 INFO - Chipset Model: Intel Iris 13:56:37 INFO - Type: GPU 13:56:37 INFO - Bus: Built-In 13:56:37 INFO - VRAM (Dynamic, Max): 1536 MB 13:56:37 INFO - Vendor: Intel (0x8086) 13:56:37 INFO - Device ID: 0x0a2e 13:56:37 INFO - Revision ID: 0x0009 13:56:37 INFO - Displays: 13:56:37 INFO - Display: 13:56:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:56:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:56:37 INFO - Display Serial Number: 1600x1200 60 13:56:37 INFO - Main Display: Yes 13:56:37 INFO - Mirror: Off 13:56:37 INFO - Online: Yes 13:56:37 INFO - Rotation: Supported 13:56:37 INFO - Return code: 0 13:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:37 INFO - Python 2.7.3 13:56:37 INFO - Return code: 0 13:56:37 INFO - grabbing minidump binary from tooltool 13:56:37 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')]} 13:56:37 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 0x10e39cd30>, '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 0x10e1c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e394b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:37 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 13:56:37 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 13:56:37 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 13:56:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:37 INFO - Return code: 0 13:56:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:56:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:56:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 13:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0217 --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 13:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J8vU5iyI6w/Render', 13:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:37 INFO - 'HOME': '/Users/cltbld', 13:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:37 INFO - 'LOGNAME': 'cltbld', 13:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:37 INFO - 'MOZ_NO_REMOTE': '1', 13:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:37 INFO - 'NO_EM_RESTART': '1', 13:56:37 INFO - 'PAGER': '/bin/cat', 13:56:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:37 INFO - 'PWD': '/builds/slave/test', 13:56:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:37 INFO - 'SHELL': '/bin/bash', 13:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67Rp4ntsSq/Listeners', 13:56:37 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 13:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:37 INFO - 'USER': 'cltbld', 13:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:37 INFO - 'XPC_FLAGS': '0x0', 13:56:37 INFO - 'XPC_SERVICE_NAME': '0', 13:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 13:56:37 INFO - mozversion application_buildid: 20161011025846 13:56:37 INFO - mozversion application_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:37 INFO - mozversion application_display_name: Nightly 13:56:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:37 INFO - mozversion application_name: Firefox 13:56:37 INFO - mozversion application_remotingname: firefox 13:56:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:56:37 INFO - mozversion application_vendor: Mozilla 13:56:37 INFO - mozversion application_version: 52.0a1 13:56:37 INFO - mozversion platform_buildid: 20161011025846 13:56:37 INFO - mozversion platform_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:56:37 INFO - mozversion platform_version: 52.0a1 13:56:37 INFO - using testdate: 1477515397 13:56:37 INFO - actual date: 1477515397 13:56:37 INFO - starting webserver on 'localhost:49267' 13:56:37 INFO - SUITE-START | Running 2 tests 13:56:37 INFO - TEST-START | dromaeo_css 13:56:37 INFO - operating with platform_type : mac_ 13:56:37 INFO - Initialising browser for dromaeo_css test... 13:56:37 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpNZVo37/profile http://localhost:49267/getInfo.html) 13:56:40 INFO - PROCESS | 1658 | 2016-10-26 13:56:40.345 plugin-container[1660:7913] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 13:56:40 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:40 INFO - PROCESS | 1658 | 2016-10-26 13:56:40.348 plugin-container[1660:7913] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9413, name = 'com.apple.CFPasteboardClient' 13:56:40 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:40 INFO - PROCESS | 1658 | 2016-10-26 13:56:40.348 plugin-container[1660:7913] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:40 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 13:56:40 INFO - PROCESS | 1658 | colorDepth:24 13:56:40 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 13:56:40 INFO - PROCESS | 1658 | __metrics 13:56:40 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 13:56:41 INFO - TEST-INFO | 1658: exit 0 13:56:41 INFO - Browser initialized. 13:56:41 INFO - Running cycle 1/1 for dromaeo_css test... 13:56:41 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpNZVo37/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:43 INFO - PROCESS | 1661 | 2016-10-26 13:56:43.659 plugin-container[1662:8034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 13:56:43 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:43 INFO - PROCESS | 1661 | 2016-10-26 13:56:43.660 plugin-container[1662:8034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 13:56:43 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:43 INFO - PROCESS | 1661 | 2016-10-26 13:56:43.660 plugin-container[1662:8034] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:53 INFO - PROCESS | 1661 | RSS: Main: 238551040 13:56:53 INFO - PROCESS | 1661 | 13:57:43 INFO - PROCESS | 1661 | 1477515463030 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:59:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 13:59:56 INFO - PROCESS | 1661 | RSS: Main: 251572224 13:59:56 INFO - PROCESS | 1661 | 14:02:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 14:02:59 INFO - PROCESS | 1661 | RSS: Main: 264237056 14:02:59 INFO - PROCESS | 1661 | 14:06:01 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 14:06:02 INFO - PROCESS | 1661 | RSS: Main: 268894208 14:06:02 INFO - PROCESS | 1661 | 14:09:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 14:09:04 INFO - PROCESS | 1661 | RSS: Main: 268537856 14:09:04 INFO - PROCESS | 1661 | 14:12:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 14:12:08 INFO - PROCESS | 1661 | RSS: Main: 273944576 14:12:08 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 14:15:11 INFO - PROCESS | 1661 | RSS: Main: 276422656 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | __start_tp_report 14:15:11 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 14:15:11 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 14:15:11 INFO - PROCESS | 1661 | |i|pagename|runs| 14:15:11 INFO - PROCESS | 1661 | |0;dojo.html;2899.7535209507196;3350.229447227139;3390.0168951004193;3403.234272288734;3409.267007593367;5449.4005659377535;5559.388467268597;5610.887782244357;5638.802641907529;5697.145428185774;5528.861778455541;5562.082256427685;5601.719914004304;5680.0627896397145;5717.857053573663;5084.822031228899;5123.333966584358;5167.9224811627855;5169.870753231162;5258.1849813279005;5199.168133098705;5250.527452529272;5262.289590905236;5276.8153114641;5323.866903327409;3695.815209239527;3772.2266935278203;4153.813078411479;5005.774740136684;5145.4597267287145;5165.948340516622;5174.870628234286;5175.404828444739;5196.870078248036;5209.869753256161;5020.974895125538;5097.617678674114;5124.154514505102;5139.15203991341;5192.948070519322;5216.660917040418;5426.75579598919;5488.945110548883;5489.1217405214975;5510.834674959758;5064.442911279756;6035.39646035393;6112.052631842072;6135.324535308576;6141.508679305645;6112.63324200545;6189.6905154742535;6193.411625895533;6208.72060757267;6232.501399888043;5548.69482178476;5592.217089607459;5646.435356464362;5691.317041954951;5730.19777231188;6186.1648677427975;6212.72042758077;6215.254169499599;6222.097795819581;6229.283632382243;6006.849828754316;6044.032954727222;6045.697715114226;6060.212172417558;6097.451229389376;5330.307060082165;6066.332703402622;6135.355787642323;6165.599236049642;6179.011358182669;5847.970760146172;5901;5903.852403689856;5987.341392446828;6064.757409703562;6087.678066570947;6105.732692890381;6138.294096178996;6146.0473626587955;6171.814845554641;4718.4337879454;4775.044991001744;4828.879278018007;4829.73436460998;4863.416390033148;4269.274223382033;4294.677899157576;4301.569843015736;4330.783460826946;4342.956570434255;5647.265855438766;5704.743286552115;5709.058005429058;5722.027255366597;5726.2555867737765;6019.367966363468;6199.783007594803;6202.162708034358;6207.099970504251;6233.438990490878;5593.580481463907;5663.546916246691;5670.886582268332;5732.34078081026;5803.593748437569;4443.333499974965;5252.737363131828;5288.9735551322;5301.575873930076;5306.548943339782;6261.154744109578;6278.0269058296035;6314.652694101776;6315.210598675166;6337.7781777637565;5461.399246083007;6083.422074902877;6090.573659843945;6103;6110.7106460192745;6249.062640603764;6287.497000240061;6292.2134733158355;6293.748250069946;6299.779507717208;6032.939670603238;6060.545459090497;6079.696015199134;6112.847178820387;6131.110988906673;5912.142739302863;6084.726187321493;6119.2350956130485;6175.938240617536;6182.289036760651;5828.825135245949;5913.34953155144;6034.426729460694;6045.063015232646;6045.727942242697;5943;5949.494292985145;5968;5992.1910542078;6000.489958353589;4778.641601879943;5645.4072322405555;5748.712564371681;5761.279840019997;5846.269216347957;5902.6458412495385;5916.792912248051;5922.851928701817;5997.460228579449;6003.7898673546215;5806.564507662027;5806.82579522615;5809.535237180931;5814.970925145347;5836.737346819318 14:15:11 INFO - PROCESS | 1661 | |1;ext.html;444.2115245439345;472.53691382445214;479.7673128532662;515.3172047037674;542.891421715657;27111.864440677793;33833.1541711457;40192.598074019326;41068.79465602675;41166.58833411665;42179.36730949038;42535.78732106335;42584;42648;42722.572774272245;8354.791130221733;9622.47076410799;9794.020597940185;9823.705288841345;9830.803383932318;8078.35373170145;9787.951060244724;9798.167155791767;9799.363041402286;9810.362326448794;8282.792930176764;9772.511374431286;9797.706068817946;9836.901630983706;9917.107460328569;9739.902600974006;9751.122398984055;9755.609775608968;9756;9803.656872009517;9655.758606034835;9741;9754.853677194847;9770.26722995771;9786.853197202048;40724.18551628981;40733;40781;40853.795731021455;40955.180896381906;3242.6270978837265;3334.649861764504;3337.7496687748517;3359.731221502274;3428.245785927092;30867;31214.53178202329;31443.213919651964;31469.842650786828;31697.366052679048;3215.887443939451;3229.938740822345;3263.7715359924814;3356.580427446569;3368.1916340078205;472767;477591;480652;481222;481949.59025205;57688;57816.483857098305;57892.13161802576;57961;58063.709681452165;60033.69983150056;60800.69599651973;60874.39125608776;60970.0854487183;61041;14108.365123569463;15532.844671553139;15947.521574352788;16226.432074877323;16252.593685157966;12538.310392928293;12585.93707031459;12643.367831608382;12653.177543459646;12656.050796190322;14959.177245251616;15505.767413488808;15591.376344946075;15816.683666326839;15881.888267821372;5455.863603409946;5629.662220266715;5738.196652468658;6812.761553345609;6816.522843400914;805.5046146619903;917.821024900138;964.6527250189926;1019.179560453827;1027.429776474049;29723.256918577208;30057.549136762966;30156.54765178524;30368;30608;889.1597440418872;924.2698268367914;1026.7895081508273;1032.8450732390202;1069.983950240747;14978.550643480714;15453.459128930434;15543.300551475211;15768.921155394379;15887.920560397355;681702;718622;721447;725585;953589;49109.7722556939;57618.8476230473;57926;58476;58637;1247.1955588645455;1306.7259422063603;1327.6083555351195;1337.7592033434075;1343.9584322150217;28802.135935921957;30189.698103018687;31199.908003219778;31484.055478335686;32097.679023210403;55689.72155139199;56213.15680264717;56375;56380.15429768475;56597;594210.0578994155;599137;599376;599489;600931;37752.24495510129;41716;41910.79044604758;42348;42920.78539607282;37446.625533745406;38591.6140838588;46631.53368466272;47804;48681.5131848677;34162.65837341595;38805.02987425224;39660;39918.002049948984;40710.59289407068;32482;38653.806730966164;38858.61141388663;40222.59777402189;40236;37506.812465937495;38413.006309179626;38426.84719458421;38560.80719596384;40166.79916600515;30280.242993925327;30452.39095218039;34828.65171348254;35284.94145175649;35768.64231357757;23750.643740343563;24119.15582954588;24910.478280384585;25556.361090972132;25959.35101622399 14:15:11 INFO - PROCESS | 1661 | |2;jquery.html;313.36856234687104;364.5607043512568;365.0017202949932;373.6842368198871;393.85427391865016;15512.68974620507;20427.591448171046;21732.8913355433;21853.890730546344;22166.224182153626;20481.283155089575;20567.38297851063;20698.586028279464;21028.894855525738;21029.789702102975;5688.772449102042;5720.79977200798;6014.278286605613;6069.08963655453;6084.117802918574;3801.505804245458;6027.427394397547;6032.638041717489;6059.606125601822;6075.513958883279;3990.580988996157;5742.885142297172;6006.729697163638;6053.122297266894;6064.727087281083;6043.153958445799;6044.123602077696;6062.939370606282;6505.804825855232;6626.966865165643;4913.828016019458;5807.593468457209;5860.970695146497;5866.911996320058;5885.440883116097;13049.021323400782;23276.30171094853;23973.76026239733;24244.87877560601;25628.615570766455;2072.7305450291365;2274.3972847195505;2276.055436993646;2458.791002764767;2693.5824947133224;9882.505874706236;9952.552135153936;9989.300748947577;10458.477076146162;10512.842307365396;1830.094103418803;1857.1072940004979;1873.9812601873944;1891.527118220445;1969.606078784249;114052;114791.85208147895;117998;128686.3565682175;130790.6920930788;11316;11504.814085323762;11522.366269855238;11751.294922304689;12026.75946481083;14359.282035898372;14364.928175359057;14379.568612941628;14382;14389.856101438852;8240.587970601566;8481.830363392697;8502.024291497926;8526.701565445179;8552.230299273095;8288.668453261922;8368.037675667254;8412.284955778827;8526.531040792815;8573;4437.5784300491405;4507.301368287921;4532.297493888453;4587.770611469413;4675.4389473262745;1897.6394485048072;1931.806819318085;1932.3816378758943;1949.1647501204443;1960.3922783937026;370.92581483703367;380.04418886500474;417.74517544297953;423.21493629317786;428.96782741294527;9751.707448776548;11808.291502509877;11889.346085965182;12189.939050304693;12235.082368822195;338.7476330134066;360.7438718509835;403.9394090886391;414.7552943763134;430.55437622061015;6087.421694939062;6166.969165154145;6194.566380353423;6246.812595622138;6264;614612;616665.5834903914;621120;624965;626891;133213.99999999805;133250.33374833062;135047;136765;140666.29666851804;430.2341831539864;435.51875177928565;443.22878191945784;444.89989752305473;449.2026652691433;9435.811283774148;11274.267172633752;11394;11537.077033837106;11621.128415368712;54405.639859003844;55714;56584.71707641435;56834.14748778689;57027;57894.710526447096;83422;84049.57975210085;84386.73419898584;86258;7980.720674776355;8046.235607617267;8064.3548516119745;8380.874286885824;8461.788455288666;9333.953330233306;11893.405329733652;11931.880681193077;12769.680757981125;12967.805482917953;10674.758300756928;10724.678259652223;11079.72300692489;11113.611023614134;11341.829872552084;9459.952700236454;10239.539220735234;10794.460276985963;10851.511681974487;10975.560977561128;10523.736906577396;11319.830202547133;11388.829167562659;11670.766584668429;11677.299362038304;7953.8409231813885;7955.204479551999;8395.24442800151;8428.283595894418;8440.704575339834;10416.583336666448;11322.433878305887;11465.541378345106;11607.129465289969;11621.88378116208 14:15:11 INFO - PROCESS | 1661 | |3;mootools.html;1480.1341215388998;1536.03229965122;1751.7372394140878;1838.8161183881605;1848.4454663600916;7837.960810195956;8067.394945379106;8425.705100321482;8964.193222609963;8983.999999999993;8409.95795021024;8717.433366831152;8725.171108744675;8822.558872056403;8843.602037908293;2295.150794206146;2326.1625814706777;2329.6272596384583;2331.230693871027;2334.0897050150456;2099.517111064456;2200.656301039396;2301.102569997702;2302.1366987379733;2338.2751347082376;2265.728112626479;2291.919782807602;2297.1270917051497;2311.861288322706;2328.1618617297845;2282.132789539981;2287.5653625811124;2292.381057114578;2297.276357947258;2301.217586020761;2275.5562665280277;2282.9771702283097;2291.7822806833324;2292.7592602776804;2298.5632729781287;8834.779130521723;8851.07063758309;8930.776730581723;8936.597853096626;8939.68711095115;5181.222816577506;5265.341832270966;5344.866378340534;5355.437679043684;5362.410134885159;3395.3548825723033;3463.0822831949554;3528.700060494861;3582.9641703582893;3593.568771747407;1039.2102002478096;1040.3497813866334;1041.2034793383068;1044.2429238801883;1058.6083149234832;11464.19750617457;11524.366159861203;11670.824937625857;11702.707432314175;11721.355325457096;4020.4572382728543;4042.7372220805555;4063.512378514597;4540.500544940054;4763.071201115818;9986.300958932805;10023.69928902134;10028.44843533598;10033.648822291185;10034.09693127622;5325.866853328698;5337.973310133424;5342.1452567589;5345.305110335631;5345.33183352081;4369.497507786582;4525.932111018337;4798.760061996886;4858.02839432115;4904.485029071968;3791.7724936503896;3884.0484081400236;3973.48344715191;3979.2041591681777;4018.8392464301687;1273.5669872243298;1281.071223363073;1284.4348486665838;1289.335991964139;1293.2886912198253;812.6586833529932;896.0994200828126;913.5980168725739;918.3617385916857;939.7039932421266;5304.549113325334;5622.0161471742285;5802.709864506758;5930.813837232571;6044.123602077674;413.05822724188897;414.55228353378277;423.9830406783756;432.5739146940324;433.231014948469;3063.417950589381;3920.157166209279;3987.720859539804;4002.639762421396;4052.8986775330854;9921.25590580695;10666.253362264722;10750.301230419998;10789.83815242772;10808.351498910091;10640;10760.031597156294;10764.461776911123;10771.138308935266;10777.46112694378;7654.578998155043;7912.683492660229;7994.68021279154;8008.439409241297;8105.108438071689;4912.48418916023;5957.136215248851;6004.0880173116875;6018.976773948351;6141.631502109888;8608.010078841013;9202.35583509148;9686.32195746291;9938.45338506389;10063;9776;10045.246606504395;10072.740907386577;10140.087392134743;10225.693229203136;7000.334968178015;7201.13586369639;7506.549607023596;7694.499857509468;7860.449768516149;8184.959075204586;8350.206730360605;8363.247307742333;8431.15688431152;8449.11284315138;7290.817729556804;7412.62936853166;7426.2945020223;7446.627668616656;7508.774736757906;7096.112985876765;7255.274472552914;7258.165310989304;7317.414606831547;7344.265573442826;6932.61870597122;6964.860702786017;7061.329173728487;7066.293370662893;7067.71729130829;4012.67898568108;4812.542808433193;4911.091448082117;4925;5021.623378246573;4654.301854721819;4867.61059115277;4954.256861470808;4972.105021096238;5020.723860187724 14:15:11 INFO - PROCESS | 1661 | |4;prototype.html;292.7526240326923;301.874721990374;302.6700896023334;308.8749056632064;312.96096958099105;4720.5515476029805;5418.862038971811;5507.201455788908;5571.080771672674;5585.553155747541;4186.513787605402;4341.544137865526;4383.671224658147;4739.289106634006;5387.164989426645;3729.160938788778;4108.691848111389;4140.047789008529;4157.729747566414;4169.499660040784;3957.2085582883537;4144.730592511492;4145.844161036274;4158.8960275993195;4163.938195760092;3277.738070842731;3719.8140092995377;3969.7249768940596;4078.3066878630702;4165.541790403053;3440.7591468597207;4138.627523522882;4147.979260103695;4151.709380343347;4158.480189976253;3624.637536246354;3624.691901188402;3644.7084233261276;3646.6353364663587;3664.9450258246147;4285.014446677251;5098.5411312982005;5133.922991155136;5177.896442071175;5299.390570084451;4716.669833111683;4770.16522108633;4772.498887616785;4798.232282834764;4827.806887724487;4976.054549635558;5377.946220537784;5700.401457846908;5769.278840144982;5821.563382746269;3861.5559210690567;3873.1479074603544;3912.15888583953;3915.6671682906986;4009.4186342980106;5022.4726403727445;5101.489851014869;5547;6001.739634676679;6130.325664176937;3494.3186078714916;4092.1406504633765;4097.684808083423;4112.321466957918;4115.54728979812;3820.178661587772;4063.2482990646827;4175.498940127204;4192.979035104866;4194.559571245037;4347.7173983690955;4442.933355999663;4535.63714902807;4703.2004559225015;4725.220338644154;4585.541445855454;5015.749212539358;5506.182959623315;5672.695280085603;5785.50823180026;1255.610760664197;1351.1555277951281;1371.136184203945;1392.5195807446414;1400.649837540615;935.209747763139;945.9858102128474;961.4519723757392;968.6464440479174;973.8490533967247;4677.3451716759;4901.436334821541;5368.4631536846;5370.946290537123;5423.610243597752;5427.9185812212845;5830.3586605473365;5888.970555147197;5911.812629327091;5914.852128696731;4424.402705634762;4925.458199598042;4949.727764972889;5001.374828146481;5263.421023687391;2132.882691451985;2420.7458216887326;2478.467129567152;2563.8205325627027;2592.468543948486;4231.153769246163;4575.99328147807;4625.7455839929125;5052.141136006888;5063.392392912874;3612.8554857805393;3948.072203032285;4241.512226094039;4963.776630051656;5033.874153146201;4312.849050283287;4479.955200447954;4638.7216766993415;4885.316055752198;4955.166588362257;4303.762043737302;4327.468430967793;4600.608948239437;4791.664583479123;4893.877653058702;3834.6033728919424;4124.298869192185;4625.444946606429;4636.489986101458;4786.880327991688;5458.808941687022;5635.872825434847;6137.815865524041;6205.47253483459;6233.283172435046;3522.753407261467;3895.376739721631;3928.2929072767174;3964.9603503965745;3966.6826653867042;4749.430068391677;5582.804601838916;5951.523878089829;5958.612690175125;5993.340732519332;5647.661140331593;5691.4104082643125;5720.971395143164;5722.74247658848;5723.5707321950185;4790.520947905182;5009.899802003866;5127.15422447911;5648.1592517088775;5767.798127065533;4736.5973892219545;5301.9469805303;5530.944690553043;5659.349174844946;5676.829695109153;4965.652404331807;5473.343198816167;5727.198192253005;5752.223449834386;5774.566907481872;4776.972950815452;5463.344398672185;5621.943780562142;5631.915521267266;5676.574256930664 14:15:11 INFO - PROCESS | 1661 | |5;yui.html;704.4962851561133;706.6078326528774;728.2971932085536;729.2415887477024;763.5380594740178;14394.568162955102;15189.31648075835;15189.848101518981;15193.696126077471;15243.31405086771;14291.356888939996;14390.208538530376;14392.71214575708;14394.928025359884;14411.63970900728;632.2665707778978;663.3896814930275;686.831726227075;820.0774129104757;842.6292431330195;710.7050574011805;856.2721686566431;857.1685465098844;857.1942374168293;857.661223816592;889.89321281446;901.7520181949983;904.1139683110556;906.1799071839962;908.1327332397544;890.2343984173606;890.9509976951265;901.9594118264694;904.900460949295;906.5014242166782;576.1616847486896;659.0608383054129;663.0849427789667;663.9236487803917;665.6139439125295;13595.592132236048;13663.658408539766;13824.930875345659;13967.860321396758;14108.717825643533;11405.600803971822;14399.928000360036;14415.135091894415;14493;14525.564233073024;11717.53129874804;11779.823302650468;11884.643460696192;11919.880801191965;12178.269303841798;3249.5938007749032;3818.6754125899333;3848.576656567803;3892.6496615304477;4006.9198616027516;94877.5256123715;96852.54721179188;104439.47780261126;106229;106571;10977.231593788518;11141.72145696364;11197.94401028006;11419;11646.70883227926;19054.713434387686;22024.88987555084;22593.548129037328;22989.7701022991;23043.423914401938;7443.516171448839;7451.627418629047;7484.476086673881;7525.736599219001;7648.464607477423;4072.3687828386646;4209.326507758744;4259.872203833828;4324.156789426094;4399.736015838996;3585.94621080684;3671.430928206132;3693.353663108945;3701.0192299040777;3702.6667599916136;649.6426965169138;662.1326062857576;662.8574856405896;669.4376723552142;676.7597502886503;589.2693060604905;615.9199304090529;659.7427003468651;664.7839452178061;668.5286872754793;9220.815583688423;9311.534423278945;9344.205742511827;9466.95266523663;9478.810423791485;531.7819693925472;603.746426500862;632.250782822357;632.658364483174;647.2944490505372;4055.1889622075705;4096.815643296059;4124.989377602446;4227.598378154071;4238.554951730086;105634.47182764037;147987.26006370113;148610;152667;155615.22192388965;128355;131358;131422;132503.33748331197;134999;70460.2953970464;70668.93996590056;102259.4887025575;107090.9290907081;109441.90558094476;7631.771046868603;8232.753017409488;8437.282830959191;8522.531260780717;8552.401331906707;39939.80030099831;42907;44645.33032004457;62344.06483902836;65239.673801630684;80977;83305;85326.1467385343;91109.54445227732;91126.54436727773;11204;13079.803802943154;13284.960356418442;13721.862781372458;13975.510857119953;13080.869191307966;14660.70678586401;14854.40582376736;15235.3905843765;15725.685486289982;11612.361320127136;13711;13809.309534523032;13926.721465570834;14393.856061439252;13588.369395672582;13610.86389136096;13861;13933.790993135313;14123;13362.064655474023;13403;13594.592162235149;13842.792358114837;14049.705644581201;11226.326420414802;11400.315981041163;11402.600908968147;11408;11534.653960381202;7450.515716478411;10482.580696772044;10810.567577297135;11035.510206122392;11106.278091924 14:15:11 INFO - PROCESS | 1661 | __end_tp_report 14:15:11 INFO - PROCESS | 1661 | __start_cc_report 14:15:11 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,368 14:15:11 INFO - PROCESS | 1661 | __end_cc_report 14:15:11 INFO - PROCESS | 1661 | __startTimestamp1477516511344__endTimestamp 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | ------- Summary: start ------- 14:15:11 INFO - PROCESS | 1661 | Number of tests: 6 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5601.07 Median:5806.56 stddev:680.68 (11.7%) stddev-sans-first:648.94 14:15:11 INFO - PROCESS | 1661 | Values: 2899.8 3350.2 3390.0 3403.2 3409.3 5449.4 5559.4 5610.9 5638.8 5697.1 5528.9 5562.1 5601.7 5680.1 5717.9 5084.8 5123.3 5167.9 5169.9 5258.2 5199.2 5250.5 5262.3 5276.8 5323.9 3695.8 3772.2 4153.8 5005.8 5145.5 5165.9 5174.9 5175.4 5196.9 5209.9 5021.0 5097.6 5124.2 5139.2 5192.9 5216.7 5426.8 5488.9 5489.1 5510.8 5064.4 6035.4 6112.1 6135.3 6141.5 6112.6 6189.7 6193.4 6208.7 6232.5 5548.7 5592.2 5646.4 5691.3 5730.2 6186.2 6212.7 6215.3 6222.1 6229.3 6006.8 6044.0 6045.7 6060.2 6097.5 5330.3 6066.3 6135.4 6165.6 6179.0 5848.0 5901.0 5903.9 5987.3 6064.8 6087.7 6105.7 6138.3 6146.0 6171.8 4718.4 4775.0 4828.9 4829.7 4863.4 4269.3 4294.7 4301.6 4330.8 4343.0 5647.3 5704.7 5709.1 5722.0 5726.3 6019.4 6199.8 6202.2 6207.1 6233.4 5593.6 5663.5 5670.9 5732.3 5803.6 4443.3 5252.7 5289.0 5301.6 5306.5 6261.2 6278.0 6314.7 6315.2 6337.8 5461.4 6083.4 6090.6 6103.0 6110.7 6249.1 6287.5 6292.2 6293.7 6299.8 6032.9 6060.5 6079.7 6112.8 6131.1 5912.1 6084.7 6119.2 6175.9 6182.3 5828.8 5913.3 6034.4 6045.1 6045.7 5943.0 5949.5 5968.0 5992.2 6000.5 4778.6 5645.4 5748.7 5761.3 5846.3 5902.6 5916.8 5922.9 5997.5 6003.8 5806.6 5806.8 5809.5 5815.0 5836.7 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:73989.11 Median:41011.99 stddev:167998.49 (409.6%) stddev-sans-first:168379.02 14:15:11 INFO - PROCESS | 1661 | Values: 444.2 472.5 479.8 515.3 542.9 27111.9 33833.2 40192.6 41068.8 41166.6 42179.4 42535.8 42584.0 42648.0 42722.6 8354.8 9622.5 9794.0 9823.7 9830.8 8078.4 9788.0 9798.2 9799.4 9810.4 8282.8 9772.5 9797.7 9836.9 9917.1 9739.9 9751.1 9755.6 9756.0 9803.7 9655.8 9741.0 9754.9 9770.3 9786.9 40724.2 40733.0 40781.0 40853.8 40955.2 3242.6 3334.6 3337.7 3359.7 3428.2 30867.0 31214.5 31443.2 31469.8 31697.4 3215.9 3229.9 3263.8 3356.6 3368.2 472767.0 477591.0 480652.0 481222.0 481949.6 57688.0 57816.5 57892.1 57961.0 58063.7 60033.7 60800.7 60874.4 60970.1 61041.0 14108.4 15532.8 15947.5 16226.4 16252.6 12538.3 12585.9 12643.4 12653.2 12656.1 14959.2 15505.8 15591.4 15816.7 15881.9 5455.9 5629.7 5738.2 6812.8 6816.5 805.5 917.8 964.7 1019.2 1027.4 29723.3 30057.5 30156.5 30368.0 30608.0 889.2 924.3 1026.8 1032.8 1070.0 14978.6 15453.5 15543.3 15768.9 15887.9 681702.0 718622.0 721447.0 725585.0 953589.0 49109.8 57618.8 57926.0 58476.0 58637.0 1247.2 1306.7 1327.6 1337.8 1344.0 28802.1 30189.7 31199.9 31484.1 32097.7 55689.7 56213.2 56375.0 56380.2 56597.0 594210.1 599137.0 599376.0 599489.0 600931.0 37752.2 41716.0 41910.8 42348.0 42920.8 37446.6 38591.6 46631.5 47804.0 48681.5 34162.7 38805.0 39660.0 39918.0 40710.6 32482.0 38653.8 38858.6 40222.6 40236.0 37506.8 38413.0 38426.8 38560.8 40166.8 30280.2 30452.4 34828.7 35284.9 35768.6 23750.6 24119.2 24910.5 25556.4 25959.4 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35328.00 Median:2090.77 stddev:103903.25 (4969.6%) stddev-sans-first:104161.46 14:15:11 INFO - PROCESS | 1661 | Values: 313.4 364.6 365.0 373.7 393.9 15512.7 20427.6 21732.9 21853.9 22166.2 20481.3 20567.4 20698.6 21028.9 21029.8 5688.8 5720.8 6014.3 6069.1 6084.1 3801.5 6027.4 6032.6 6059.6 6075.5 3990.6 5742.9 6006.7 6053.1 6064.7 6043.2 6044.1 6062.9 6505.8 6627.0 4913.8 5807.6 5861.0 5866.9 5885.4 13049.0 23276.3 23973.8 24244.9 25628.6 2072.7 2274.4 2276.1 2458.8 2693.6 9882.5 9952.6 9989.3 10458.5 10512.8 1830.1 1857.1 1874.0 1891.5 1969.6 114052.0 114791.9 117998.0 128686.4 130790.7 11316.0 11504.8 11522.4 11751.3 12026.8 14359.3 14364.9 14379.6 14382.0 14389.9 8240.6 8481.8 8502.0 8526.7 8552.2 8288.7 8368.0 8412.3 8526.5 8573.0 4437.6 4507.3 4532.3 4587.8 4675.4 1897.6 1931.8 1932.4 1949.2 1960.4 370.9 380.0 417.7 423.2 429.0 9751.7 11808.3 11889.3 12189.9 12235.1 338.7 360.7 403.9 414.8 430.6 6087.4 6167.0 6194.6 6246.8 6264.0 614612.0 616665.6 621120.0 624965.0 626891.0 133214.0 133250.3 135047.0 136765.0 140666.3 430.2 435.5 443.2 444.9 449.2 9435.8 11274.3 11394.0 11537.1 11621.1 54405.6 55714.0 56584.7 56834.1 57027.0 57894.7 83422.0 84049.6 84386.7 86258.0 7980.7 8046.2 8064.4 8380.9 8461.8 9334.0 11893.4 11931.9 12769.7 12967.8 10674.8 10724.7 11079.7 11113.6 11341.8 9460.0 10239.5 10794.5 10851.5 10975.6 10523.7 11319.8 11388.8 11670.8 11677.3 7953.8 7955.2 8395.2 8428.3 8440.7 10416.6 11322.4 11465.5 11607.1 11621.9 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5634.60 Median:4708.69 stddev:3212.94 (68.2%) stddev-sans-first:3206.79 14:15:11 INFO - PROCESS | 1661 | Values: 1480.1 1536.0 1751.7 1838.8 1848.4 7838.0 8067.4 8425.7 8964.2 8984.0 8410.0 8717.4 8725.2 8822.6 8843.6 2295.2 2326.2 2329.6 2331.2 2334.1 2099.5 2200.7 2301.1 2302.1 2338.3 2265.7 2291.9 2297.1 2311.9 2328.2 2282.1 2287.6 2292.4 2297.3 2301.2 2275.6 2283.0 2291.8 2292.8 2298.6 8834.8 8851.1 8930.8 8936.6 8939.7 5181.2 5265.3 5344.9 5355.4 5362.4 3395.4 3463.1 3528.7 3583.0 3593.6 1039.2 1040.3 1041.2 1044.2 1058.6 11464.2 11524.4 11670.8 11702.7 11721.4 4020.5 4042.7 4063.5 4540.5 4763.1 9986.3 10023.7 10028.4 10033.6 10034.1 5325.9 5338.0 5342.1 5345.3 5345.3 4369.5 4525.9 4798.8 4858.0 4904.5 3791.8 3884.0 3973.5 3979.2 4018.8 1273.6 1281.1 1284.4 1289.3 1293.3 812.7 896.1 913.6 918.4 939.7 5304.5 5622.0 5802.7 5930.8 6044.1 413.1 414.6 424.0 432.6 433.2 3063.4 3920.2 3987.7 4002.6 4052.9 9921.3 10666.3 10750.3 10789.8 10808.4 10640.0 10760.0 10764.5 10771.1 10777.5 7654.6 7912.7 7994.7 8008.4 8105.1 4912.5 5957.1 6004.1 6019.0 6141.6 8608.0 9202.4 9686.3 9938.5 10063.0 9776.0 10045.2 10072.7 10140.1 10225.7 7000.3 7201.1 7506.5 7694.5 7860.4 8185.0 8350.2 8363.2 8431.2 8449.1 7290.8 7412.6 7426.3 7446.6 7508.8 7096.1 7255.3 7258.2 7317.4 7344.3 6932.6 6964.9 7061.3 7066.3 7067.7 4012.7 4812.5 4911.1 4925.0 5021.6 4654.3 4867.6 4954.3 4972.1 5020.7 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4409.14 Median:4737.94 stddev:1340.79 (28.3%) stddev-sans-first:1308.47 14:15:11 INFO - PROCESS | 1661 | Values: 292.8 301.9 302.7 308.9 313.0 4720.6 5418.9 5507.2 5571.1 5585.6 4186.5 4341.5 4383.7 4739.3 5387.2 3729.2 4108.7 4140.0 4157.7 4169.5 3957.2 4144.7 4145.8 4158.9 4163.9 3277.7 3719.8 3969.7 4078.3 4165.5 3440.8 4138.6 4148.0 4151.7 4158.5 3624.6 3624.7 3644.7 3646.6 3664.9 4285.0 5098.5 5133.9 5177.9 5299.4 4716.7 4770.2 4772.5 4798.2 4827.8 4976.1 5377.9 5700.4 5769.3 5821.6 3861.6 3873.1 3912.2 3915.7 4009.4 5022.5 5101.5 5547.0 6001.7 6130.3 3494.3 4092.1 4097.7 4112.3 4115.5 3820.2 4063.2 4175.5 4193.0 4194.6 4347.7 4442.9 4535.6 4703.2 4725.2 4585.5 5015.7 5506.2 5672.7 5785.5 1255.6 1351.2 1371.1 1392.5 1400.6 935.2 946.0 961.5 968.6 973.8 4677.3 4901.4 5368.5 5370.9 5423.6 5427.9 5830.4 5889.0 5911.8 5914.9 4424.4 4925.5 4949.7 5001.4 5263.4 2132.9 2420.7 2478.5 2563.8 2592.5 4231.2 4576.0 4625.7 5052.1 5063.4 3612.9 3948.1 4241.5 4963.8 5033.9 4312.8 4480.0 4638.7 4885.3 4955.2 4303.8 4327.5 4600.6 4791.7 4893.9 3834.6 4124.3 4625.4 4636.5 4786.9 5458.8 5635.9 6137.8 6205.5 6233.3 3522.8 3895.4 3928.3 3965.0 3966.7 4749.4 5582.8 5951.5 5958.6 5993.3 5647.7 5691.4 5721.0 5722.7 5723.6 4790.5 5009.9 5127.2 5648.2 5767.8 4736.6 5301.9 5530.9 5659.3 5676.8 4965.7 5473.3 5727.2 5752.2 5774.6 4777.0 5463.3 5621.9 5631.9 5676.6 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:23475.97 Median:3760.67 stddev:37533.83 (998.1%) stddev-sans-first:37600.18 14:15:11 INFO - PROCESS | 1661 | Values: 704.5 706.6 728.3 729.2 763.5 14394.6 15189.3 15189.8 15193.7 15243.3 14291.4 14390.2 14392.7 14394.9 14411.6 632.3 663.4 686.8 820.1 842.6 710.7 856.3 857.2 857.2 857.7 889.9 901.8 904.1 906.2 908.1 890.2 891.0 902.0 904.9 906.5 576.2 659.1 663.1 663.9 665.6 13595.6 13663.7 13824.9 13967.9 14108.7 11405.6 14399.9 14415.1 14493.0 14525.6 11717.5 11779.8 11884.6 11919.9 12178.3 3249.6 3818.7 3848.6 3892.6 4006.9 94877.5 96852.5 104439.5 106229.0 106571.0 10977.2 11141.7 11197.9 11419.0 11646.7 19054.7 22024.9 22593.5 22989.8 23043.4 7443.5 7451.6 7484.5 7525.7 7648.5 4072.4 4209.3 4259.9 4324.2 4399.7 3585.9 3671.4 3693.4 3701.0 3702.7 649.6 662.1 662.9 669.4 676.8 589.3 615.9 659.7 664.8 668.5 9220.8 9311.5 9344.2 9467.0 9478.8 531.8 603.7 632.3 632.7 647.3 4055.2 4096.8 4125.0 4227.6 4238.6 105634.5 147987.3 148610.0 152667.0 155615.2 128355.0 131358.0 131422.0 132503.3 134999.0 70460.3 70668.9 102259.5 107090.9 109441.9 7631.8 8232.8 8437.3 8522.5 8552.4 39939.8 42907.0 44645.3 62344.1 65239.7 80977.0 83305.0 85326.1 91109.5 91126.5 11204.0 13079.8 13285.0 13721.9 13975.5 13080.9 14660.7 14854.4 15235.4 15725.7 11612.4 13711.0 13809.3 13926.7 14393.9 13588.4 13610.9 13861.0 13933.8 14123.0 13362.1 13403.0 13594.6 13842.8 14049.7 11226.3 11400.3 11402.6 11408.0 11534.7 7450.5 10482.6 10810.6 11035.5 11106.3 14:15:11 INFO - PROCESS | 1661 | -------- Summary: end -------- 14:15:11 INFO - PROCESS | 1661 | 14:15:11 INFO - TEST-INFO | 1661: exit 0 14:15:11 INFO - TEST-OK | dromaeo_css | took 1114339ms 14:15:11 INFO - TEST-START | kraken 14:15:11 INFO - operating with platform_type : mac_ 14:15:11 INFO - Initialising browser for kraken test... 14:15:11 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpHf6jrS/profile http://localhost:49267/getInfo.html) 14:15:14 INFO - PROCESS | 1670 | 2016-10-26 14:15:14.590 plugin-container[1671:10248] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 14:15:14 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:14 INFO - PROCESS | 1670 | 2016-10-26 14:15:14.593 plugin-container[1671:10248] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460f, name = 'com.apple.CFPasteboardClient' 14:15:14 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:14 INFO - PROCESS | 1670 | 2016-10-26 14:15:14.593 plugin-container[1671:10248] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:14 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 14:15:14 INFO - PROCESS | 1670 | colorDepth:24 14:15:14 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 14:15:14 INFO - PROCESS | 1670 | __metrics 14:15:14 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:15:15 INFO - TEST-INFO | 1670: exit 0 14:15:15 INFO - Browser initialized. 14:15:15 INFO - Running cycle 1/1 for kraken test... 14:15:15 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpHf6jrS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:17 INFO - PROCESS | 1672 | 2016-10-26 14:15:17.890 plugin-container[1673:10366] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 14:15:17 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:17 INFO - PROCESS | 1672 | 2016-10-26 14:15:17.891 plugin-container[1673:10366] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.CFPasteboardClient' 14:15:17 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:17 INFO - PROCESS | 1672 | 2016-10-26 14:15:17.891 plugin-container[1673:10366] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:27 INFO - PROCESS | 1672 | RSS: Main: 238931968 14:15:27 INFO - PROCESS | 1672 | 14:15:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:31 INFO - PROCESS | 1672 | RSS: Main: 252690432 14:15:31 INFO - PROCESS | 1672 | 14:15:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 14:15:34 INFO - PROCESS | 1672 | RSS: Main: 260165632 14:15:34 INFO - PROCESS | 1672 | 14:15:38 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 14:15:39 INFO - PROCESS | 1672 | RSS: Main: 261070848 14:15:39 INFO - PROCESS | 1672 | 14:15:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 14:15:41 INFO - PROCESS | 1672 | RSS: Main: 263217152 14:15:41 INFO - PROCESS | 1672 | 14:15:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:44 INFO - PROCESS | 1672 | RSS: Main: 263675904 14:15:44 INFO - PROCESS | 1672 | 14:15:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:48 INFO - PROCESS | 1672 | RSS: Main: 264056832 14:15:48 INFO - PROCESS | 1672 | 14:15:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:51 INFO - PROCESS | 1672 | RSS: Main: 264638464 14:15:51 INFO - PROCESS | 1672 | 14:15:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 14:15:55 INFO - PROCESS | 1672 | RSS: Main: 264323072 14:15:55 INFO - PROCESS | 1672 | 14:15:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:58 INFO - PROCESS | 1672 | RSS: Main: 264278016 14:15:58 INFO - PROCESS | 1672 | 14:15:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:00 INFO - PROCESS | 1672 | RSS: Main: 264228864 14:16:00 INFO - PROCESS | 1672 | 14:16:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:03 INFO - PROCESS | 1672 | RSS: Main: 264310784 14:16:03 INFO - PROCESS | 1672 | 14:16:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:07 INFO - PROCESS | 1672 | RSS: Main: 264638464 14:16:07 INFO - PROCESS | 1672 | 14:16:10 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:10 INFO - PROCESS | 1672 | RSS: Main: 264433664 14:16:10 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 14:16:12 INFO - PROCESS | 1672 | RSS: Main: 267403264 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | __start_tp_report 14:16:12 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 14:16:12 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 14:16:12 INFO - PROCESS | 1672 | |i|pagename|runs| 14:16:12 INFO - PROCESS | 1672 | |0;ai-astar;116;118;120;118;118;120;120;106;148;175 14:16:12 INFO - PROCESS | 1672 | |1;audio-beat-detection;146;115;123;186;148;138;118;116;162;116 14:16:12 INFO - PROCESS | 1672 | |2;audio-dft;204;235;254;196;197;203;196;198;196;226 14:16:12 INFO - PROCESS | 1672 | |3;audio-fft;79;58;59;83;62;49;62;70;103;82 14:16:12 INFO - PROCESS | 1672 | |4;audio-oscillator;128;102;121;103;57;79;125;101;101;100 14:16:12 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;136;132;90;111;84;131;135;120;93;89 14:16:12 INFO - PROCESS | 1672 | |6;imaging-darkroom;101;121;171;107;112;170;110;112;100;102 14:16:12 INFO - PROCESS | 1672 | |7;imaging-desaturate;77;131;146;138;91;77;150;122;133;92 14:16:12 INFO - PROCESS | 1672 | |8;json-parse-financial;49;50;58;56;63;76;87;86;87;71 14:16:12 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;72;68;70;79;72;68;60;87;63;67 14:16:12 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;87;92;92;90;102;77;78;83;77;109 14:16:12 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;146;165;162;162;148;148;161;158;193;164 14:16:12 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;178;175;176;171;172;172;175;176;217;204 14:16:12 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;85;87;92;90;85;70;70;67;86 14:16:12 INFO - PROCESS | 1672 | __end_tp_report 14:16:12 INFO - PROCESS | 1672 | __start_cc_report 14:16:12 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,921 14:16:12 INFO - PROCESS | 1672 | __end_cc_report 14:16:12 INFO - PROCESS | 1672 | __startTimestamp1477516572899__endTimestamp 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | ------- Summary: start ------- 14:16:12 INFO - PROCESS | 1672 | Number of tests: 14 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:125.90 Median:120.00 stddev:20.23 (16.9%) stddev-sans-first:21.14 14:16:12 INFO - PROCESS | 1672 | Values: 116.0 118.0 120.0 118.0 118.0 120.0 120.0 106.0 148.0 175.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:142.00 stddev:23.92 (16.8%) stddev-sans-first:25.14 14:16:12 INFO - PROCESS | 1672 | Values: 146.0 115.0 123.0 186.0 148.0 138.0 118.0 116.0 162.0 116.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:210.50 Median:203.50 stddev:20.55 (10.1%) stddev-sans-first:21.66 14:16:12 INFO - PROCESS | 1672 | Values: 204.0 235.0 254.0 196.0 197.0 203.0 196.0 198.0 196.0 226.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:70.70 Median:66.00 stddev:16.03 (24.3%) stddev-sans-first:16.72 14:16:12 INFO - PROCESS | 1672 | Values: 79.0 58.0 59.0 83.0 62.0 49.0 62.0 70.0 103.0 82.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:123.00 stddev:21.41 (17.4%) stddev-sans-first:20.49 14:16:12 INFO - PROCESS | 1672 | Values: 128.0 102.0 121.0 103.0 57.0 79.0 125.0 101.0 101.0 100.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:112.10 Median:110.00 stddev:21.31 (19.4%) stddev-sans-first:20.78 14:16:12 INFO - PROCESS | 1672 | Values: 136.0 132.0 90.0 111.0 84.0 131.0 135.0 120.0 93.0 89.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:120.60 Median:112.00 stddev:27.04 (24.1%) stddev-sans-first:27.73 14:16:12 INFO - PROCESS | 1672 | Values: 101.0 121.0 171.0 107.0 112.0 170.0 110.0 112.0 100.0 102.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:115.70 Median:113.50 stddev:28.54 (25.1%) stddev-sans-first:26.62 14:16:12 INFO - PROCESS | 1672 | Values: 77.0 131.0 146.0 138.0 91.0 77.0 150.0 122.0 133.0 92.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:73.50 stddev:15.17 (20.6%) stddev-sans-first:14.40 14:16:12 INFO - PROCESS | 1672 | Values: 49.0 50.0 58.0 56.0 63.0 76.0 87.0 86.0 87.0 71.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:7.75 (10.9%) stddev-sans-first:8.20 14:16:12 INFO - PROCESS | 1672 | Values: 72.0 68.0 70.0 79.0 72.0 68.0 60.0 87.0 63.0 67.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:10.73 (12.6%) stddev-sans-first:11.36 14:16:12 INFO - PROCESS | 1672 | Values: 87.0 92.0 92.0 90.0 102.0 77.0 78.0 83.0 77.0 109.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:160.70 Median:162.00 stddev:13.43 (8.3%) stddev-sans-first:13.14 14:16:12 INFO - PROCESS | 1672 | Values: 146.0 165.0 162.0 162.0 148.0 148.0 161.0 158.0 193.0 164.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:176.00 stddev:15.69 (8.9%) stddev-sans-first:16.58 14:16:12 INFO - PROCESS | 1672 | Values: 178.0 175.0 176.0 171.0 172.0 172.0 175.0 176.0 217.0 204.0 14:16:12 INFO - PROCESS | 1672 | 14:16:12 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.00 Median:85.50 stddev:9.96 (11.6%) stddev-sans-first:9.57 14:16:12 INFO - PROCESS | 1672 | Values: 68.0 85.0 87.0 92.0 90.0 85.0 70.0 70.0 67.0 86.0 14:16:12 INFO - PROCESS | 1672 | -------- Summary: end -------- 14:16:12 INFO - PROCESS | 1672 | 14:16:13 INFO - TEST-INFO | 1672: exit 0 14:16:13 INFO - TEST-OK | kraken | took 61796ms 14:16:13 INFO - SUITE-END | took 1176s 14:16:14 INFO - Completed test suite (00:19:36) 14:16:14 INFO - javascript benchmark 14:16:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7085.21003600934, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2899.7535209507196, 3350.229447227139, 3390.0168951004193, 3403.234272288734, 3409.267007593367, 5449.4005659377535, 5559.388467268597, 5610.887782244357, 5638.802641907529, 5697.145428185774, 5528.861778455541, 5562.082256427685, 5601.719914004304, 5680.0627896397145, 5717.857053573663, 5084.822031228899, 5123.333966584358, 5167.9224811627855, 5169.870753231162, 5258.1849813279005, 5199.168133098705, 5250.527452529272, 5262.289590905236, 5276.8153114641, 5323.866903327409, 3695.815209239527, 3772.2266935278203, 4153.813078411479, 5005.774740136684, 5145.4597267287145, 5165.948340516622, 5174.870628234286, 5175.404828444739, 5196.870078248036, 5209.869753256161, 5020.974895125538, 5097.617678674114, 5124.154514505102, 5139.15203991341, 5192.948070519322, 5216.660917040418, 5426.75579598919, 5488.945110548883, 5489.1217405214975, 5510.834674959758, 5064.442911279756, 6035.39646035393, 6112.052631842072, 6135.324535308576, 6141.508679305645, 6112.63324200545, 6189.6905154742535, 6193.411625895533, 6208.72060757267, 6232.501399888043, 5548.69482178476, 5592.217089607459, 5646.435356464362, 5691.317041954951, 5730.19777231188, 6186.1648677427975, 6212.72042758077, 6215.254169499599, 6222.097795819581, 6229.283632382243, 6006.849828754316, 6044.032954727222, 6045.697715114226, 6060.212172417558, 6097.451229389376, 5330.307060082165, 6066.332703402622, 6135.355787642323, 6165.599236049642, 6179.011358182669, 5847.970760146172, 5901.0, 5903.852403689856, 5987.341392446828, 6064.757409703562, 6087.678066570947, 6105.732692890381, 6138.294096178996, 6146.0473626587955, 6171.814845554641, 4718.4337879454, 4775.044991001744, 4828.879278018007, 4829.73436460998, 4863.416390033148, 4269.274223382033, 4294.677899157576, 4301.569843015736, 4330.783460826946, 4342.956570434255, 5647.265855438766, 5704.743286552115, 5709.058005429058, 5722.027255366597, 5726.2555867737765, 6019.367966363468, 6199.783007594803, 6202.162708034358, 6207.099970504251, 6233.438990490878, 5593.580481463907, 5663.546916246691, 5670.886582268332, 5732.34078081026, 5803.593748437569, 4443.333499974965, 5252.737363131828, 5288.9735551322, 5301.575873930076, 5306.548943339782, 6261.154744109578, 6278.0269058296035, 6314.652694101776, 6315.210598675166, 6337.7781777637565, 5461.399246083007, 6083.422074902877, 6090.573659843945, 6103.0, 6110.7106460192745, 6249.062640603764, 6287.497000240061, 6292.2134733158355, 6293.748250069946, 6299.779507717208, 6032.939670603238, 6060.545459090497, 6079.696015199134, 6112.847178820387, 6131.110988906673, 5912.142739302863, 6084.726187321493, 6119.2350956130485, 6175.938240617536, 6182.289036760651, 5828.825135245949, 5913.34953155144, 6034.426729460694, 6045.063015232646, 6045.727942242697, 5943.0, 5949.494292985145, 5968.0, 5992.1910542078, 6000.489958353589, 4778.641601879943, 5645.4072322405555, 5748.712564371681, 5761.279840019997, 5846.269216347957, 5902.6458412495385, 5916.792912248051, 5922.851928701817, 5997.460228579449, 6003.7898673546215, 5806.564507662027, 5806.82579522615, 5809.535237180931, 5814.970925145347, 5836.737346819318], "value": 5556.023126045155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.2115245439345, 472.53691382445214, 479.7673128532662, 515.3172047037674, 542.891421715657, 27111.864440677793, 33833.1541711457, 40192.598074019326, 41068.79465602675, 41166.58833411665, 42179.36730949038, 42535.78732106335, 42584.0, 42648.0, 42722.572774272245, 8354.791130221733, 9622.47076410799, 9794.020597940185, 9823.705288841345, 9830.803383932318, 8078.35373170145, 9787.951060244724, 9798.167155791767, 9799.363041402286, 9810.362326448794, 8282.792930176764, 9772.511374431286, 9797.706068817946, 9836.901630983706, 9917.107460328569, 9739.902600974006, 9751.122398984055, 9755.609775608968, 9756.0, 9803.656872009517, 9655.758606034835, 9741.0, 9754.853677194847, 9770.26722995771, 9786.853197202048, 40724.18551628981, 40733.0, 40781.0, 40853.795731021455, 40955.180896381906, 3242.6270978837265, 3334.649861764504, 3337.7496687748517, 3359.731221502274, 3428.245785927092, 30867.0, 31214.53178202329, 31443.213919651964, 31469.842650786828, 31697.366052679048, 3215.887443939451, 3229.938740822345, 3263.7715359924814, 3356.580427446569, 3368.1916340078205, 472767.0, 477591.0, 480652.0, 481222.0, 481949.59025205, 57688.0, 57816.483857098305, 57892.13161802576, 57961.0, 58063.709681452165, 60033.69983150056, 60800.69599651973, 60874.39125608776, 60970.0854487183, 61041.0, 14108.365123569463, 15532.844671553139, 15947.521574352788, 16226.432074877323, 16252.593685157966, 12538.310392928293, 12585.93707031459, 12643.367831608382, 12653.177543459646, 12656.050796190322, 14959.177245251616, 15505.767413488808, 15591.376344946075, 15816.683666326839, 15881.888267821372, 5455.863603409946, 5629.662220266715, 5738.196652468658, 6812.761553345609, 6816.522843400914, 805.5046146619903, 917.821024900138, 964.6527250189926, 1019.179560453827, 1027.429776474049, 29723.256918577208, 30057.549136762966, 30156.54765178524, 30368.0, 30608.0, 889.1597440418872, 924.2698268367914, 1026.7895081508273, 1032.8450732390202, 1069.983950240747, 14978.550643480714, 15453.459128930434, 15543.300551475211, 15768.921155394379, 15887.920560397355, 681702.0, 718622.0, 721447.0, 725585.0, 953589.0, 49109.7722556939, 57618.8476230473, 57926.0, 58476.0, 58637.0, 1247.1955588645455, 1306.7259422063603, 1327.6083555351195, 1337.7592033434075, 1343.9584322150217, 28802.135935921957, 30189.698103018687, 31199.908003219778, 31484.055478335686, 32097.679023210403, 55689.72155139199, 56213.15680264717, 56375.0, 56380.15429768475, 56597.0, 594210.0578994155, 599137.0, 599376.0, 599489.0, 600931.0, 37752.24495510129, 41716.0, 41910.79044604758, 42348.0, 42920.78539607282, 37446.625533745406, 38591.6140838588, 46631.53368466272, 47804.0, 48681.5131848677, 34162.65837341595, 38805.02987425224, 39660.0, 39918.002049948984, 40710.59289407068, 32482.0, 38653.806730966164, 38858.61141388663, 40222.59777402189, 40236.0, 37506.812465937495, 38413.006309179626, 38426.84719458421, 38560.80719596384, 40166.79916600515, 30280.242993925327, 30452.39095218039, 34828.65171348254, 35284.94145175649, 35768.64231357757, 23750.643740343563, 24119.15582954588, 24910.478280384585, 25556.361090972132, 25959.35101622399], "value": 19925.529228498523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.36856234687104, 364.5607043512568, 365.0017202949932, 373.6842368198871, 393.85427391865016, 15512.68974620507, 20427.591448171046, 21732.8913355433, 21853.890730546344, 22166.224182153626, 20481.283155089575, 20567.38297851063, 20698.586028279464, 21028.894855525738, 21029.789702102975, 5688.772449102042, 5720.79977200798, 6014.278286605613, 6069.08963655453, 6084.117802918574, 3801.505804245458, 6027.427394397547, 6032.638041717489, 6059.606125601822, 6075.513958883279, 3990.580988996157, 5742.885142297172, 6006.729697163638, 6053.122297266894, 6064.727087281083, 6043.153958445799, 6044.123602077696, 6062.939370606282, 6505.804825855232, 6626.966865165643, 4913.828016019458, 5807.593468457209, 5860.970695146497, 5866.911996320058, 5885.440883116097, 13049.021323400782, 23276.30171094853, 23973.76026239733, 24244.87877560601, 25628.615570766455, 2072.7305450291365, 2274.3972847195505, 2276.055436993646, 2458.791002764767, 2693.5824947133224, 9882.505874706236, 9952.552135153936, 9989.300748947577, 10458.477076146162, 10512.842307365396, 1830.094103418803, 1857.1072940004979, 1873.9812601873944, 1891.527118220445, 1969.606078784249, 114052.0, 114791.85208147895, 117998.0, 128686.3565682175, 130790.6920930788, 11316.0, 11504.814085323762, 11522.366269855238, 11751.294922304689, 12026.75946481083, 14359.282035898372, 14364.928175359057, 14379.568612941628, 14382.0, 14389.856101438852, 8240.587970601566, 8481.830363392697, 8502.024291497926, 8526.701565445179, 8552.230299273095, 8288.668453261922, 8368.037675667254, 8412.284955778827, 8526.531040792815, 8573.0, 4437.5784300491405, 4507.301368287921, 4532.297493888453, 4587.770611469413, 4675.4389473262745, 1897.6394485048072, 1931.806819318085, 1932.3816378758943, 1949.1647501204443, 1960.3922783937026, 370.92581483703367, 380.04418886500474, 417.74517544297953, 423.21493629317786, 428.96782741294527, 9751.707448776548, 11808.291502509877, 11889.346085965182, 12189.939050304693, 12235.082368822195, 338.7476330134066, 360.7438718509835, 403.9394090886391, 414.7552943763134, 430.55437622061015, 6087.421694939062, 6166.969165154145, 6194.566380353423, 6246.812595622138, 6264.0, 614612.0, 616665.5834903914, 621120.0, 624965.0, 626891.0, 133213.99999999805, 133250.33374833062, 135047.0, 136765.0, 140666.29666851804, 430.2341831539864, 435.51875177928565, 443.22878191945784, 444.89989752305473, 449.2026652691433, 9435.811283774148, 11274.267172633752, 11394.0, 11537.077033837106, 11621.128415368712, 54405.639859003844, 55714.0, 56584.71707641435, 56834.14748778689, 57027.0, 57894.710526447096, 83422.0, 84049.57975210085, 84386.73419898584, 86258.0, 7980.720674776355, 8046.235607617267, 8064.3548516119745, 8380.874286885824, 8461.788455288666, 9333.953330233306, 11893.405329733652, 11931.880681193077, 12769.680757981125, 12967.805482917953, 10674.758300756928, 10724.678259652223, 11079.72300692489, 11113.611023614134, 11341.829872552084, 9459.952700236454, 10239.539220735234, 10794.460276985963, 10851.511681974487, 10975.560977561128, 10523.736906577396, 11319.830202547133, 11388.829167562659, 11670.766584668429, 11677.299362038304, 7953.8409231813885, 7955.204479551999, 8395.24442800151, 8428.283595894418, 8440.704575339834, 10416.583336666448, 11322.433878305887, 11465.541378345106, 11607.129465289969, 11621.88378116208], "value": 8515.08769331295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.1341215388998, 1536.03229965122, 1751.7372394140878, 1838.8161183881605, 1848.4454663600916, 7837.960810195956, 8067.394945379106, 8425.705100321482, 8964.193222609963, 8983.999999999993, 8409.95795021024, 8717.433366831152, 8725.171108744675, 8822.558872056403, 8843.602037908293, 2295.150794206146, 2326.1625814706777, 2329.6272596384583, 2331.230693871027, 2334.0897050150456, 2099.517111064456, 2200.656301039396, 2301.102569997702, 2302.1366987379733, 2338.2751347082376, 2265.728112626479, 2291.919782807602, 2297.1270917051497, 2311.861288322706, 2328.1618617297845, 2282.132789539981, 2287.5653625811124, 2292.381057114578, 2297.276357947258, 2301.217586020761, 2275.5562665280277, 2282.9771702283097, 2291.7822806833324, 2292.7592602776804, 2298.5632729781287, 8834.779130521723, 8851.07063758309, 8930.776730581723, 8936.597853096626, 8939.68711095115, 5181.222816577506, 5265.341832270966, 5344.866378340534, 5355.437679043684, 5362.410134885159, 3395.3548825723033, 3463.0822831949554, 3528.700060494861, 3582.9641703582893, 3593.568771747407, 1039.2102002478096, 1040.3497813866334, 1041.2034793383068, 1044.2429238801883, 1058.6083149234832, 11464.19750617457, 11524.366159861203, 11670.824937625857, 11702.707432314175, 11721.355325457096, 4020.4572382728543, 4042.7372220805555, 4063.512378514597, 4540.500544940054, 4763.071201115818, 9986.300958932805, 10023.69928902134, 10028.44843533598, 10033.648822291185, 10034.09693127622, 5325.866853328698, 5337.973310133424, 5342.1452567589, 5345.305110335631, 5345.33183352081, 4369.497507786582, 4525.932111018337, 4798.760061996886, 4858.02839432115, 4904.485029071968, 3791.7724936503896, 3884.0484081400236, 3973.48344715191, 3979.2041591681777, 4018.8392464301687, 1273.5669872243298, 1281.071223363073, 1284.4348486665838, 1289.335991964139, 1293.2886912198253, 812.6586833529932, 896.0994200828126, 913.5980168725739, 918.3617385916857, 939.7039932421266, 5304.549113325334, 5622.0161471742285, 5802.709864506758, 5930.813837232571, 6044.123602077674, 413.05822724188897, 414.55228353378277, 423.9830406783756, 432.5739146940324, 433.231014948469, 3063.417950589381, 3920.157166209279, 3987.720859539804, 4002.639762421396, 4052.8986775330854, 9921.25590580695, 10666.253362264722, 10750.301230419998, 10789.83815242772, 10808.351498910091, 10640.0, 10760.031597156294, 10764.461776911123, 10771.138308935266, 10777.46112694378, 7654.578998155043, 7912.683492660229, 7994.68021279154, 8008.439409241297, 8105.108438071689, 4912.48418916023, 5957.136215248851, 6004.0880173116875, 6018.976773948351, 6141.631502109888, 8608.010078841013, 9202.35583509148, 9686.32195746291, 9938.45338506389, 10063.0, 9776.0, 10045.246606504395, 10072.740907386577, 10140.087392134743, 10225.693229203136, 7000.334968178015, 7201.13586369639, 7506.549607023596, 7694.499857509468, 7860.449768516149, 8184.959075204586, 8350.206730360605, 8363.247307742333, 8431.15688431152, 8449.11284315138, 7290.817729556804, 7412.62936853166, 7426.2945020223, 7446.627668616656, 7508.774736757906, 7096.112985876765, 7255.274472552914, 7258.165310989304, 7317.414606831547, 7344.265573442826, 6932.61870597122, 6964.860702786017, 7061.329173728487, 7066.293370662893, 7067.71729130829, 4012.67898568108, 4812.542808433193, 4911.091448082117, 4925.0, 5021.623378246573, 4654.301854721819, 4867.61059115277, 4954.256861470808, 4972.105021096238, 5020.723860187724], "value": 4435.12422403771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.7526240326923, 301.874721990374, 302.6700896023334, 308.8749056632064, 312.96096958099105, 4720.5515476029805, 5418.862038971811, 5507.201455788908, 5571.080771672674, 5585.553155747541, 4186.513787605402, 4341.544137865526, 4383.671224658147, 4739.289106634006, 5387.164989426645, 3729.160938788778, 4108.691848111389, 4140.047789008529, 4157.729747566414, 4169.499660040784, 3957.2085582883537, 4144.730592511492, 4145.844161036274, 4158.8960275993195, 4163.938195760092, 3277.738070842731, 3719.8140092995377, 3969.7249768940596, 4078.3066878630702, 4165.541790403053, 3440.7591468597207, 4138.627523522882, 4147.979260103695, 4151.709380343347, 4158.480189976253, 3624.637536246354, 3624.691901188402, 3644.7084233261276, 3646.6353364663587, 3664.9450258246147, 4285.014446677251, 5098.5411312982005, 5133.922991155136, 5177.896442071175, 5299.390570084451, 4716.669833111683, 4770.16522108633, 4772.498887616785, 4798.232282834764, 4827.806887724487, 4976.054549635558, 5377.946220537784, 5700.401457846908, 5769.278840144982, 5821.563382746269, 3861.5559210690567, 3873.1479074603544, 3912.15888583953, 3915.6671682906986, 4009.4186342980106, 5022.4726403727445, 5101.489851014869, 5547.0, 6001.739634676679, 6130.325664176937, 3494.3186078714916, 4092.1406504633765, 4097.684808083423, 4112.321466957918, 4115.54728979812, 3820.178661587772, 4063.2482990646827, 4175.498940127204, 4192.979035104866, 4194.559571245037, 4347.7173983690955, 4442.933355999663, 4535.63714902807, 4703.2004559225015, 4725.220338644154, 4585.541445855454, 5015.749212539358, 5506.182959623315, 5672.695280085603, 5785.50823180026, 1255.610760664197, 1351.1555277951281, 1371.136184203945, 1392.5195807446414, 1400.649837540615, 935.209747763139, 945.9858102128474, 961.4519723757392, 968.6464440479174, 973.8490533967247, 4677.3451716759, 4901.436334821541, 5368.4631536846, 5370.946290537123, 5423.610243597752, 5427.9185812212845, 5830.3586605473365, 5888.970555147197, 5911.812629327091, 5914.852128696731, 4424.402705634762, 4925.458199598042, 4949.727764972889, 5001.374828146481, 5263.421023687391, 2132.882691451985, 2420.7458216887326, 2478.467129567152, 2563.8205325627027, 2592.468543948486, 4231.153769246163, 4575.99328147807, 4625.7455839929125, 5052.141136006888, 5063.392392912874, 3612.8554857805393, 3948.072203032285, 4241.512226094039, 4963.776630051656, 5033.874153146201, 4312.849050283287, 4479.955200447954, 4638.7216766993415, 4885.316055752198, 4955.166588362257, 4303.762043737302, 4327.468430967793, 4600.608948239437, 4791.664583479123, 4893.877653058702, 3834.6033728919424, 4124.298869192185, 4625.444946606429, 4636.489986101458, 4786.880327991688, 5458.808941687022, 5635.872825434847, 6137.815865524041, 6205.47253483459, 6233.283172435046, 3522.753407261467, 3895.376739721631, 3928.2929072767174, 3964.9603503965745, 3966.6826653867042, 4749.430068391677, 5582.804601838916, 5951.523878089829, 5958.612690175125, 5993.340732519332, 5647.661140331593, 5691.4104082643125, 5720.971395143164, 5722.74247658848, 5723.5707321950185, 4790.520947905182, 5009.899802003866, 5127.15422447911, 5648.1592517088775, 5767.798127065533, 4736.5973892219545, 5301.9469805303, 5530.944690553043, 5659.349174844946, 5676.829695109153, 4965.652404331807, 5473.343198816167, 5727.198192253005, 5752.223449834386, 5774.566907481872, 4776.972950815452, 5463.344398672185, 5621.943780562142, 5631.915521267266, 5676.574256930664], "value": 3994.133366469931, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.4962851561133, 706.6078326528774, 728.2971932085536, 729.2415887477024, 763.5380594740178, 14394.568162955102, 15189.31648075835, 15189.848101518981, 15193.696126077471, 15243.31405086771, 14291.356888939996, 14390.208538530376, 14392.71214575708, 14394.928025359884, 14411.63970900728, 632.2665707778978, 663.3896814930275, 686.831726227075, 820.0774129104757, 842.6292431330195, 710.7050574011805, 856.2721686566431, 857.1685465098844, 857.1942374168293, 857.661223816592, 889.89321281446, 901.7520181949983, 904.1139683110556, 906.1799071839962, 908.1327332397544, 890.2343984173606, 890.9509976951265, 901.9594118264694, 904.900460949295, 906.5014242166782, 576.1616847486896, 659.0608383054129, 663.0849427789667, 663.9236487803917, 665.6139439125295, 13595.592132236048, 13663.658408539766, 13824.930875345659, 13967.860321396758, 14108.717825643533, 11405.600803971822, 14399.928000360036, 14415.135091894415, 14493.0, 14525.564233073024, 11717.53129874804, 11779.823302650468, 11884.643460696192, 11919.880801191965, 12178.269303841798, 3249.5938007749032, 3818.6754125899333, 3848.576656567803, 3892.6496615304477, 4006.9198616027516, 94877.5256123715, 96852.54721179188, 104439.47780261126, 106229.0, 106571.0, 10977.231593788518, 11141.72145696364, 11197.94401028006, 11419.0, 11646.70883227926, 19054.713434387686, 22024.88987555084, 22593.548129037328, 22989.7701022991, 23043.423914401938, 7443.516171448839, 7451.627418629047, 7484.476086673881, 7525.736599219001, 7648.464607477423, 4072.3687828386646, 4209.326507758744, 4259.872203833828, 4324.156789426094, 4399.736015838996, 3585.94621080684, 3671.430928206132, 3693.353663108945, 3701.0192299040777, 3702.6667599916136, 649.6426965169138, 662.1326062857576, 662.8574856405896, 669.4376723552142, 676.7597502886503, 589.2693060604905, 615.9199304090529, 659.7427003468651, 664.7839452178061, 668.5286872754793, 9220.815583688423, 9311.534423278945, 9344.205742511827, 9466.95266523663, 9478.810423791485, 531.7819693925472, 603.746426500862, 632.250782822357, 632.658364483174, 647.2944490505372, 4055.1889622075705, 4096.815643296059, 4124.989377602446, 4227.598378154071, 4238.554951730086, 105634.47182764037, 147987.26006370113, 148610.0, 152667.0, 155615.22192388965, 128355.0, 131358.0, 131422.0, 132503.33748331197, 134999.0, 70460.2953970464, 70668.93996590056, 102259.4887025575, 107090.9290907081, 109441.90558094476, 7631.771046868603, 8232.753017409488, 8437.282830959191, 8522.531260780717, 8552.401331906707, 39939.80030099831, 42907.0, 44645.33032004457, 62344.06483902836, 65239.673801630684, 80977.0, 83305.0, 85326.1467385343, 91109.54445227732, 91126.54436727773, 11204.0, 13079.803802943154, 13284.960356418442, 13721.862781372458, 13975.510857119953, 13080.869191307966, 14660.70678586401, 14854.40582376736, 15235.3905843765, 15725.685486289982, 11612.361320127136, 13711.0, 13809.309534523032, 13926.721465570834, 14393.856061439252, 13588.369395672582, 13610.86389136096, 13861.0, 13933.790993135313, 14123.0, 13362.064655474023, 13403.0, 13594.592162235149, 13842.792358114837, 14049.705644581201, 11226.326420414802, 11400.315981041163, 11402.600908968147, 11408.0, 11534.653960381202, 7450.515716478411, 10482.580696772044, 10810.567577297135, 11035.510206122392, 11106.278091924], "value": 7574.916058432523, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1643.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 120.0, 118.0, 118.0, 120.0, 120.0, 106.0, 148.0, 175.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 123.0, 186.0, 148.0, 138.0, 118.0, 116.0, 162.0, 116.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 235.0, 254.0, 196.0, 197.0, 203.0, 196.0, 198.0, 196.0, 226.0], "value": 210.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 83.0, 62.0, 49.0, 62.0, 70.0, 103.0, 82.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 102.0, 121.0, 103.0, 57.0, 79.0, 125.0, 101.0, 101.0, 100.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 90.0, 111.0, 84.0, 131.0, 135.0, 120.0, 93.0, 89.0], "value": 112.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 121.0, 171.0, 107.0, 112.0, 170.0, 110.0, 112.0, 100.0, 102.0], "value": 120.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 131.0, 146.0, 138.0, 91.0, 77.0, 150.0, 122.0, 133.0, 92.0], "value": 115.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 58.0, 56.0, 63.0, 76.0, 87.0, 86.0, 87.0, 71.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 70.0, 79.0, 72.0, 68.0, 60.0, 87.0, 63.0, 67.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 92.0, 90.0, 102.0, 77.0, 78.0, 83.0, 77.0, 109.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 165.0, 162.0, 162.0, 148.0, 148.0, 161.0, 158.0, 193.0, 164.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 176.0, 171.0, 172.0, 172.0, 175.0, 176.0, 217.0, 204.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 85.0, 87.0, 92.0, 90.0, 85.0, 70.0, 70.0, 67.0, 86.0], "value": 80.0, "unit": "score"}]}]} 14:16:14 INFO - Return code: 0 14:16:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:14 ERROR - # TBPL SUCCESS # 14:16:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:14 INFO - 2016-10-26 14:16:14.236 screenresolution[1677:10757] starting screenresolution argv=screenresolution get 14:16:14 INFO - 2016-10-26 14:16:14.239 screenresolution[1677:10757] Display 0: 1600x1200x32@60 14:16:14 INFO - 2016-10-26 14:16:14.245 screenresolution[1678:10760] starting screenresolution argv=screenresolution list 14:16:14 INFO - Available Modes on Display 0 14:16:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:14 INFO - Intel Iris: 14:16:14 INFO - Chipset Model: Intel Iris 14:16:14 INFO - Type: GPU 14:16:14 INFO - Bus: Built-In 14:16:14 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:14 INFO - Vendor: Intel (0x8086) 14:16:14 INFO - Device ID: 0x0a2e 14:16:14 INFO - Revision ID: 0x0009 14:16:14 INFO - Displays: 14:16:14 INFO - Display: 14:16:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:14 INFO - Display Serial Number: 1600x1200 60 14:16:14 INFO - Main Display: Yes 14:16:14 INFO - Mirror: Off 14:16:14 INFO - Online: Yes 14:16:14 INFO - Rotation: Supported 14:16:14 INFO - Return code: 0 14:16:14 INFO - Running post-action listener: _resource_record_post_action 14:16:14 INFO - [mozharness: 2016-10-26 21:16:14.481487Z] Finished run-tests step (success) 14:16:14 INFO - Running post-run listener: _resource_record_post_run 14:16:14 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 37251584; Write bytes: 712360960; Read time: 240; Write time: 2019 14:16:14 INFO - TinderboxPrint: CPU usage
54.5% 14:16:14 INFO - TinderboxPrint: I/O read bytes / time
37,251,584 / 240 14:16:14 INFO - TinderboxPrint: I/O write bytes / time
712,360,960 / 2,019 14:16:14 INFO - TinderboxPrint: CPU idle
2,205.0 (45.5%) 14:16:14 INFO - TinderboxPrint: CPU system
982.8 (20.3%) 14:16:14 INFO - TinderboxPrint: CPU user
1,661.9 (34.3%) 14:16:14 INFO - TinderboxPrint: Swap in / out
444,755,968 / 0 14:16:14 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413673984; Write bytes: 408430080; Read time: 30809; Write time: 854 14:16:14 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 29786624; Write bytes: 300244480; Read time: 174; Write time: 1151 14:16:14 INFO - Running post-run listener: _upload_blobber_files 14:16:14 INFO - Blob upload gear active. 14:16:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:14 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 14:16:14 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'] 14:16:14 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 14:16:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:16 INFO - (blobuploader) - INFO - Done attempting. 14:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:17 INFO - (blobuploader) - INFO - Done attempting. 14:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:19 INFO - (blobuploader) - INFO - Done attempting. 14:16:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:20 INFO - Return code: 0 14:16:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2a6c10816adb7af0355cfa8851be094b478cd93e6161f941e585c12d1cd962593178d0c3adb5b552baf85eef7c8c9528f6cea98002c78994886bdebb612a577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e150db69479c60fe2066eb9b63c254d5be611a8bd8d003de3723bc1a0c0f3f2fb3b82b40814a052520c32bbe466c681344e9e51d075ce98b1a0a7a66eec219a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7470893920dc3d848969968a0e365760b2a69a0f7dd7622c0b5cfe9466bbefb3361224a8ca76a3220770706e8f076b0b726dea34f08c4c8b764c42cb7537d"} 14:16:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:20 INFO - Contents: 14:16:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2a6c10816adb7af0355cfa8851be094b478cd93e6161f941e585c12d1cd962593178d0c3adb5b552baf85eef7c8c9528f6cea98002c78994886bdebb612a577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e150db69479c60fe2066eb9b63c254d5be611a8bd8d003de3723bc1a0c0f3f2fb3b82b40814a052520c32bbe466c681344e9e51d075ce98b1a0a7a66eec219a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7470893920dc3d848969968a0e365760b2a69a0f7dd7622c0b5cfe9466bbefb3361224a8ca76a3220770706e8f076b0b726dea34f08c4c8b764c42cb7537d"} 14:16:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:20 INFO - Copying logs to upload dir... 14:16:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.837953 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-10-26 14:16:20.081279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.089097) ========= 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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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/c2a6c10816adb7af0355cfa8851be094b478cd93e6161f941e585c12d1cd962593178d0c3adb5b552baf85eef7c8c9528f6cea98002c78994886bdebb612a577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e150db69479c60fe2066eb9b63c254d5be611a8bd8d003de3723bc1a0c0f3f2fb3b82b40814a052520c32bbe466c681344e9e51d075ce98b1a0a7a66eec219a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7470893920dc3d848969968a0e365760b2a69a0f7dd7622c0b5cfe9466bbefb3361224a8ca76a3220770706e8f076b0b726dea34f08c4c8b764c42cb7537d"} build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2a6c10816adb7af0355cfa8851be094b478cd93e6161f941e585c12d1cd962593178d0c3adb5b552baf85eef7c8c9528f6cea98002c78994886bdebb612a577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e150db69479c60fe2066eb9b63c254d5be611a8bd8d003de3723bc1a0c0f3f2fb3b82b40814a052520c32bbe466c681344e9e51d075ce98b1a0a7a66eec219a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7470893920dc3d848969968a0e365760b2a69a0f7dd7622c0b5cfe9466bbefb3361224a8ca76a3220770706e8f076b0b726dea34f08c4c8b764c42cb7537d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.124904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.125256) ========= 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.J8vU5iyI6w/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.67Rp4ntsSq/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.005071 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.174517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:20.177850) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:20.178210) ========= ========= Total master_lag: 0.20 =========