builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0142 starttime: 1477515301.8 results: success (0) buildid: 20161011025846 builduid: 5120a331d5884b248fd298482f4fffa2 revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.804458) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.804887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.805167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.828842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.829483) ========= 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.qu8VMuboe4/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.fLjqzH38fW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:55:01-- 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% 161M=0s 2016-10-26 13:55:01 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.954708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:01.955245) ========= 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.qu8VMuboe4/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.fLjqzH38fW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.019843 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:02.004973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:55:02.005373) ========= 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.qu8VMuboe4/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.fLjqzH38fW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:55:02,077 truncating revision to first 12 chars 2016-10-26 13:55:02,077 Setting DEBUG logging. 2016-10-26 13:55:02,077 attempt 1/10 2016-10-26 13:55:02,077 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:55:02,998 unpacking tar archive at: mozilla-central-45052ddb03a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.192120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:55:03.218927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:03.219245) ========= script_repo_revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:03.219633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:03.219911) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:55:03.237824) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 13:55:03.238137) ========= /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.qu8VMuboe4/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.fLjqzH38fW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:03 INFO - MultiFileLogger online at 20161026 13:55:03 in /builds/slave/test 13:55:03 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:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:03 INFO - {'append_to_log': False, 13:55:03 INFO - 'base_work_dir': '/builds/slave/test', 13:55:03 INFO - 'blob_upload_branch': 'Firefox', 13:55:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:03 INFO - 'branch': 'Firefox', 13:55:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:03 INFO - 'config_files': ('talos/mac_config.py',), 13:55:03 INFO - 'default_actions': ('clobber', 13:55:03 INFO - 'read-buildbot-config', 13:55:03 INFO - 'download-and-extract', 13:55:03 INFO - 'populate-webroot', 13:55:03 INFO - 'create-virtualenv', 13:55:03 INFO - 'install', 13:55:03 INFO - 'run-tests'), 13:55:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:03 INFO - 'download_minidump_stackwalk': True, 13:55:03 INFO - 'download_symbols': 'ondemand', 13:55:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:03 INFO - 'installer_path': 'installer.exe', 13:55:03 INFO - 'log_level': 'info', 13:55:03 INFO - 'log_name': 'talos', 13:55:03 INFO - 'log_to_console': True, 13:55:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:55:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:55:03 INFO - 'opt_config_files': (), 13:55:03 INFO - 'pip_index': False, 13:55:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:03 INFO - 'cmd': ('bash', 13:55:03 INFO - '-c', 13:55:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:03 INFO - 'enabled': True, 13:55:03 INFO - 'halt_on_failure': False, 13:55:03 INFO - 'name': 'check_screen_resolution'},), 13:55:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:03 INFO - 'cmd': ('bash', 13:55:03 INFO - '-c', 13:55:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:03 INFO - 'enabled': True, 13:55:03 INFO - 'halt_on_failure': False, 13:55:03 INFO - 'name': 'check_screen_resolution'},), 13:55:03 INFO - 'run_cmd_checks_enabled': True, 13:55:03 INFO - 'sps_profile': False, 13:55:03 INFO - 'sps_profile_interval': 0, 13:55:03 INFO - 'suite': 'dromaeojs-e10s', 13:55:03 INFO - 'system_bits': '32', 13:55:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:03 INFO - 'title': 't-yosemite-r7-0142', 13:55:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:03 INFO - 'use_talos_json': True, 13:55:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:03 INFO - 'work_dir': 'build'} 13:55:03 INFO - [mozharness: 2016-10-26 20:55:03.433284Z] Running clobber step. 13:55:03 INFO - Running pre-action listener: _resource_record_pre_action 13:55:03 INFO - Running main action method: clobber 13:55:03 INFO - rmtree: /builds/slave/test/build 13:55:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:04 INFO - Running post-action listener: _resource_record_post_action 13:55:04 INFO - [mozharness: 2016-10-26 20:55:04.349341Z] Finished clobber step (success) 13:55:04 INFO - [mozharness: 2016-10-26 20:55:04.349501Z] Running read-buildbot-config step. 13:55:04 INFO - Running pre-action listener: _resource_record_pre_action 13:55:04 INFO - Running main action method: read_buildbot_config 13:55:04 INFO - Using buildbot properties: 13:55:04 INFO - { 13:55:04 INFO - "project": "", 13:55:04 INFO - "product": "firefox", 13:55:04 INFO - "script_repo_revision": "production", 13:55:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:55:04 INFO - "repository": "", 13:55:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:55:04 INFO - "buildid": "20161011025846", 13:55:04 INFO - "pgo_build": "False", 13:55:04 INFO - "basedir": "/builds/slave/test", 13:55:04 INFO - "buildnumber": 34, 13:55:04 INFO - "slavename": "t-yosemite-r7-0142", 13:55:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:55:04 INFO - "platform": "yosemite_r7", 13:55:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:55:04 INFO - "branch": "mozilla-central", 13:55:04 INFO - "repo_path": "mozilla-central", 13:55:04 INFO - "revision": "45052ddb03a448606ca6ce33f4893a559edebf72", 13:55:04 INFO - "stage_platform": "macosx64", 13:55:04 INFO - "builduid": "5120a331d5884b248fd298482f4fffa2", 13:55:04 INFO - "slavebuilddir": "test" 13:55:04 INFO - } 13:55:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:55:04 INFO - Running post-action listener: _resource_record_post_action 13:55:04 INFO - [mozharness: 2016-10-26 20:55:04.352897Z] Finished read-buildbot-config step (success) 13:55:04 INFO - [mozharness: 2016-10-26 20:55:04.353020Z] Running download-and-extract step. 13:55:04 INFO - Running pre-action listener: _resource_record_pre_action 13:55:04 INFO - Running main action method: download_and_extract 13:55:04 INFO - mkdir: /builds/slave/test/build/tests 13:55:04 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:04 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:55:04 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:04 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:09 INFO - Downloaded 1199 bytes. 13:55:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:55:09 INFO - Using the following test package requirements: 13:55:09 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:55:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:55:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:55:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'jsshell-mac.zip'], 13:55:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:55:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:55:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:55:09 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:55:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:55:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:09 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:55:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:55:09 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:09 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:09 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:10 INFO - Http code: 200 13:55:10 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 13:55:10 INFO - x-amz-cf-id: mXul51MXKPdsTeP3dALyxPV3dWQSafcxqHBnPb-F4cnaUd5G5x93iQ== 13:55:10 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:11 INFO - Expected file size: 16508481 13:55:11 INFO - Obtained file size: 16508481 13:55:18 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:18 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:18 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:18 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:18 INFO - Http code: 200 13:55:18 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 13:55:18 INFO - x-amz-cf-id: mEqUziBWyk2Gyz7FviaAafe8IhejXP4tYAv6BQHDruBXL4CPILV3Lw== 13:55:18 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:19 INFO - Expected file size: 16508481 13:55:19 INFO - Obtained file size: 16508481 13:55:25 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:25 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:25 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:25 INFO - Http code: 200 13:55:25 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 13:55:25 INFO - x-amz-cf-id: y8QNakVlSKmDToq6NQ5KWMWEqWl_gcUO5ElyYES7f2j6ImQ1iu2KWw== 13:55:25 INFO - x-amz-version-id: h7oaKNhRQzyZtP5vdBlaq4n0FwksjilO 13:55:26 INFO - Expected file size: 14409006 13:55:26 INFO - Obtained file size: 14409006 13:55:26 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:26 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:26 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:26 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:29 INFO - Downloaded 111738529 bytes. 13:55:29 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:29 INFO - mkdir: /builds/slave/test/properties 13:55:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:29 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:29 INFO - Contents: 13:55:29 INFO - build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:30 INFO - Running post-action listener: _resource_record_post_action 13:55:30 INFO - Running post-action listener: set_extra_try_arguments 13:55:30 INFO - [mozharness: 2016-10-26 20:55:30.510838Z] Finished download-and-extract step (success) 13:55:30 INFO - [mozharness: 2016-10-26 20:55:30.510969Z] Running populate-webroot step. 13:55:30 INFO - Running pre-action listener: _resource_record_pre_action 13:55:30 INFO - Running main action method: populate_webroot 13:55:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:30 INFO - '--tppagecycles', 13:55:30 INFO - '7'], 13:55:30 INFO - 'tests': ['tsvgm']}}, 13:55:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['damp', 'tps']}, 13:55:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'tests': ['damp', 'tps']}, 13:55:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['dromaeo_dom']}, 13:55:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['basic_compositor_video']}, 13:55:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:55:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['a11yr', 13:55:30 INFO - 'ts_paint', 13:55:30 INFO - 'tpaint', 13:55:30 INFO - 'sessionrestore', 13:55:30 INFO - 'sessionrestore_no_auto_restore', 13:55:30 INFO - 'tabpaint']}, 13:55:30 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:30 INFO - 'ts_paint', 13:55:30 INFO - 'tpaint', 13:55:30 INFO - 'sessionrestore', 13:55:30 INFO - 'sessionrestore_no_auto_restore', 13:55:30 INFO - 'tabpaint']}, 13:55:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:30 INFO - 'ts_paint', 13:55:30 INFO - 'tpaint', 13:55:30 INFO - 'sessionrestore', 13:55:30 INFO - 'sessionrestore_no_auto_restore', 13:55:30 INFO - 'tabpaint']}, 13:55:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:30 INFO - 'ts_paint', 13:55:30 INFO - 'tpaint', 13:55:30 INFO - 'sessionrestore', 13:55:30 INFO - 'sessionrestore_no_auto_restore', 13:55:30 INFO - 'tabpaint']}, 13:55:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['a11yr', 13:55:30 INFO - 'ts_paint', 13:55:30 INFO - 'tpaint', 13:55:30 INFO - 'sessionrestore', 13:55:30 INFO - 'sessionrestore_no_auto_restore', 13:55:30 INFO - 'tabpaint']}, 13:55:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['a11yr', 13:55:30 INFO - 'ts_paint', 13:55:30 INFO - 'tpaint', 13:55:30 INFO - 'sessionrestore', 13:55:30 INFO - 'sessionrestore_no_auto_restore', 13:55:30 INFO - 'tabpaint']}, 13:55:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['tsvgx', 13:55:30 INFO - 'tsvgr_opacity', 13:55:30 INFO - 'tart', 13:55:30 INFO - 'tscrollx', 13:55:30 INFO - 'cart']}, 13:55:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:30 INFO - 'tsvgr_opacity', 13:55:30 INFO - 'tart', 13:55:30 INFO - 'tscrollx', 13:55:30 INFO - 'cart']}, 13:55:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'talos_options': ['--disable-e10s'], 13:55:30 INFO - 'tests': ['tp5o']}, 13:55:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'tests': ['tp5o']}, 13:55:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'talos_options': ['--disable-e10s', 13:55:30 INFO - '--xperf_path', 13:55:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:30 INFO - 'tests': ['tp5n']}, 13:55:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:30 INFO - 'talos_options': ['--xperf_path', 13:55:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:30 INFO - 'tests': ['tp5n']}}, 13:55:30 INFO - 'talos.zip': {'path': '', 13:55:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:30 INFO - Running post-action listener: _resource_record_post_action 13:55:30 INFO - [mozharness: 2016-10-26 20:55:30.529593Z] Finished populate-webroot step (success) 13:55:30 INFO - [mozharness: 2016-10-26 20:55:30.529722Z] Running create-virtualenv step. 13:55:30 INFO - Running pre-action listener: _resource_record_pre_action 13:55:30 INFO - Running main action method: create_virtualenv 13:55:30 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:30 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:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:30 INFO - Using real prefix '/tools/python27' 13:55:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:31 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:34 INFO - Installing pip.................done. 13:55:34 INFO - Return code: 0 13:55:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:55:34 INFO - Reading from file tmpfile_stdout 13:55:34 INFO - Output received: 13:55:34 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:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:34 INFO - 'HOME': '/Users/cltbld', 13:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:34 INFO - 'LOGNAME': 'cltbld', 13:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:34 INFO - 'MOZ_NO_REMOTE': '1', 13:55:34 INFO - 'NO_EM_RESTART': '1', 13:55:34 INFO - 'PAGER': '/bin/cat', 13:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:34 INFO - 'PWD': '/builds/slave/test', 13:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:34 INFO - 'SHELL': '/bin/bash', 13:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:34 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:34 INFO - 'USER': 'cltbld', 13:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:34 INFO - 'XPC_FLAGS': '0x0', 13:55:34 INFO - 'XPC_SERVICE_NAME': '0', 13:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:34 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:34 INFO - Cleaning up... 13:55:34 INFO - Return code: 0 13:55:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:34 INFO - 'HOME': '/Users/cltbld', 13:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:34 INFO - 'LOGNAME': 'cltbld', 13:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:34 INFO - 'MOZ_NO_REMOTE': '1', 13:55:34 INFO - 'NO_EM_RESTART': '1', 13:55:34 INFO - 'PAGER': '/bin/cat', 13:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:34 INFO - 'PWD': '/builds/slave/test', 13:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:34 INFO - 'SHELL': '/bin/bash', 13:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:34 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:34 INFO - 'USER': 'cltbld', 13:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:34 INFO - 'XPC_FLAGS': '0x0', 13:55:34 INFO - 'XPC_SERVICE_NAME': '0', 13:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:34 INFO - Downloading/unpacking psutil>=3.1.1 13:55:34 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:34 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:34 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:34 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:34 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:34 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:38 INFO - Installing collected packages: psutil 13:55:38 INFO - Running setup.py install for psutil 13:55:38 INFO - building 'psutil._psutil_osx' extension 13:55:38 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:38 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:38 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:39 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:39 INFO - building 'psutil._psutil_posix' extension 13:55:39 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:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:55:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:55:39 INFO - ^ 13:55:39 INFO - 1 warning generated. 13:55:39 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:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:39 INFO - Successfully installed psutil 13:55:39 INFO - Cleaning up... 13:55:39 INFO - Return code: 0 13:55:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:39 INFO - 'HOME': '/Users/cltbld', 13:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:39 INFO - 'LOGNAME': 'cltbld', 13:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:39 INFO - 'MOZ_NO_REMOTE': '1', 13:55:39 INFO - 'NO_EM_RESTART': '1', 13:55:39 INFO - 'PAGER': '/bin/cat', 13:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:39 INFO - 'PWD': '/builds/slave/test', 13:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:39 INFO - 'SHELL': '/bin/bash', 13:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:39 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:39 INFO - 'USER': 'cltbld', 13:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:39 INFO - 'XPC_FLAGS': '0x0', 13:55:39 INFO - 'XPC_SERVICE_NAME': '0', 13:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:39 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:39 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:39 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:39 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:39 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:39 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:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:42 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:42 INFO - Installing collected packages: mozsystemmonitor 13:55:42 INFO - Running setup.py install for mozsystemmonitor 13:55:42 INFO - Successfully installed mozsystemmonitor 13:55:42 INFO - Cleaning up... 13:55:42 INFO - Return code: 0 13:55:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:42 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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:42 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:42 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:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:42 INFO - 'HOME': '/Users/cltbld', 13:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:42 INFO - 'LOGNAME': 'cltbld', 13:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:42 INFO - 'MOZ_NO_REMOTE': '1', 13:55:42 INFO - 'NO_EM_RESTART': '1', 13:55:42 INFO - 'PAGER': '/bin/cat', 13:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:42 INFO - 'PWD': '/builds/slave/test', 13:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:42 INFO - 'SHELL': '/bin/bash', 13:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:42 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:42 INFO - 'USER': 'cltbld', 13:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:42 INFO - 'XPC_FLAGS': '0x0', 13:55:42 INFO - 'XPC_SERVICE_NAME': '0', 13:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:42 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:42 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:42 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:42 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:42 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:42 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:42 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:45 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:45 INFO - warning: no files found matching '*.txt' 13:55:45 INFO - no previously-included directories found matching 'build' 13:55:45 INFO - no previously-included directories found matching 'dist' 13:55:45 INFO - no previously-included directories found matching '.git*' 13:55:45 INFO - Installing collected packages: jsonschema, functools32 13:55:45 INFO - Running setup.py install for functools32 13:55:45 INFO - warning: no files found matching '*.txt' 13:55:45 INFO - no previously-included directories found matching 'build' 13:55:45 INFO - no previously-included directories found matching 'dist' 13:55:45 INFO - no previously-included directories found matching '.git*' 13:55:45 INFO - Successfully installed jsonschema functools32 13:55:45 INFO - Cleaning up... 13:55:46 INFO - Return code: 0 13:55:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:55:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:46 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:46 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:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:46 INFO - 'HOME': '/Users/cltbld', 13:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:46 INFO - 'LOGNAME': 'cltbld', 13:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:46 INFO - 'MOZ_NO_REMOTE': '1', 13:55:46 INFO - 'NO_EM_RESTART': '1', 13:55:46 INFO - 'PAGER': '/bin/cat', 13:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:46 INFO - 'PWD': '/builds/slave/test', 13:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:46 INFO - 'SHELL': '/bin/bash', 13:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:46 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:46 INFO - 'USER': 'cltbld', 13:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:46 INFO - 'XPC_FLAGS': '0x0', 13:55:46 INFO - 'XPC_SERVICE_NAME': '0', 13:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:55:46 INFO - Cleaning up... 13:55:46 INFO - Return code: 0 13:55:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:46 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:46 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:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:46 INFO - 'HOME': '/Users/cltbld', 13:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:46 INFO - 'LOGNAME': 'cltbld', 13:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:46 INFO - 'MOZ_NO_REMOTE': '1', 13:55:46 INFO - 'NO_EM_RESTART': '1', 13:55:46 INFO - 'PAGER': '/bin/cat', 13:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:46 INFO - 'PWD': '/builds/slave/test', 13:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:46 INFO - 'SHELL': '/bin/bash', 13:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:46 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:46 INFO - 'USER': 'cltbld', 13:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:46 INFO - 'XPC_FLAGS': '0x0', 13:55:46 INFO - 'XPC_SERVICE_NAME': '0', 13:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:46 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:48 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55:49 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:49 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:49 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:49 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:49 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:49 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:50 INFO - Downloading docopt-0.6.1.tar.gz 13:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:50 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:50 INFO - Running setup.py install for blobuploader 13:55:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:50 INFO - Running setup.py install for requests 13:55:50 INFO - Running setup.py install for docopt 13:55:51 INFO - Successfully installed blobuploader requests docopt 13:55:51 INFO - Cleaning up... 13:55:51 INFO - Return code: 0 13:55:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:51 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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:51 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:51 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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:51 INFO - 'HOME': '/Users/cltbld', 13:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:51 INFO - 'LOGNAME': 'cltbld', 13:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:51 INFO - 'MOZ_NO_REMOTE': '1', 13:55:51 INFO - 'NO_EM_RESTART': '1', 13:55:51 INFO - 'PAGER': '/bin/cat', 13:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:51 INFO - 'PWD': '/builds/slave/test', 13:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:51 INFO - 'SHELL': '/bin/bash', 13:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:55:51 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:51 INFO - 'USER': 'cltbld', 13:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:51 INFO - 'XPC_FLAGS': '0x0', 13:55:51 INFO - 'XPC_SERVICE_NAME': '0', 13:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:51 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-x0JKdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:51 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-bwrfM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:51 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-BnzhWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:51 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-rNYhk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:51 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-qfciEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:51 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-a3Hkzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-o8gmzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-izSHIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-REE2mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ZJCkqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-xfCvCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-F90Laq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-LA1E8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-7NcfLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-6s4eJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:52 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-v8K2Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:53 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-xsr__t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:53 INFO - Running setup.py install for manifestparser 13:55:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozcrash 13:55:53 INFO - Running setup.py install for mozdebug 13:55:53 INFO - Running setup.py install for mozdevice 13:55:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozfile 13:55:53 INFO - Running setup.py install for mozhttpd 13:55:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozinfo 13:55:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozInstall 13:55:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozleak 13:55:54 INFO - Running setup.py install for mozlog 13:55:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for moznetwork 13:55:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozprocess 13:55:54 INFO - Running setup.py install for mozprofile 13:55:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozrunner 13:55:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozscreenshot 13:55:55 INFO - Running setup.py install for moztest 13:55:55 INFO - Running setup.py install for mozversion 13:55:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:55 INFO - Cleaning up... 13:55:55 INFO - Return code: 0 13:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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.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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 13:55:55 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:56 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-dmsHSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:56 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-STzAtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:56 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-0L1j_Z-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-QmQQ3s-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-WB4KH3-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-1DQGnw-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Nx24BG-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-KkIugp-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-iKz66C-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Ip2tLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:57 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-2LolIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:57 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:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:57 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-i0DcOL-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-8z51pl-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-6LX6FJ-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ujeeMI-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-qP1rx4-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/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-oxjWyQ-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 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 13:56:01 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10277e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f005c78a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qu8VMuboe4/Render', 13:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:02 INFO - 'HOME': '/Users/cltbld', 13:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:02 INFO - 'LOGNAME': 'cltbld', 13:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:02 INFO - 'MOZ_NO_REMOTE': '1', 13:56:02 INFO - 'NO_EM_RESTART': '1', 13:56:02 INFO - 'PAGER': '/bin/cat', 13:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:02 INFO - 'PWD': '/builds/slave/test', 13:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:02 INFO - 'SHELL': '/bin/bash', 13:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fLjqzH38fW/Listeners', 13:56:02 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 13:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:02 INFO - 'USER': 'cltbld', 13:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:02 INFO - 'XPC_FLAGS': '0x0', 13:56:02 INFO - 'XPC_SERVICE_NAME': '0', 13:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:56:02 INFO - Cleaning up... 13:56:02 INFO - Return code: 0 13:56:02 INFO - Running post-action listener: _resource_record_post_action 13:56:02 INFO - Running post-action listener: _start_resource_monitoring 13:56:02 INFO - Starting resource monitoring. 13:56:02 INFO - [mozharness: 2016-10-26 20:56:02.544284Z] Finished create-virtualenv step (success) 13:56:02 INFO - [mozharness: 2016-10-26 20:56:02.545259Z] Running install step. 13:56:02 INFO - Running pre-action listener: _resource_record_pre_action 13:56:02 INFO - Running main action method: install 13:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:02 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.535649Z] Finished install step (success) 13:56:37 INFO - [mozharness: 2016-10-26 20:56:37.535805Z] 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.550 screenresolution[1928:11212] starting screenresolution argv=screenresolution get 13:56:37 INFO - 2016-10-26 13:56:37.552 screenresolution[1928:11212] Display 0: 1600x1200x32@60 13:56:37 INFO - 2016-10-26 13:56:37.558 screenresolution[1929:11214] 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 0x102592d30>, '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 0x1023b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10258ab20>, '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-0142', '--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-0142 --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.qu8VMuboe4/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.fLjqzH38fW/Listeners', 13:56:37 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-0142', '--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:38 INFO - mozversion application_buildid: 20161011025846 13:56:38 INFO - mozversion application_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:38 INFO - mozversion application_display_name: Nightly 13:56:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:38 INFO - mozversion application_name: Firefox 13:56:38 INFO - mozversion application_remotingname: firefox 13:56:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:56:38 INFO - mozversion application_vendor: Mozilla 13:56:38 INFO - mozversion application_version: 52.0a1 13:56:38 INFO - mozversion platform_buildid: 20161011025846 13:56:38 INFO - mozversion platform_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:56:38 INFO - mozversion platform_version: 52.0a1 13:56:38 INFO - using testdate: 1477515398 13:56:38 INFO - actual date: 1477515398 13:56:38 INFO - starting webserver on 'localhost:49783' 13:56:38 INFO - SUITE-START | Running 2 tests 13:56:38 INFO - TEST-START | dromaeo_css 13:56:38 INFO - operating with platform_type : mac_ 13:56:38 INFO - Initialising browser for dromaeo_css test... 13:56:38 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpfZPIHS/profile http://localhost:49783/getInfo.html) 13:56:40 INFO - PROCESS | 1939 | 2016-10-26 13:56:40.852 plugin-container[1941:11367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4b, name = 'com.apple.tsm.portname' 13:56:40 INFO - PROCESS | 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:40 INFO - PROCESS | 1939 | 2016-10-26 13:56:40.855 plugin-container[1941:11367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 13:56:40 INFO - PROCESS | 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:40 INFO - PROCESS | 1939 | 2016-10-26 13:56:40.855 plugin-container[1941:11367] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:40 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 13:56:40 INFO - PROCESS | 1939 | colorDepth:24 13:56:40 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 13:56:40 INFO - PROCESS | 1939 | __metrics 13:56:41 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 13:56:41 INFO - TEST-INFO | 1939: 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 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpfZPIHS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:44 INFO - PROCESS | 1942 | 2016-10-26 13:56:43.999 plugin-container[1943:11484] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 13:56:44 INFO - PROCESS | 1942 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:44 INFO - PROCESS | 1942 | 2016-10-26 13:56:44.000 plugin-container[1943:11484] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 13:56:44 INFO - PROCESS | 1942 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:44 INFO - PROCESS | 1942 | 2016-10-26 13:56:44.000 plugin-container[1943:11484] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:53 INFO - PROCESS | 1942 | RSS: Main: 239034368 13:56:53 INFO - PROCESS | 1942 | 13:57:43 INFO - PROCESS | 1942 | 1477515463347 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:56 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49783/tests/dromaeo/cssquery-ext.html) 13:59:57 INFO - PROCESS | 1942 | RSS: Main: 256561152 13:59:57 INFO - PROCESS | 1942 | 14:03:00 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49783/tests/dromaeo/cssquery-ext.html (next: http://localhost:49783/tests/dromaeo/cssquery-jquery.html) 14:03:00 INFO - PROCESS | 1942 | RSS: Main: 266768384 14:03:00 INFO - PROCESS | 1942 | 14:06:02 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49783/tests/dromaeo/cssquery-mootools.html) 14:06:03 INFO - PROCESS | 1942 | RSS: Main: 270393344 14:06:03 INFO - PROCESS | 1942 | 14:09:05 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49783/tests/dromaeo/cssquery-prototype.html) 14:09:05 INFO - PROCESS | 1942 | RSS: Main: 270012416 14:09:05 INFO - PROCESS | 1942 | 14:12:08 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49783/tests/dromaeo/cssquery-yui.html) 14:12:09 INFO - PROCESS | 1942 | RSS: Main: 275128320 14:12:09 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49783/tests/dromaeo/cssquery-yui.html (next: http://localhost:49783/tests/dromaeo/cssquery-dojo.html) 14:15:12 INFO - PROCESS | 1942 | RSS: Main: 278118400 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | __start_tp_report 14:15:12 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 14:15:12 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 14:15:12 INFO - PROCESS | 1942 | |i|pagename|runs| 14:15:12 INFO - PROCESS | 1942 | |0;dojo.html;3248.3665685191395;3282.6389097199312;3295.7033866951983;3322.186064414219;3324.17170556194;4295.892602684934;5252.6323157379;5355.946440535598;5384;5427.728613569316;5306.867328316794;5331.813386531472;5344.331958505187;5410.269613602162;5424.267723857278;3974.980125099385;4040.878773636796;4926.162552366106;5033.094043072246;5041.697498150123;4115.938260926088;4958.107540642683;5040.092783299005;5084.44071152173;5134.204198349244;4672.11229866326;4906.975465122688;4918.655694101414;5058.822941197041;5061.544460998491;4919.827806026808;4921.950780492185;4982.526659967298;4998.175301075318;5041.017001684673;3968.3650615901315;4886.731229782361;4890.119778439879;4905.828296009622;4967.981563779416;5311.336082989626;5416.9729151353995;5451.073317536028;5453.945460545423;5473.781048758045;5445.455454454563;5918.526517878602;5942.851428714273;5944.940550594482;5985.940140598582;5987.153313747981;6078.118672792464;6078.331383547807;6078.665673387962;6088.695565221766;5427.782888684408;5571.693556854331;5578.191162281447;5583.106702927594;5586.944130558683;6097.75608975636;6098.176746139303;6110.346130329577;6147.3709466990385;6153.4154255345675;5889.764409423575;5903.114532820111;5903.321118071477;5927.673977931169;5946.821595352147;6029.246344206974;6034.366391528826;6045.304789949124;6059.909101363395;6097.420745029215;5791.478766910998;5797.536197104221;5819.418058194231;5862.941370586324;5881.264841894763;5906.3207731110615;5935.970320148458;5977.22296101504;6004.879902401927;6007.8197654070445;4658.95341046592;4673.439187297478;4736.502667219961;4741.95258047422;4775.307580400822;4155.688323375759;4175.290200665894;4210.915781684411;4221.071364299849;4258.914821703549;5540.141278101901;5588.720563971785;5589.049861523551;5594.244776955059;5598.916016259678;5992.850178745566;6054.152418661391;6079.483243924316;6085.8478538036015;6094.725737341831;5421.5933804964;5499.917501237484;5503.11950087984;5576.86057848557;5577.9163312550345;5130.666506677054;5183.196604526304;5195.48045195485;5219.791208351699;5227.111391063529;6173.506119510428;6208.068789681493;6272.655003974825;6273.749050037947;6280.466160376419;5814.941850581609;5880.000399931936;5986.970065149646;6086.178365920544;6096.512279017579;6118.893302669041;6142.04798256271;6142.590862071594;6206.689665516797;6209.130721699056;5839.708014599338;5843.1235314701435;5848.0350742127075;5851.327097383855;5894.115882617642;5390.676559406448;5913.083472061838;5939;5943.851403714769;5968.343482216866;4137.524184718796;4300.8709738707885;5565.693886836101;5762.452567006296;5849.64902105875;5134.743262836769;5364.731763411735;5649.830505084854;5794.855128621818;5808.883822323614;4682.531746825426;5574.832755017356;5607.523360514402;5687;5699.5725320600295;5768;5877.94122058774;5892.558058145742;5904.0553511437965;5953.76184952597;5656.208130861765;5685.829425117253;5692.6299790513485;5703.600747947604;5719.28508936383 14:15:12 INFO - PROCESS | 1942 | |1;ext.html;431.92873175925973;475.607623710439;488.965772395932;507.6421123108209;531.3199105145413;38490.80754596226;41693;41711.957201069985;41728.58271417285;41733.79133104338;41732.956676083115;41952.58047419525;42282;42366.7881660592;42427.57572424275;9614.759631009229;9704.61181552737;9780.168685661693;9830.901690983106;9862.358946668479;9728.173105286023;9750.024997500228;9781.119699227069;9870.654527091554;9903.45530995795;9806;9832.606695732162;9845.704628861109;9888.20894328452;9890;9693.466859322734;9819.459929703864;9826.852597211047;9877.60489580416;9882.160016398615;9774.511274436321;9849.458279794608;9855.802883942353;9857.014298570157;9881.604735810559;40915.59084409148;40983.38524922128;41047;41207.38188927169;41207.96980075522;3138.148492389478;3266.085496061107;3431.3995050865997;3438.2951494943477;3737.2899149161844;30520;31267.687323126705;31738.841305793325;32178.356432871446;32369.659006263937;3154.9684503155136;3241.9351612967607;3262.4453842846774;3341.866325346983;3358.7313014958745;475143;477636;481324;482476.5876170667;483314.58342708414;61260.693696531234;61297.080543791875;61592.69203654043;61598;61601.69199153975;63679;64254.71490570162;64773.70452591016;65010;65168;15912.443064492687;16256;16456;16461.929974551615;16466.176691165634;12668.176568523017;12727.299998500172;12796.488140474277;12806.935965320114;12868.356582170854;18257.588057880304;19144.138513766913;19315;19378;19399.612007759766;3158.463061279588;7517.17311095779;7725.459217854696;7749.651265693057;7902.3678105751405;856.2721686566493;913.9451632901914;921.7004473546124;973.464594473037;1064.3188359449957;25182.622260666103;29320.853395732884;30154.698453015626;30223.69776302209;30317.93887213937;955.4697143085515;1049.21833234241;1138.7893239750672;1163.7730642524796;1195.647284051207;11338.773224535464;12836.679083022998;13931.303434828218;15537.922310388602;15825.446109386347;530632;638008;640614;647188;648845;58436.12345814816;58594;58853.82292354129;59040.704796475744;59172.70413647904;1192.582596091361;1305.7910734282468;1368.9863101369058;1370.41757253167;1395.5464474045773;29618.259543511584;30207.69792302049;30527;30633.387332253675;30735;51770.741146295535;51847;51892;51970.96058078742;52546.686332841986;547283;547683;550053;551470;554468;26914.59628105541;27213.86393068101;27562.5865612012;27637.170884873485;27666.585001224594;45133;45595.77202113968;46509;46658;47523.28715069208;39449.60550394459;39455.02724863688;40001.79999099986;40616;41356.58643413648;31646.683533164374;39961.40057899192;40285.39571906365;40384.59615403926;41069.794651026554;37468.06329841776;38247.61752382552;39108.413373798845;39369.40945885871;39389.80305098456;28502.805433471764;33216;34726.47910281398;35324.470132947514;35762.463563047095;24458.63312050285;25551.722413879605;25653.87173064123;25748;26226 14:15:12 INFO - PROCESS | 1942 | |2;jquery.html;375.4643508052065;375.8665673685841;381.9553521119738;387.93792993121104;403.39692160220477;18518.62962740746;20344.593108137866;21636.918154092313;21658.458538536546;21895.014724337405;10429.895701042988;11636.476358563863;12070.637880863565;12143.878561214386;19412.611747765037;4730.479647238818;5170.276161337406;5522.530584900288;5557.166425036236;5563.13771365439;4491.4161159049445;4621.353010578522;5261.684298942057;5445.782168713246;5490.588205884555;5427.592930530206;5459.426760190182;5473.397926228112;5476.096444086721;5505.366882808468;5045.369328833895;5440.619156659016;5461.262729531502;5495.890082198333;5509.5675124467525;4478.798454069574;4531.07113041829;5226.686398816083;5322.76047577856;5366.543843773284;13096.34518274092;13100.803487947689;13335.799963000465;13470.663233419145;13520.526781562598;2280.635098384267;2305.919292824743;2389.104085967762;2446.755324467557;2699.8380097194035;5571.777128914839;5638.126090455986;15066.773998390034;15321.857629549928;15478.690426191413;1796.6406718656322;1875.0812102070024;1888.5089876632037;1918.7793403758467;1946.1242440901651;109479.45260273728;121258.39370803178;130213;132413.6758632411;133457;9272.907270927204;11393.430328483542;11426.25729327591;11582.88417115818;11670.941645291889;13029.609111726664;14089.85910140906;14097.647558811112;14221.502247421291;14349.704047352374;7935.365170786324;8104.230098140667;8329.08380078191;8340.666373344999;8403.831923361498;8128.593570321578;8243;8259.793505162419;8314.085450600429;8360.99668039827;4530.818767249339;4532;4564.269716845289;4567.200739870509;4612.077584483117;1886.8867867927693;1912.1968773115047;1928.3443629166152;1934.303650685752;1934.7775005874223;723.3345322303494;808.6280311056979;884.1335491218641;932.1936524905908;943.0522325063405;19783.714058586145;19949.900250498944;20709.96450177485;21024.894875525526;21200.575988480454;844.5988155626152;903.4895284164558;907.419251678926;912.2063804490136;925.6991477769752;10507.422091784872;10715.928407159221;10945.945270273598;11026.44867756609;11045.061169800658;525736;590106;599497;603016;607384;107764.4611776936;113651;115710;126795.36602316929;127434.08848867274;980.2745967983641;1004.6985904228702;1026.630413051301;1035.0477560644226;1036.1503567075076;18521.59219301536;19119.617607648048;19122.52193695169;19185.712214317075;19227.94246316466;54415.72792136014;55238;55944.72027639999;57700.422995769506;58981;80176;85027.72458413252;85119.1488085136;85620;85720.57139714262;7471.850562988601;7931.325837303893;8197.139300373376;8203.58982050907;8283.37874659415;8423.410361274897;11682.162065877475;12814.487420503076;12927.482900684243;13107.344632768132;9235.492047937429;9289.67486138009;10374.792504150026;10914.799372069225;11072.667819965414;9362.344635875423;9653.855192171983;10918.344899306067;10973.396463194282;11208.159388045766;11113.555457781598;11321;11411.429428528707;11520.769584608428;11599.826002610136;6906.447484201151;7787.377009839086;7868.685252590061;8010.959945200237;8226.383021273308;8761.466743319766;9522.714318570454;10959.56161753521;10960.671179864617;11139.888601113886 14:15:12 INFO - PROCESS | 1942 | |3;mootools.html;1484.1540322016456;1540.12213038568;1593.8804589655779;1696.7454881767733;1733.7226043832982;7895.723649672263;8155.225253600898;8363.4563753356;8930.151635594624;8935.329850261232;7253.601051942154;8403.41176117672;8669.609867555959;8777;8794.208521233088;1940.2627001739354;2318.6985691860036;2320.0255892525097;2320.721513418392;2328.37133973827;2258.5144193998285;2299.12633199384;2309.58427483053;2316.652502124686;2321.3152120124605;2283.063943783049;2307.9884600577057;2316.4324740438615;2327.9301620951314;2336.147306233221;2275.7382900966436;2284.417473544252;2287.6911616931666;2291.0721157931066;2296.7703229677068;2289.8740569268684;2298.7241531016384;2299.241250387368;2309.8036666883168;2319.211468100854;8828.779280517974;8841.646334146626;8917.643294268222;8919.777005574848;8948.731538053804;5094.745262736886;5212.921806172911;5261.657992230531;5286.127788914824;5304.416514183436;3329.966700333014;3383.340248651514;3501.690902097519;3506.6843984041557;3511.6839484446523;1052.542144167282;1054.2830875004993;1063.6330465989222;1065.91472682186;1082.3073233130804;11280.943595282053;11492.655220343404;11526.82709759346;11529.654110376701;11535.25020873649;4496.752678602708;4521.208788462071;4700.365450664185;4709.740964246999;4713.151632706145;9714.611415543299;9787.951060244653;9803.705888823346;9822.26333025026;9866.30935834499;5175.120229560984;5227.869303267373;5246.31797866275;5252.842414727565;5262.815801446931;4287.464066991626;4390.165868485042;4723.527647235318;4797;4818.325434439182;3222.951655725166;3834.9424758628643;3921.5882332355263;3923.019245188703;3991.960080399217;1250.1811313589612;1260.4517035089582;1264.0898553041795;1272.3892531584706;1272.7899896517156;742.9108506979197;847.1020718038899;894.6019021535484;903.9005709371963;908.0510866144895;5637.49262566371;5705.372409035002;5853.619514731528;5893.11603259506;5971.4327138921735;415.9438475805788;419.3918817714326;432.2716223163916;432.96103350698587;440.8611287444445;3869.8645547405704;3880.7477513961503;3969.2458432897656;4014.8394064237687;4038.5759495252573;8146.714864979697;8691.739247822576;9396.624135034523;10264.692059238085;10474.057334839901;8640.913590864136;8682.739517814476;10456.843147352796;10619.044286014141;10713.89286107129;6944.375006249462;7893.921060789434;7925.682972681028;8084;8160.5103693778565;5795.855103622274;5835.533157347487;5890.322612899571;5948.4943779779205;5971.581989260884;8516.148385161681;9562.378445401027;9829.31194816356;9907.603695852085;9910.207183425164;8836.867446988172;9907.356021858555;9920.75198120024;9927.354721943051;9943.900560994298;6768.120144381396;6981.79054628362;7236.565806051653;7379.114506259283;7553.244675532403;8096.83806323882;8275.751727448187;8369.995600527976;8394.286485648789;8398.454100483448;7343.41252699772;7485.88771168422;7490.438217133627;7519.323260906544;7588.81027974305;7225.602591857499;7289.015982842248;7307.451941104332;7389.076365454318;7424.443166762407;6864.6910889011115;6870.62211578348;6945.826354341182;6948.374646281859;6950.930490695028;4905.4603993561395;4992.6255530834605;4995.875103122451;4998.450170481171;5035.92446113316;3962.40563915415;4832.95167048339;4913.361263035926;4977.975110124571;5096.541311282002 14:15:12 INFO - PROCESS | 1942 | |4;prototype.html;257.4066776081133;259.48880705011123;301.3505894796714;312.45944515987344;318.74818893074473;4215.786711976214;5347.491988261114;5409.6213265071465;5413.593980451472;5416.458354164582;4353.978230108845;4883.487233840449;5237.397699264586;5243.475652434755;5310.893782124364;3871.9225615487744;3928.3321835287925;4039.394090886361;4055.7351332177586;4061.979690101545;4062.837486500536;4089.591040895916;4096.487939007624;4102.979485102585;4110.260153172428;3885.1064255221318;3956.5845586213463;3982.402639604068;4069.8982525436804;4093.7953102344914;3245.610526736795;3734.636857547003;3832.5209348831395;3996.140829721624;4032.1129351542613;3185.569948057029;3450.1547120955524;3467.9653203468147;3477.956613016085;3498.510208570802;5182.341650671787;5198.3351737025305;5206.427292997767;5215.713135777531;5228.633995620308;4060.1879624075304;4102.630763231324;4216.3464662977285;4573.931391029138;4592.071330041391;4382.386465894777;4431.955680443187;5018.623603229772;5484.546595152287;5514.759179184692;3109.6112985876766;3702.7037836972977;3772.7736335819664;3790.2608991246716;3831.7126215533945;4982.576480999083;5468.125099984023;5605.943940560624;5889.85275368115;5959.761609535613;3317.270200555874;3840.135969406861;3846.2692088503095;3861.324268253101;3865.9806700966315;3119.890803821855;3739.700823934079;3926.784026878549;3937.547182074041;3940.9211815763524;4296.89257768552;4489.236829738952;4513.661475389359;4577.725336479822;4579.458400587706;4155.667546596265;5121.897562048738;5624.493795558419;5625.440424606794;5659.886802264014;1066.9490551806464;1322.6494978830617;1327.774278372679;1345.7510360583324;1368.4457794593206;733.4462480827049;734.8903156234124;822.9506229626122;833.6707000734797;836;5046.722430266297;5179.896402071938;5321.361436627552;5341.5192632662465;5374.6506477078865;5088.651507350555;5753.353457409638;5755;5757.568182386254;5779.768809247667;4829.541193586604;4993.725345105981;5202.687838729688;5299.3905700844125;5316.946830531722;2806.5509518476947;2932.516134837728;3054.533823764561;3068.9386212276077;3070.925176188316;4826.7827947742435;5090.821821236239;5115.797787519929;6095.238095238095;6160.9383906160365;4912.263160525878;5578.86052848682;5871.884341975011;5912.467877890925;5920.5559583031445;4955.950440495549;5956.404359564096;6102.267727872595;6166.352532984151;6177.135201071854;4929.11646686678;5676.7445464955;5836.795712150054;5923.496502797138;5977.282726072725;5336.519713225828;5674.744636491285;5693.5445164387575;5747.971260143672;5800.24596802413;5039.740064983754;5329.573634109184;5890.734916928663;6102.542309326729;6162.870876512658;3601.7298702596886;3623;3787.7348585598743;4015.9598404015587;4020.2964481216254;5173.81891633791;5703.3764468345025;5757.251557297524;5764.942350576441;5822.621529600732;5153.453963810767;5344.679319240858;5596.216529685928;5608.803691870929;5674.6166610023065;4805.543473370024;5382.811601593926;5631.719153742741;5704.178200605521;5710.458845813573;5001.549860512426;5156;5262;5440;5594.664320140804;5396.406395296593;5442.428545002717;5490.423505531861;5547.308071038372;5653.575981801464;5068.150125204347;5276.973615131899;5362.302900622894;5471.50756431923;5485.917711234414 14:15:12 INFO - PROCESS | 1942 | |5;yui.html;637.7640273098954;701.3652644356853;722.8084557592238;743.6802175064727;784.0552134677714;15054;15831.525054248392;15972;15996.200189990497;16010.199490025496;14478.565643030726;14555.854441455582;14680.486182983597;14683.412663493447;14690.971631985765;665.4576520136097;687.7902239816854;817.8854960305562;836.3184005035906;854.1245223645782;845.2435070611799;853.3002937591177;857.5797859049084;859.1837754133567;861.1689719420758;896.5696465696469;905.2938707807921;906.2297047509597;907.2923119966437;907.6460180529599;899.7480705402432;899.8155378147464;901.0403919825397;901.6618767962015;902.6254104546605;652.4421619515293;661.6691654172913;670.5942904542779;670.7987603718865;671.1811589860363;13127.606171814861;13145.802812957718;13170.934145329307;13210.603681889559;13284.40220190084;14433.855661443462;14516.564503064925;14538.055026423248;14616.780748288784;14807.111573305529;10190.694279171637;11761.882381176165;11803.173777835555;11904.642860714192;11919.284842909454;3739.607341229159;3786.2995345861104;3813.733038687293;3835;3943.132510847609;78547.60726196332;93874.5306273471;99036;109317;112540;10661.626843060456;10971.83542246867;11181.608643697431;11325.546978120783;11326.037286830711;21934.561308773737;21937.890310548344;21957.451063723216;21981.890090549445;21989.780102198773;7644.197359277307;7779.844403111906;7809.843803124019;8038.598070096472;8049.154838741848;3518.3530433654128;4141.689373297015;4148.834046638161;4228.175505776406;4290.82836686529;3453.533772940621;3554.2713743682484;3637.199816040467;3692.48305237267;3703.277860817169;575.683374144219;659.9901001484885;680.1464162476061;681.7204945972128;685.7428464325877;609.9359567245464;643.1863692429081;652.8922727749963;659.7657831469759;660.8909529927508;8521.886867879346;9061;9164.946031206497;9442;9473.90526094744;625.6402568523117;657.6810247030187;673.5285300289817;676.5669971218424;677.2381071294793;4449.888752781207;4584.679072464895;4598.632109431304;4642.419697537808;4699.342092107107;147041;158430;159729;161268.19365903095;167563.32436675476;106957;109147;125334;142719;143088.28455857653;77199;121657.78342216641;122430;122853;124027.9999999982;8139;8362.749117526484;8839.558022098998;8897.28821694276;8931.285497160081;31548.842255788575;37342.06644833901;41961.79019104885;49276.01447970949;54483.727581363426;68054.65972670303;82281;82885;84896.57551712202;88872;12146.331951742386;12460.376981150725;13006.674833129247;13153.671158221121;13263.602091937257;14873.405063797327;15015.699686006437;15040.473583424528;15292.158931258888;15337.6165595861;13807.654808629864;13863.72272554523;13951.162930224218;14077.436902524194;14400.783988240395;11026.944865275944;13468.191908485522;13679.931600342332;13887.791683124558;14184.361703723564;13653.112547684766;13728.725425491235;13831.100978436369;13915.165090094626;13928.72142557123;10941.671749847517;11230.157738169833;11519.827202592136;11898;11924.463399146885;10169.423739320417;10479.738006549593;10755.946220268848;11586.594469193538;11706.473208705798 14:15:12 INFO - PROCESS | 1942 | __end_tp_report 14:15:12 INFO - PROCESS | 1942 | __start_cc_report 14:15:12 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,360 14:15:12 INFO - PROCESS | 1942 | __end_cc_report 14:15:12 INFO - PROCESS | 1942 | __startTimestamp1477516512545__endTimestamp 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | ------- Summary: start ------- 14:15:12 INFO - PROCESS | 1942 | Number of tests: 6 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5445.15 Median:5594.24 stddev:678.32 (12.1%) stddev-sans-first:658.14 14:15:12 INFO - PROCESS | 1942 | Values: 3248.4 3282.6 3295.7 3322.2 3324.2 4295.9 5252.6 5355.9 5384.0 5427.7 5306.9 5331.8 5344.3 5410.3 5424.3 3975.0 4040.9 4926.2 5033.1 5041.7 4115.9 4958.1 5040.1 5084.4 5134.2 4672.1 4907.0 4918.7 5058.8 5061.5 4919.8 4922.0 4982.5 4998.2 5041.0 3968.4 4886.7 4890.1 4905.8 4968.0 5311.3 5417.0 5451.1 5453.9 5473.8 5445.5 5918.5 5942.9 5944.9 5985.9 5987.2 6078.1 6078.3 6078.7 6088.7 5427.8 5571.7 5578.2 5583.1 5586.9 6097.8 6098.2 6110.3 6147.4 6153.4 5889.8 5903.1 5903.3 5927.7 5946.8 6029.2 6034.4 6045.3 6059.9 6097.4 5791.5 5797.5 5819.4 5862.9 5881.3 5906.3 5936.0 5977.2 6004.9 6007.8 4659.0 4673.4 4736.5 4742.0 4775.3 4155.7 4175.3 4210.9 4221.1 4258.9 5540.1 5588.7 5589.0 5594.2 5598.9 5992.9 6054.2 6079.5 6085.8 6094.7 5421.6 5499.9 5503.1 5576.9 5577.9 5130.7 5183.2 5195.5 5219.8 5227.1 6173.5 6208.1 6272.7 6273.7 6280.5 5814.9 5880.0 5987.0 6086.2 6096.5 6118.9 6142.0 6142.6 6206.7 6209.1 5839.7 5843.1 5848.0 5851.3 5894.1 5390.7 5913.1 5939.0 5943.9 5968.3 4137.5 4300.9 5565.7 5762.5 5849.6 5134.7 5364.7 5649.8 5794.9 5808.9 4682.5 5574.8 5607.5 5687.0 5699.6 5768.0 5877.9 5892.6 5904.1 5953.8 5656.2 5685.8 5692.6 5703.6 5719.3 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:68949.37 Median:41282.28 stddev:147853.75 (358.2%) stddev-sans-first:148179.02 14:15:12 INFO - PROCESS | 1942 | Values: 431.9 475.6 489.0 507.6 531.3 38490.8 41693.0 41712.0 41728.6 41733.8 41733.0 41952.6 42282.0 42366.8 42427.6 9614.8 9704.6 9780.2 9830.9 9862.4 9728.2 9750.0 9781.1 9870.7 9903.5 9806.0 9832.6 9845.7 9888.2 9890.0 9693.5 9819.5 9826.9 9877.6 9882.2 9774.5 9849.5 9855.8 9857.0 9881.6 40915.6 40983.4 41047.0 41207.4 41208.0 3138.1 3266.1 3431.4 3438.3 3737.3 30520.0 31267.7 31738.8 32178.4 32369.7 3155.0 3241.9 3262.4 3341.9 3358.7 475143.0 477636.0 481324.0 482476.6 483314.6 61260.7 61297.1 61592.7 61598.0 61601.7 63679.0 64254.7 64773.7 65010.0 65168.0 15912.4 16256.0 16456.0 16461.9 16466.2 12668.2 12727.3 12796.5 12806.9 12868.4 18257.6 19144.1 19315.0 19378.0 19399.6 3158.5 7517.2 7725.5 7749.7 7902.4 856.3 913.9 921.7 973.5 1064.3 25182.6 29320.9 30154.7 30223.7 30317.9 955.5 1049.2 1138.8 1163.8 1195.6 11338.8 12836.7 13931.3 15537.9 15825.4 530632.0 638008.0 640614.0 647188.0 648845.0 58436.1 58594.0 58853.8 59040.7 59172.7 1192.6 1305.8 1369.0 1370.4 1395.5 29618.3 30207.7 30527.0 30633.4 30735.0 51770.7 51847.0 51892.0 51971.0 52546.7 547283.0 547683.0 550053.0 551470.0 554468.0 26914.6 27213.9 27562.6 27637.2 27666.6 45133.0 45595.8 46509.0 46658.0 47523.3 39449.6 39455.0 40001.8 40616.0 41356.6 31646.7 39961.4 40285.4 40384.6 41069.8 37468.1 38247.6 39108.4 39369.4 39389.8 28502.8 33216.0 34726.5 35324.5 35762.5 24458.6 25551.7 25653.9 25748.0 26226.0 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:34171.24 Median:378.91 stddev:98113.89 (25893.7%) stddev-sans-first:98356.31 14:15:12 INFO - PROCESS | 1942 | Values: 375.5 375.9 382.0 387.9 403.4 18518.6 20344.6 21636.9 21658.5 21895.0 10429.9 11636.5 12070.6 12143.9 19412.6 4730.5 5170.3 5522.5 5557.2 5563.1 4491.4 4621.4 5261.7 5445.8 5490.6 5427.6 5459.4 5473.4 5476.1 5505.4 5045.4 5440.6 5461.3 5495.9 5509.6 4478.8 4531.1 5226.7 5322.8 5366.5 13096.3 13100.8 13335.8 13470.7 13520.5 2280.6 2305.9 2389.1 2446.8 2699.8 5571.8 5638.1 15066.8 15321.9 15478.7 1796.6 1875.1 1888.5 1918.8 1946.1 109479.5 121258.4 130213.0 132413.7 133457.0 9272.9 11393.4 11426.3 11582.9 11670.9 13029.6 14089.9 14097.6 14221.5 14349.7 7935.4 8104.2 8329.1 8340.7 8403.8 8128.6 8243.0 8259.8 8314.1 8361.0 4530.8 4532.0 4564.3 4567.2 4612.1 1886.9 1912.2 1928.3 1934.3 1934.8 723.3 808.6 884.1 932.2 943.1 19783.7 19949.9 20710.0 21024.9 21200.6 844.6 903.5 907.4 912.2 925.7 10507.4 10715.9 10945.9 11026.4 11045.1 525736.0 590106.0 599497.0 603016.0 607384.0 107764.5 113651.0 115710.0 126795.4 127434.1 980.3 1004.7 1026.6 1035.0 1036.2 18521.6 19119.6 19122.5 19185.7 19227.9 54415.7 55238.0 55944.7 57700.4 58981.0 80176.0 85027.7 85119.1 85620.0 85720.6 7471.9 7931.3 8197.1 8203.6 8283.4 8423.4 11682.2 12814.5 12927.5 13107.3 9235.5 9289.7 10374.8 10914.8 11072.7 9362.3 9653.9 10918.3 10973.4 11208.2 11113.6 11321.0 11411.4 11520.8 11599.8 6906.4 7787.4 7868.7 8011.0 8226.4 8761.5 9522.7 10959.6 10960.7 11139.9 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5541.28 Median:5135.83 stddev:3095.71 (60.3%) stddev-sans-first:3089.38 14:15:12 INFO - PROCESS | 1942 | Values: 1484.2 1540.1 1593.9 1696.7 1733.7 7895.7 8155.2 8363.5 8930.2 8935.3 7253.6 8403.4 8669.6 8777.0 8794.2 1940.3 2318.7 2320.0 2320.7 2328.4 2258.5 2299.1 2309.6 2316.7 2321.3 2283.1 2308.0 2316.4 2327.9 2336.1 2275.7 2284.4 2287.7 2291.1 2296.8 2289.9 2298.7 2299.2 2309.8 2319.2 8828.8 8841.6 8917.6 8919.8 8948.7 5094.7 5212.9 5261.7 5286.1 5304.4 3330.0 3383.3 3501.7 3506.7 3511.7 1052.5 1054.3 1063.6 1065.9 1082.3 11280.9 11492.7 11526.8 11529.7 11535.3 4496.8 4521.2 4700.4 4709.7 4713.2 9714.6 9788.0 9803.7 9822.3 9866.3 5175.1 5227.9 5246.3 5252.8 5262.8 4287.5 4390.2 4723.5 4797.0 4818.3 3223.0 3834.9 3921.6 3923.0 3992.0 1250.2 1260.5 1264.1 1272.4 1272.8 742.9 847.1 894.6 903.9 908.1 5637.5 5705.4 5853.6 5893.1 5971.4 415.9 419.4 432.3 433.0 440.9 3869.9 3880.7 3969.2 4014.8 4038.6 8146.7 8691.7 9396.6 10264.7 10474.1 8640.9 8682.7 10456.8 10619.0 10713.9 6944.4 7893.9 7925.7 8084.0 8160.5 5795.9 5835.5 5890.3 5948.5 5971.6 8516.1 9562.4 9829.3 9907.6 9910.2 8836.9 9907.4 9920.8 9927.4 9943.9 6768.1 6981.8 7236.6 7379.1 7553.2 8096.8 8275.8 8370.0 8394.3 8398.5 7343.4 7485.9 7490.4 7519.3 7588.8 7225.6 7289.0 7307.5 7389.1 7424.4 6864.7 6870.6 6945.8 6948.4 6950.9 4905.5 4992.6 4995.9 4998.5 5035.9 3962.4 4833.0 4913.4 4978.0 5096.5 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:4505.76 Median:5103.31 stddev:1407.42 (27.6%) stddev-sans-first:1374.77 14:15:12 INFO - PROCESS | 1942 | Values: 257.4 259.5 301.4 312.5 318.7 4215.8 5347.5 5409.6 5413.6 5416.5 4354.0 4883.5 5237.4 5243.5 5310.9 3871.9 3928.3 4039.4 4055.7 4062.0 4062.8 4089.6 4096.5 4103.0 4110.3 3885.1 3956.6 3982.4 4069.9 4093.8 3245.6 3734.6 3832.5 3996.1 4032.1 3185.6 3450.2 3468.0 3478.0 3498.5 5182.3 5198.3 5206.4 5215.7 5228.6 4060.2 4102.6 4216.3 4573.9 4592.1 4382.4 4432.0 5018.6 5484.5 5514.8 3109.6 3702.7 3772.8 3790.3 3831.7 4982.6 5468.1 5605.9 5889.9 5959.8 3317.3 3840.1 3846.3 3861.3 3866.0 3119.9 3739.7 3926.8 3937.5 3940.9 4296.9 4489.2 4513.7 4577.7 4579.5 4155.7 5121.9 5624.5 5625.4 5659.9 1066.9 1322.6 1327.8 1345.8 1368.4 733.4 734.9 823.0 833.7 836.0 5046.7 5179.9 5321.4 5341.5 5374.7 5088.7 5753.4 5755.0 5757.6 5779.8 4829.5 4993.7 5202.7 5299.4 5316.9 2806.6 2932.5 3054.5 3068.9 3070.9 4826.8 5090.8 5115.8 6095.2 6160.9 4912.3 5578.9 5871.9 5912.5 5920.6 4956.0 5956.4 6102.3 6166.4 6177.1 4929.1 5676.7 5836.8 5923.5 5977.3 5336.5 5674.7 5693.5 5748.0 5800.2 5039.7 5329.6 5890.7 6102.5 6162.9 3601.7 3623.0 3787.7 4016.0 4020.3 5173.8 5703.4 5757.3 5764.9 5822.6 5153.5 5344.7 5596.2 5608.8 5674.6 4805.5 5382.8 5631.7 5704.2 5710.5 5001.5 5156.0 5262.0 5440.0 5594.7 5396.4 5442.4 5490.4 5547.3 5653.6 5068.2 5277.0 5362.3 5471.5 5485.9 14:15:12 INFO - PROCESS | 1942 | 14:15:12 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:23987.45 Median:3664.84 stddev:39312.91 (1072.7%) stddev-sans-first:39384.10 14:15:12 INFO - PROCESS | 1942 | Values: 637.8 701.4 722.8 743.7 784.1 15054.0 15831.5 15972.0 15996.2 16010.2 14478.6 14555.9 14680.5 14683.4 14691.0 665.5 687.8 817.9 836.3 854.1 845.2 853.3 857.6 859.2 861.2 896.6 905.3 906.2 907.3 907.6 899.7 899.8 901.0 901.7 902.6 652.4 661.7 670.6 670.8 671.2 13127.6 13145.8 13170.9 13210.6 13284.4 14433.9 14516.6 14538.1 14616.8 14807.1 10190.7 11761.9 11803.2 11904.6 11919.3 3739.6 3786.3 3813.7 3835.0 3943.1 78547.6 93874.5 99036.0 109317.0 112540.0 10661.6 10971.8 11181.6 11325.5 11326.0 21934.6 21937.9 21957.5 21981.9 21989.8 7644.2 7779.8 7809.8 8038.6 8049.2 3518.4 4141.7 4148.8 4228.2 4290.8 3453.5 3554.3 3637.2 3692.5 3703.3 575.7 660.0 680.1 681.7 685.7 609.9 643.2 652.9 659.8 660.9 8521.9 9061.0 9164.9 9442.0 9473.9 625.6 657.7 673.5 676.6 677.2 4449.9 4584.7 4598.6 4642.4 4699.3 147041.0 158430.0 159729.0 161268.2 167563.3 106957.0 109147.0 125334.0 142719.0 143088.3 77199.0 121657.8 122430.0 122853.0 124028.0 8139.0 8362.7 8839.6 8897.3 8931.3 31548.8 37342.1 41961.8 49276.0 54483.7 68054.7 82281.0 82885.0 84896.6 88872.0 12146.3 12460.4 13006.7 13153.7 13263.6 14873.4 15015.7 15040.5 15292.2 15337.6 13807.7 13863.7 13951.2 14077.4 14400.8 11026.9 13468.2 13679.9 13887.8 14184.4 13653.1 13728.7 13831.1 13915.2 13928.7 10941.7 11230.2 11519.8 11898.0 11924.5 10169.4 10479.7 10755.9 11586.6 11706.5 14:15:12 INFO - PROCESS | 1942 | -------- Summary: end -------- 14:15:12 INFO - PROCESS | 1942 | 14:15:13 INFO - TEST-INFO | 1942: exit 0 14:15:13 INFO - TEST-OK | dromaeo_css | took 1115046ms 14:15:13 INFO - TEST-START | kraken 14:15:13 INFO - operating with platform_type : mac_ 14:15:13 INFO - Initialising browser for kraken test... 14:15:13 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpR5_kKp/profile http://localhost:49783/getInfo.html) 14:15:15 INFO - PROCESS | 1948 | 2016-10-26 14:15:15.722 plugin-container[1949:13425] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:15:15 INFO - PROCESS | 1948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:15 INFO - PROCESS | 1948 | 2016-10-26 14:15:15.726 plugin-container[1949:13425] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 14:15:15 INFO - PROCESS | 1948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:15 INFO - PROCESS | 1948 | 2016-10-26 14:15:15.726 plugin-container[1949:13425] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:15 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 14:15:15 INFO - PROCESS | 1948 | colorDepth:24 14:15:15 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 14:15:15 INFO - PROCESS | 1948 | __metrics 14:15:15 ERROR - PROCESS | 1948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:15:16 INFO - TEST-INFO | 1948: exit 0 14:15:16 INFO - Browser initialized. 14:15:16 INFO - Running cycle 1/1 for kraken test... 14:15:16 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpR5_kKp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:19 INFO - PROCESS | 1950 | 2016-10-26 14:15:19.201 plugin-container[1951:13542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 14:15:19 INFO - PROCESS | 1950 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:19 INFO - PROCESS | 1950 | 2016-10-26 14:15:19.205 plugin-container[1951:13542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:15:19 INFO - PROCESS | 1950 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:19 INFO - PROCESS | 1950 | 2016-10-26 14:15:19.205 plugin-container[1951:13542] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:28 INFO - PROCESS | 1950 | RSS: Main: 238567424 14:15:28 INFO - PROCESS | 1950 | 14:15:31 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49783/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:32 INFO - PROCESS | 1950 | RSS: Main: 251998208 14:15:32 INFO - PROCESS | 1950 | 14:15:35 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49783/tests/kraken/driver.html?testName=audio-dft) 14:15:35 INFO - PROCESS | 1950 | RSS: Main: 260374528 14:15:35 INFO - PROCESS | 1950 | 14:15:39 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49783/tests/kraken/driver.html?testName=audio-fft) 14:15:40 INFO - PROCESS | 1950 | RSS: Main: 260702208 14:15:40 INFO - PROCESS | 1950 | 14:15:42 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49783/tests/kraken/driver.html?testName=audio-oscillator) 14:15:42 INFO - PROCESS | 1950 | RSS: Main: 261623808 14:15:42 INFO - PROCESS | 1950 | 14:15:44 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:45 INFO - PROCESS | 1950 | RSS: Main: 263012352 14:15:45 INFO - PROCESS | 1950 | 14:15:48 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49783/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:48 INFO - PROCESS | 1950 | RSS: Main: 263548928 14:15:48 INFO - PROCESS | 1950 | 14:15:51 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49783/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:52 INFO - PROCESS | 1950 | RSS: Main: 263708672 14:15:52 INFO - PROCESS | 1950 | 14:15:55 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49783/tests/kraken/driver.html?testName=json-parse-financial) 14:15:55 INFO - PROCESS | 1950 | RSS: Main: 263905280 14:15:55 INFO - PROCESS | 1950 | 14:15:57 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:57 INFO - PROCESS | 1950 | RSS: Main: 263614464 14:15:57 INFO - PROCESS | 1950 | 14:15:59 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:00 INFO - PROCESS | 1950 | RSS: Main: 264105984 14:16:00 INFO - PROCESS | 1950 | 14:16:02 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:03 INFO - PROCESS | 1950 | RSS: Main: 263643136 14:16:03 INFO - PROCESS | 1950 | 14:16:06 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:07 INFO - PROCESS | 1950 | RSS: Main: 263950336 14:16:07 INFO - PROCESS | 1950 | 14:16:10 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:10 INFO - PROCESS | 1950 | RSS: Main: 264015872 14:16:10 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49783/tests/kraken/driver.html?testName=ai-astar) 14:16:12 INFO - PROCESS | 1950 | RSS: Main: 265773056 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | __start_tp_report 14:16:12 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 14:16:12 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 14:16:12 INFO - PROCESS | 1950 | |i|pagename|runs| 14:16:12 INFO - PROCESS | 1950 | |0;ai-astar;132;176;175;117;118;117;113;117;116;117 14:16:12 INFO - PROCESS | 1950 | |1;audio-beat-detection;149;102;148;187;147;117;115;119;145;114 14:16:12 INFO - PROCESS | 1950 | |2;audio-dft;195;206;232;275;286;250;200;196;198;197 14:16:12 INFO - PROCESS | 1950 | |3;audio-fft;84;60;60;81;60;60;52;87;107;86 14:16:12 INFO - PROCESS | 1950 | |4;audio-oscillator;90;71;87;75;69;71;86;69;72;88 14:16:12 INFO - PROCESS | 1950 | |5;imaging-gaussian-blur;92;130;88;89;89;83;88;94;135;133 14:16:12 INFO - PROCESS | 1950 | |6;imaging-darkroom;96;94;96;94;96;94;106;97;95;96 14:16:12 INFO - PROCESS | 1950 | |7;imaging-desaturate;129;147;91;93;92;90;89;90;91;92 14:16:12 INFO - PROCESS | 1950 | |8;json-parse-financial;57;57;58;59;57;57;57;58;56;61 14:16:12 INFO - PROCESS | 1950 | |9;json-stringify-tinderbox;69;74;69;80;74;70;69;69;69;70 14:16:12 INFO - PROCESS | 1950 | |10;stanford-crypto-aes;86;92;89;91;95;110;87;92;87;88 14:16:12 INFO - PROCESS | 1950 | |11;stanford-crypto-ccm;147;148;147;168;166;170;149;160;213;167 14:16:12 INFO - PROCESS | 1950 | |12;stanford-crypto-pbkdf2;174;179;166;154;161;223;168;168;152;201 14:16:12 INFO - PROCESS | 1950 | |13;stanford-crypto-sha256-iterative;89;92;91;87;69;76;66;75;86;92 14:16:12 INFO - PROCESS | 1950 | __end_tp_report 14:16:12 INFO - PROCESS | 1950 | __start_cc_report 14:16:12 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,932 14:16:12 INFO - PROCESS | 1950 | __end_cc_report 14:16:12 INFO - PROCESS | 1950 | __startTimestamp1477516572914__endTimestamp 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | ------- Summary: start ------- 14:16:12 INFO - PROCESS | 1950 | Number of tests: 14 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#0] ai-astar Cycles:10 Average:129.80 Median:117.50 stddev:24.61 (20.9%) stddev-sans-first:26.09 14:16:12 INFO - PROCESS | 1950 | Values: 132.0 176.0 175.0 117.0 118.0 117.0 113.0 117.0 116.0 117.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:146.00 stddev:25.43 (17.4%) stddev-sans-first:26.41 14:16:12 INFO - PROCESS | 1950 | Values: 149.0 102.0 148.0 187.0 147.0 117.0 115.0 119.0 145.0 114.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#2] audio-dft Cycles:10 Average:223.50 Median:219.00 stddev:35.14 (16.0%) stddev-sans-first:35.72 14:16:12 INFO - PROCESS | 1950 | Values: 195.0 206.0 232.0 275.0 286.0 250.0 200.0 196.0 198.0 197.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#3] audio-fft Cycles:10 Average:73.70 Median:70.50 stddev:17.70 (25.1%) stddev-sans-first:18.37 14:16:12 INFO - PROCESS | 1950 | Values: 84.0 60.0 60.0 81.0 60.0 60.0 52.0 87.0 107.0 86.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.50 stddev:8.78 (10.9%) stddev-sans-first:8.13 14:16:12 INFO - PROCESS | 1950 | Values: 90.0 71.0 87.0 75.0 69.0 71.0 86.0 69.0 72.0 88.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#5] imaging-gaussian-blur Cycles:10 Average:102.10 Median:88.50 stddev:21.31 (24.1%) stddev-sans-first:22.29 14:16:12 INFO - PROCESS | 1950 | Values: 92.0 130.0 88.0 89.0 89.0 83.0 88.0 94.0 135.0 133.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:3.53 (3.7%) stddev-sans-first:3.75 14:16:12 INFO - PROCESS | 1950 | Values: 96.0 94.0 96.0 94.0 96.0 94.0 106.0 97.0 95.0 96.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#7] imaging-desaturate Cycles:10 Average:100.40 Median:91.00 stddev:20.30 (22.3%) stddev-sans-first:18.71 14:16:12 INFO - PROCESS | 1950 | Values: 129.0 147.0 91.0 93.0 92.0 90.0 89.0 90.0 91.0 92.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:1.42 (2.5%) stddev-sans-first:1.48 14:16:12 INFO - PROCESS | 1950 | Values: 57.0 57.0 58.0 59.0 57.0 57.0 57.0 58.0 56.0 61.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:70.00 stddev:3.65 (5.2%) stddev-sans-first:3.78 14:16:12 INFO - PROCESS | 1950 | Values: 69.0 74.0 69.0 80.0 74.0 70.0 69.0 69.0 69.0 70.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:90.00 stddev:7.02 (7.8%) stddev-sans-first:7.14 14:16:12 INFO - PROCESS | 1950 | Values: 86.0 92.0 89.0 91.0 95.0 110.0 87.0 92.0 87.0 88.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#11] stanford-crypto-ccm Cycles:10 Average:163.50 Median:166.50 stddev:19.83 (11.9%) stddev-sans-first:20.11 14:16:12 INFO - PROCESS | 1950 | Values: 147.0 148.0 147.0 168.0 166.0 170.0 149.0 160.0 213.0 167.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:171.00 stddev:21.96 (12.8%) stddev-sans-first:23.29 14:16:12 INFO - PROCESS | 1950 | Values: 174.0 179.0 166.0 154.0 161.0 223.0 168.0 168.0 152.0 201.0 14:16:12 INFO - PROCESS | 1950 | 14:16:12 INFO - PROCESS | 1950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:88.00 stddev:9.89 (11.2%) stddev-sans-first:10.19 14:16:12 INFO - PROCESS | 1950 | Values: 89.0 92.0 91.0 87.0 69.0 76.0 66.0 75.0 86.0 92.0 14:16:12 INFO - PROCESS | 1950 | -------- Summary: end -------- 14:16:12 INFO - PROCESS | 1950 | 14:16:13 INFO - TEST-INFO | 1950: exit 0 14:16:13 INFO - TEST-OK | kraken | took 60535ms 14:16:13 INFO - SUITE-END | took 1175s 14:16:14 INFO - Completed test suite (00:19:35) 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": 7150.91587646967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.3665685191395, 3282.6389097199312, 3295.7033866951983, 3322.186064414219, 3324.17170556194, 4295.892602684934, 5252.6323157379, 5355.946440535598, 5384.0, 5427.728613569316, 5306.867328316794, 5331.813386531472, 5344.331958505187, 5410.269613602162, 5424.267723857278, 3974.980125099385, 4040.878773636796, 4926.162552366106, 5033.094043072246, 5041.697498150123, 4115.938260926088, 4958.107540642683, 5040.092783299005, 5084.44071152173, 5134.204198349244, 4672.11229866326, 4906.975465122688, 4918.655694101414, 5058.822941197041, 5061.544460998491, 4919.827806026808, 4921.950780492185, 4982.526659967298, 4998.175301075318, 5041.017001684673, 3968.3650615901315, 4886.731229782361, 4890.119778439879, 4905.828296009622, 4967.981563779416, 5311.336082989626, 5416.9729151353995, 5451.073317536028, 5453.945460545423, 5473.781048758045, 5445.455454454563, 5918.526517878602, 5942.851428714273, 5944.940550594482, 5985.940140598582, 5987.153313747981, 6078.118672792464, 6078.331383547807, 6078.665673387962, 6088.695565221766, 5427.782888684408, 5571.693556854331, 5578.191162281447, 5583.106702927594, 5586.944130558683, 6097.75608975636, 6098.176746139303, 6110.346130329577, 6147.3709466990385, 6153.4154255345675, 5889.764409423575, 5903.114532820111, 5903.321118071477, 5927.673977931169, 5946.821595352147, 6029.246344206974, 6034.366391528826, 6045.304789949124, 6059.909101363395, 6097.420745029215, 5791.478766910998, 5797.536197104221, 5819.418058194231, 5862.941370586324, 5881.264841894763, 5906.3207731110615, 5935.970320148458, 5977.22296101504, 6004.879902401927, 6007.8197654070445, 4658.95341046592, 4673.439187297478, 4736.502667219961, 4741.95258047422, 4775.307580400822, 4155.688323375759, 4175.290200665894, 4210.915781684411, 4221.071364299849, 4258.914821703549, 5540.141278101901, 5588.720563971785, 5589.049861523551, 5594.244776955059, 5598.916016259678, 5992.850178745566, 6054.152418661391, 6079.483243924316, 6085.8478538036015, 6094.725737341831, 5421.5933804964, 5499.917501237484, 5503.11950087984, 5576.86057848557, 5577.9163312550345, 5130.666506677054, 5183.196604526304, 5195.48045195485, 5219.791208351699, 5227.111391063529, 6173.506119510428, 6208.068789681493, 6272.655003974825, 6273.749050037947, 6280.466160376419, 5814.941850581609, 5880.000399931936, 5986.970065149646, 6086.178365920544, 6096.512279017579, 6118.893302669041, 6142.04798256271, 6142.590862071594, 6206.689665516797, 6209.130721699056, 5839.708014599338, 5843.1235314701435, 5848.0350742127075, 5851.327097383855, 5894.115882617642, 5390.676559406448, 5913.083472061838, 5939.0, 5943.851403714769, 5968.343482216866, 4137.524184718796, 4300.8709738707885, 5565.693886836101, 5762.452567006296, 5849.64902105875, 5134.743262836769, 5364.731763411735, 5649.830505084854, 5794.855128621818, 5808.883822323614, 4682.531746825426, 5574.832755017356, 5607.523360514402, 5687.0, 5699.5725320600295, 5768.0, 5877.94122058774, 5892.558058145742, 5904.0553511437965, 5953.76184952597, 5656.208130861765, 5685.829425117253, 5692.6299790513485, 5703.600747947604, 5719.28508936383], "value": 5402.358375247084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.92873175925973, 475.607623710439, 488.965772395932, 507.6421123108209, 531.3199105145413, 38490.80754596226, 41693.0, 41711.957201069985, 41728.58271417285, 41733.79133104338, 41732.956676083115, 41952.58047419525, 42282.0, 42366.7881660592, 42427.57572424275, 9614.759631009229, 9704.61181552737, 9780.168685661693, 9830.901690983106, 9862.358946668479, 9728.173105286023, 9750.024997500228, 9781.119699227069, 9870.654527091554, 9903.45530995795, 9806.0, 9832.606695732162, 9845.704628861109, 9888.20894328452, 9890.0, 9693.466859322734, 9819.459929703864, 9826.852597211047, 9877.60489580416, 9882.160016398615, 9774.511274436321, 9849.458279794608, 9855.802883942353, 9857.014298570157, 9881.604735810559, 40915.59084409148, 40983.38524922128, 41047.0, 41207.38188927169, 41207.96980075522, 3138.148492389478, 3266.085496061107, 3431.3995050865997, 3438.2951494943477, 3737.2899149161844, 30520.0, 31267.687323126705, 31738.841305793325, 32178.356432871446, 32369.659006263937, 3154.9684503155136, 3241.9351612967607, 3262.4453842846774, 3341.866325346983, 3358.7313014958745, 475143.0, 477636.0, 481324.0, 482476.5876170667, 483314.58342708414, 61260.693696531234, 61297.080543791875, 61592.69203654043, 61598.0, 61601.69199153975, 63679.0, 64254.71490570162, 64773.70452591016, 65010.0, 65168.0, 15912.443064492687, 16256.0, 16456.0, 16461.929974551615, 16466.176691165634, 12668.176568523017, 12727.299998500172, 12796.488140474277, 12806.935965320114, 12868.356582170854, 18257.588057880304, 19144.138513766913, 19315.0, 19378.0, 19399.612007759766, 3158.463061279588, 7517.17311095779, 7725.459217854696, 7749.651265693057, 7902.3678105751405, 856.2721686566493, 913.9451632901914, 921.7004473546124, 973.464594473037, 1064.3188359449957, 25182.622260666103, 29320.853395732884, 30154.698453015626, 30223.69776302209, 30317.93887213937, 955.4697143085515, 1049.21833234241, 1138.7893239750672, 1163.7730642524796, 1195.647284051207, 11338.773224535464, 12836.679083022998, 13931.303434828218, 15537.922310388602, 15825.446109386347, 530632.0, 638008.0, 640614.0, 647188.0, 648845.0, 58436.12345814816, 58594.0, 58853.82292354129, 59040.704796475744, 59172.70413647904, 1192.582596091361, 1305.7910734282468, 1368.9863101369058, 1370.41757253167, 1395.5464474045773, 29618.259543511584, 30207.69792302049, 30527.0, 30633.387332253675, 30735.0, 51770.741146295535, 51847.0, 51892.0, 51970.96058078742, 52546.686332841986, 547283.0, 547683.0, 550053.0, 551470.0, 554468.0, 26914.59628105541, 27213.86393068101, 27562.5865612012, 27637.170884873485, 27666.585001224594, 45133.0, 45595.77202113968, 46509.0, 46658.0, 47523.28715069208, 39449.60550394459, 39455.02724863688, 40001.79999099986, 40616.0, 41356.58643413648, 31646.683533164374, 39961.40057899192, 40285.39571906365, 40384.59615403926, 41069.794651026554, 37468.06329841776, 38247.61752382552, 39108.413373798845, 39369.40945885871, 39389.80305098456, 28502.805433471764, 33216.0, 34726.47910281398, 35324.470132947514, 35762.463563047095, 24458.63312050285, 25551.722413879605, 25653.87173064123, 25748.0, 26226.0], "value": 19981.59814837788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4643508052065, 375.8665673685841, 381.9553521119738, 387.93792993121104, 403.39692160220477, 18518.62962740746, 20344.593108137866, 21636.918154092313, 21658.458538536546, 21895.014724337405, 10429.895701042988, 11636.476358563863, 12070.637880863565, 12143.878561214386, 19412.611747765037, 4730.479647238818, 5170.276161337406, 5522.530584900288, 5557.166425036236, 5563.13771365439, 4491.4161159049445, 4621.353010578522, 5261.684298942057, 5445.782168713246, 5490.588205884555, 5427.592930530206, 5459.426760190182, 5473.397926228112, 5476.096444086721, 5505.366882808468, 5045.369328833895, 5440.619156659016, 5461.262729531502, 5495.890082198333, 5509.5675124467525, 4478.798454069574, 4531.07113041829, 5226.686398816083, 5322.76047577856, 5366.543843773284, 13096.34518274092, 13100.803487947689, 13335.799963000465, 13470.663233419145, 13520.526781562598, 2280.635098384267, 2305.919292824743, 2389.104085967762, 2446.755324467557, 2699.8380097194035, 5571.777128914839, 5638.126090455986, 15066.773998390034, 15321.857629549928, 15478.690426191413, 1796.6406718656322, 1875.0812102070024, 1888.5089876632037, 1918.7793403758467, 1946.1242440901651, 109479.45260273728, 121258.39370803178, 130213.0, 132413.6758632411, 133457.0, 9272.907270927204, 11393.430328483542, 11426.25729327591, 11582.88417115818, 11670.941645291889, 13029.609111726664, 14089.85910140906, 14097.647558811112, 14221.502247421291, 14349.704047352374, 7935.365170786324, 8104.230098140667, 8329.08380078191, 8340.666373344999, 8403.831923361498, 8128.593570321578, 8243.0, 8259.793505162419, 8314.085450600429, 8360.99668039827, 4530.818767249339, 4532.0, 4564.269716845289, 4567.200739870509, 4612.077584483117, 1886.8867867927693, 1912.1968773115047, 1928.3443629166152, 1934.303650685752, 1934.7775005874223, 723.3345322303494, 808.6280311056979, 884.1335491218641, 932.1936524905908, 943.0522325063405, 19783.714058586145, 19949.900250498944, 20709.96450177485, 21024.894875525526, 21200.575988480454, 844.5988155626152, 903.4895284164558, 907.419251678926, 912.2063804490136, 925.6991477769752, 10507.422091784872, 10715.928407159221, 10945.945270273598, 11026.44867756609, 11045.061169800658, 525736.0, 590106.0, 599497.0, 603016.0, 607384.0, 107764.4611776936, 113651.0, 115710.0, 126795.36602316929, 127434.08848867274, 980.2745967983641, 1004.6985904228702, 1026.630413051301, 1035.0477560644226, 1036.1503567075076, 18521.59219301536, 19119.617607648048, 19122.52193695169, 19185.712214317075, 19227.94246316466, 54415.72792136014, 55238.0, 55944.72027639999, 57700.422995769506, 58981.0, 80176.0, 85027.72458413252, 85119.1488085136, 85620.0, 85720.57139714262, 7471.850562988601, 7931.325837303893, 8197.139300373376, 8203.58982050907, 8283.37874659415, 8423.410361274897, 11682.162065877475, 12814.487420503076, 12927.482900684243, 13107.344632768132, 9235.492047937429, 9289.67486138009, 10374.792504150026, 10914.799372069225, 11072.667819965414, 9362.344635875423, 9653.855192171983, 10918.344899306067, 10973.396463194282, 11208.159388045766, 11113.555457781598, 11321.0, 11411.429428528707, 11520.769584608428, 11599.826002610136, 6906.447484201151, 7787.377009839086, 7868.685252590061, 8010.959945200237, 8226.383021273308, 8761.466743319766, 9522.714318570454, 10959.56161753521, 10960.671179864617, 11139.888601113886], "value": 9098.602460551368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.1540322016456, 1540.12213038568, 1593.8804589655779, 1696.7454881767733, 1733.7226043832982, 7895.723649672263, 8155.225253600898, 8363.4563753356, 8930.151635594624, 8935.329850261232, 7253.601051942154, 8403.41176117672, 8669.609867555959, 8777.0, 8794.208521233088, 1940.2627001739354, 2318.6985691860036, 2320.0255892525097, 2320.721513418392, 2328.37133973827, 2258.5144193998285, 2299.12633199384, 2309.58427483053, 2316.652502124686, 2321.3152120124605, 2283.063943783049, 2307.9884600577057, 2316.4324740438615, 2327.9301620951314, 2336.147306233221, 2275.7382900966436, 2284.417473544252, 2287.6911616931666, 2291.0721157931066, 2296.7703229677068, 2289.8740569268684, 2298.7241531016384, 2299.241250387368, 2309.8036666883168, 2319.211468100854, 8828.779280517974, 8841.646334146626, 8917.643294268222, 8919.777005574848, 8948.731538053804, 5094.745262736886, 5212.921806172911, 5261.657992230531, 5286.127788914824, 5304.416514183436, 3329.966700333014, 3383.340248651514, 3501.690902097519, 3506.6843984041557, 3511.6839484446523, 1052.542144167282, 1054.2830875004993, 1063.6330465989222, 1065.91472682186, 1082.3073233130804, 11280.943595282053, 11492.655220343404, 11526.82709759346, 11529.654110376701, 11535.25020873649, 4496.752678602708, 4521.208788462071, 4700.365450664185, 4709.740964246999, 4713.151632706145, 9714.611415543299, 9787.951060244653, 9803.705888823346, 9822.26333025026, 9866.30935834499, 5175.120229560984, 5227.869303267373, 5246.31797866275, 5252.842414727565, 5262.815801446931, 4287.464066991626, 4390.165868485042, 4723.527647235318, 4797.0, 4818.325434439182, 3222.951655725166, 3834.9424758628643, 3921.5882332355263, 3923.019245188703, 3991.960080399217, 1250.1811313589612, 1260.4517035089582, 1264.0898553041795, 1272.3892531584706, 1272.7899896517156, 742.9108506979197, 847.1020718038899, 894.6019021535484, 903.9005709371963, 908.0510866144895, 5637.49262566371, 5705.372409035002, 5853.619514731528, 5893.11603259506, 5971.4327138921735, 415.9438475805788, 419.3918817714326, 432.2716223163916, 432.96103350698587, 440.8611287444445, 3869.8645547405704, 3880.7477513961503, 3969.2458432897656, 4014.8394064237687, 4038.5759495252573, 8146.714864979697, 8691.739247822576, 9396.624135034523, 10264.692059238085, 10474.057334839901, 8640.913590864136, 8682.739517814476, 10456.843147352796, 10619.044286014141, 10713.89286107129, 6944.375006249462, 7893.921060789434, 7925.682972681028, 8084.0, 8160.5103693778565, 5795.855103622274, 5835.533157347487, 5890.322612899571, 5948.4943779779205, 5971.581989260884, 8516.148385161681, 9562.378445401027, 9829.31194816356, 9907.603695852085, 9910.207183425164, 8836.867446988172, 9907.356021858555, 9920.75198120024, 9927.354721943051, 9943.900560994298, 6768.120144381396, 6981.79054628362, 7236.565806051653, 7379.114506259283, 7553.244675532403, 8096.83806323882, 8275.751727448187, 8369.995600527976, 8394.286485648789, 8398.454100483448, 7343.41252699772, 7485.88771168422, 7490.438217133627, 7519.323260906544, 7588.81027974305, 7225.602591857499, 7289.015982842248, 7307.451941104332, 7389.076365454318, 7424.443166762407, 6864.6910889011115, 6870.62211578348, 6945.826354341182, 6948.374646281859, 6950.930490695028, 4905.4603993561395, 4992.6255530834605, 4995.875103122451, 4998.450170481171, 5035.92446113316, 3962.40563915415, 4832.95167048339, 4913.361263035926, 4977.975110124571, 5096.541311282002], "value": 4387.162652181258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.4066776081133, 259.48880705011123, 301.3505894796714, 312.45944515987344, 318.74818893074473, 4215.786711976214, 5347.491988261114, 5409.6213265071465, 5413.593980451472, 5416.458354164582, 4353.978230108845, 4883.487233840449, 5237.397699264586, 5243.475652434755, 5310.893782124364, 3871.9225615487744, 3928.3321835287925, 4039.394090886361, 4055.7351332177586, 4061.979690101545, 4062.837486500536, 4089.591040895916, 4096.487939007624, 4102.979485102585, 4110.260153172428, 3885.1064255221318, 3956.5845586213463, 3982.402639604068, 4069.8982525436804, 4093.7953102344914, 3245.610526736795, 3734.636857547003, 3832.5209348831395, 3996.140829721624, 4032.1129351542613, 3185.569948057029, 3450.1547120955524, 3467.9653203468147, 3477.956613016085, 3498.510208570802, 5182.341650671787, 5198.3351737025305, 5206.427292997767, 5215.713135777531, 5228.633995620308, 4060.1879624075304, 4102.630763231324, 4216.3464662977285, 4573.931391029138, 4592.071330041391, 4382.386465894777, 4431.955680443187, 5018.623603229772, 5484.546595152287, 5514.759179184692, 3109.6112985876766, 3702.7037836972977, 3772.7736335819664, 3790.2608991246716, 3831.7126215533945, 4982.576480999083, 5468.125099984023, 5605.943940560624, 5889.85275368115, 5959.761609535613, 3317.270200555874, 3840.135969406861, 3846.2692088503095, 3861.324268253101, 3865.9806700966315, 3119.890803821855, 3739.700823934079, 3926.784026878549, 3937.547182074041, 3940.9211815763524, 4296.89257768552, 4489.236829738952, 4513.661475389359, 4577.725336479822, 4579.458400587706, 4155.667546596265, 5121.897562048738, 5624.493795558419, 5625.440424606794, 5659.886802264014, 1066.9490551806464, 1322.6494978830617, 1327.774278372679, 1345.7510360583324, 1368.4457794593206, 733.4462480827049, 734.8903156234124, 822.9506229626122, 833.6707000734797, 836.0, 5046.722430266297, 5179.896402071938, 5321.361436627552, 5341.5192632662465, 5374.6506477078865, 5088.651507350555, 5753.353457409638, 5755.0, 5757.568182386254, 5779.768809247667, 4829.541193586604, 4993.725345105981, 5202.687838729688, 5299.3905700844125, 5316.946830531722, 2806.5509518476947, 2932.516134837728, 3054.533823764561, 3068.9386212276077, 3070.925176188316, 4826.7827947742435, 5090.821821236239, 5115.797787519929, 6095.238095238095, 6160.9383906160365, 4912.263160525878, 5578.86052848682, 5871.884341975011, 5912.467877890925, 5920.5559583031445, 4955.950440495549, 5956.404359564096, 6102.267727872595, 6166.352532984151, 6177.135201071854, 4929.11646686678, 5676.7445464955, 5836.795712150054, 5923.496502797138, 5977.282726072725, 5336.519713225828, 5674.744636491285, 5693.5445164387575, 5747.971260143672, 5800.24596802413, 5039.740064983754, 5329.573634109184, 5890.734916928663, 6102.542309326729, 6162.870876512658, 3601.7298702596886, 3623.0, 3787.7348585598743, 4015.9598404015587, 4020.2964481216254, 5173.81891633791, 5703.3764468345025, 5757.251557297524, 5764.942350576441, 5822.621529600732, 5153.453963810767, 5344.679319240858, 5596.216529685928, 5608.803691870929, 5674.6166610023065, 4805.543473370024, 5382.811601593926, 5631.719153742741, 5704.178200605521, 5710.458845813573, 5001.549860512426, 5156.0, 5262.0, 5440.0, 5594.664320140804, 5396.406395296593, 5442.428545002717, 5490.423505531861, 5547.308071038372, 5653.575981801464, 5068.150125204347, 5276.973615131899, 5362.302900622894, 5471.50756431923, 5485.917711234414], "value": 4046.2617920059206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.7640273098954, 701.3652644356853, 722.8084557592238, 743.6802175064727, 784.0552134677714, 15054.0, 15831.525054248392, 15972.0, 15996.200189990497, 16010.199490025496, 14478.565643030726, 14555.854441455582, 14680.486182983597, 14683.412663493447, 14690.971631985765, 665.4576520136097, 687.7902239816854, 817.8854960305562, 836.3184005035906, 854.1245223645782, 845.2435070611799, 853.3002937591177, 857.5797859049084, 859.1837754133567, 861.1689719420758, 896.5696465696469, 905.2938707807921, 906.2297047509597, 907.2923119966437, 907.6460180529599, 899.7480705402432, 899.8155378147464, 901.0403919825397, 901.6618767962015, 902.6254104546605, 652.4421619515293, 661.6691654172913, 670.5942904542779, 670.7987603718865, 671.1811589860363, 13127.606171814861, 13145.802812957718, 13170.934145329307, 13210.603681889559, 13284.40220190084, 14433.855661443462, 14516.564503064925, 14538.055026423248, 14616.780748288784, 14807.111573305529, 10190.694279171637, 11761.882381176165, 11803.173777835555, 11904.642860714192, 11919.284842909454, 3739.607341229159, 3786.2995345861104, 3813.733038687293, 3835.0, 3943.132510847609, 78547.60726196332, 93874.5306273471, 99036.0, 109317.0, 112540.0, 10661.626843060456, 10971.83542246867, 11181.608643697431, 11325.546978120783, 11326.037286830711, 21934.561308773737, 21937.890310548344, 21957.451063723216, 21981.890090549445, 21989.780102198773, 7644.197359277307, 7779.844403111906, 7809.843803124019, 8038.598070096472, 8049.154838741848, 3518.3530433654128, 4141.689373297015, 4148.834046638161, 4228.175505776406, 4290.82836686529, 3453.533772940621, 3554.2713743682484, 3637.199816040467, 3692.48305237267, 3703.277860817169, 575.683374144219, 659.9901001484885, 680.1464162476061, 681.7204945972128, 685.7428464325877, 609.9359567245464, 643.1863692429081, 652.8922727749963, 659.7657831469759, 660.8909529927508, 8521.886867879346, 9061.0, 9164.946031206497, 9442.0, 9473.90526094744, 625.6402568523117, 657.6810247030187, 673.5285300289817, 676.5669971218424, 677.2381071294793, 4449.888752781207, 4584.679072464895, 4598.632109431304, 4642.419697537808, 4699.342092107107, 147041.0, 158430.0, 159729.0, 161268.19365903095, 167563.32436675476, 106957.0, 109147.0, 125334.0, 142719.0, 143088.28455857653, 77199.0, 121657.78342216641, 122430.0, 122853.0, 124027.9999999982, 8139.0, 8362.749117526484, 8839.558022098998, 8897.28821694276, 8931.285497160081, 31548.842255788575, 37342.06644833901, 41961.79019104885, 49276.01447970949, 54483.727581363426, 68054.65972670303, 82281.0, 82885.0, 84896.57551712202, 88872.0, 12146.331951742386, 12460.376981150725, 13006.674833129247, 13153.671158221121, 13263.602091937257, 14873.405063797327, 15015.699686006437, 15040.473583424528, 15292.158931258888, 15337.6165595861, 13807.654808629864, 13863.72272554523, 13951.162930224218, 14077.436902524194, 14400.783988240395, 11026.944865275944, 13468.191908485522, 13679.931600342332, 13887.791683124558, 14184.361703723564, 13653.112547684766, 13728.725425491235, 13831.100978436369, 13915.165090094626, 13928.72142557123, 10941.671749847517, 11230.157738169833, 11519.827202592136, 11898.0, 11924.463399146885, 10169.423739320417, 10479.738006549593, 10755.946220268848, 11586.594469193538, 11706.473208705798], "value": 7668.238148519438, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 176.0, 175.0, 117.0, 118.0, 117.0, 113.0, 117.0, 116.0, 117.0], "value": 129.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 102.0, 148.0, 187.0, 147.0, 117.0, 115.0, 119.0, 145.0, 114.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 206.0, 232.0, 275.0, 286.0, 250.0, 200.0, 196.0, 198.0, 197.0], "value": 223.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 60.0, 81.0, 60.0, 60.0, 52.0, 87.0, 107.0, 86.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 87.0, 75.0, 69.0, 71.0, 86.0, 69.0, 72.0, 88.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 130.0, 88.0, 89.0, 89.0, 83.0, 88.0, 94.0, 135.0, 133.0], "value": 102.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 94.0, 96.0, 94.0, 106.0, 97.0, 95.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 147.0, 91.0, 93.0, 92.0, 90.0, 89.0, 90.0, 91.0, 92.0], "value": 100.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 59.0, 57.0, 57.0, 57.0, 58.0, 56.0, 61.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 69.0, 80.0, 74.0, 70.0, 69.0, 69.0, 69.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 89.0, 91.0, 95.0, 110.0, 87.0, 92.0, 87.0, 88.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 168.0, 166.0, 170.0, 149.0, 160.0, 213.0, 167.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 166.0, 154.0, 161.0, 223.0, 168.0, 168.0, 152.0, 201.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 91.0, 87.0, 69.0, 76.0, 66.0, 75.0, 86.0, 92.0], "value": 82.3, "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.205 screenresolution[1955:13928] starting screenresolution argv=screenresolution get 14:16:14 INFO - 2016-10-26 14:16:14.208 screenresolution[1955:13928] Display 0: 1600x1200x32@60 14:16:14 INFO - 2016-10-26 14:16:14.213 screenresolution[1956:13931] 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.452233Z] 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: 1211s; CPU: 54.0%; Read bytes: 110592; Write bytes: 707617792; Read time: 3; Write time: 1900 14:16:14 INFO - TinderboxPrint: CPU usage
54.3% 14:16:14 INFO - TinderboxPrint: I/O read bytes / time
110,592 / 3 14:16:14 INFO - TinderboxPrint: I/O write bytes / time
707,617,792 / 1,900 14:16:14 INFO - TinderboxPrint: CPU idle
2,213.3 (45.7%) 14:16:14 INFO - TinderboxPrint: CPU system
978.9 (20.2%) 14:16:14 INFO - TinderboxPrint: CPU user
1,653.4 (34.1%) 14:16:14 INFO - TinderboxPrint: Swap in / out
407,711,744 / 0 14:16:14 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387154432; Write bytes: 381404672; Read time: 29042; Write time: 668 14:16:14 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 110592; Write bytes: 297618944; Read time: 3; Write time: 1180 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:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:20 INFO - (blobuploader) - INFO - Done attempting. 14:16:20 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/f981dfff816a72042a185e095c15215b22261561e8e98379e18a837f18502adce8487c4eeb1a858b20a779b5150ab9f49a566a4c1efdddb28cb23b886e17488c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db89c4647fcbaefab9ac6d89a47874bac77e1b44962e2a8a8ede7d959ab4deb6e41e5f9b7ef6db0c1ac8dda6011085a3ed5e7b5bd434764fbcfb6fa960afc4a"} 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/f981dfff816a72042a185e095c15215b22261561e8e98379e18a837f18502adce8487c4eeb1a858b20a779b5150ab9f49a566a4c1efdddb28cb23b886e17488c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db89c4647fcbaefab9ac6d89a47874bac77e1b44962e2a8a8ede7d959ab4deb6e41e5f9b7ef6db0c1ac8dda6011085a3ed5e7b5bd434764fbcfb6fa960afc4a"} 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=1277.189675 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 14:16:20.472199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.476247) ========= 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.qu8VMuboe4/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.fLjqzH38fW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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/f981dfff816a72042a185e095c15215b22261561e8e98379e18a837f18502adce8487c4eeb1a858b20a779b5150ab9f49a566a4c1efdddb28cb23b886e17488c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db89c4647fcbaefab9ac6d89a47874bac77e1b44962e2a8a8ede7d959ab4deb6e41e5f9b7ef6db0c1ac8dda6011085a3ed5e7b5bd434764fbcfb6fa960afc4a"} 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.011154 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/f981dfff816a72042a185e095c15215b22261561e8e98379e18a837f18502adce8487c4eeb1a858b20a779b5150ab9f49a566a4c1efdddb28cb23b886e17488c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5db89c4647fcbaefab9ac6d89a47874bac77e1b44962e2a8a8ede7d959ab4deb6e41e5f9b7ef6db0c1ac8dda6011085a3ed5e7b5bd434764fbcfb6fa960afc4a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.508985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.509338) ========= 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.qu8VMuboe4/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.fLjqzH38fW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005217 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:20.557608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:20.557924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:20.558247) ========= ========= Total master_lag: 0.19 =========