builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0052 starttime: 1487033992.95 results: success (0) buildid: 20170213141724 builduid: 2f07f451fcf34e7c822b6dae07363ecb revision: bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:52.949384) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:52.949838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:52.950122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:52.977305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:52.977709) ========= 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.225O2pWqAH/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.72OTlEceOp/Listeners TMPDIR=/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-13 16:59:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.37M=0.001s 2017-02-13 16:59:53 (9.37 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:53.093129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:53.093452) ========= 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.225O2pWqAH/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.72OTlEceOp/Listeners TMPDIR=/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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.026068 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:53.142521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 16:59:53.142915) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.225O2pWqAH/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.72OTlEceOp/Listeners TMPDIR=/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-13 16:59:53,239 truncating revision to first 12 chars 2017-02-13 16:59:53,239 Setting DEBUG logging. 2017-02-13 16:59:53,239 attempt 1/10 2017-02-13 16:59:53,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bd9cd325c4bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 16:59:54,190 unpacking tar archive at: mozilla-beta-bd9cd325c4bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 16:59:54.394243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:54.394585) ========= script_repo_revision: bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:54.394986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:54.395258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 16:59:54.415039) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-13 16:59:54.415427) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.225O2pWqAH/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.72OTlEceOp/Listeners TMPDIR=/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 16:59:54 INFO - MultiFileLogger online at 20170213 16:59:54 in /builds/slave/test 16:59:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:59:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:54 INFO - {'append_to_log': False, 16:59:54 INFO - 'base_work_dir': '/builds/slave/test', 16:59:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:59:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:54 INFO - 'branch': 'Mozilla-Beta', 16:59:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:54 INFO - 'config_files': ('talos/mac_config.py',), 16:59:54 INFO - 'default_actions': ('clobber', 16:59:54 INFO - 'read-buildbot-config', 16:59:54 INFO - 'download-and-extract', 16:59:54 INFO - 'populate-webroot', 16:59:54 INFO - 'create-virtualenv', 16:59:54 INFO - 'install', 16:59:54 INFO - 'run-tests'), 16:59:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:54 INFO - 'download_minidump_stackwalk': True, 16:59:54 INFO - 'download_symbols': 'ondemand', 16:59:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:54 INFO - 'installer_path': 'installer.exe', 16:59:54 INFO - 'log_level': 'info', 16:59:54 INFO - 'log_name': 'talos', 16:59:54 INFO - 'log_to_console': True, 16:59:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:59:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:59:54 INFO - 'opt_config_files': (), 16:59:54 INFO - 'pip_index': False, 16:59:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:59:54 INFO - 'cmd': ('bash', 16:59:54 INFO - '-c', 16:59:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:59:54 INFO - 'enabled': True, 16:59:54 INFO - 'halt_on_failure': False, 16:59:54 INFO - 'name': 'check_screen_resolution'},), 16:59:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:59:54 INFO - 'cmd': ('bash', 16:59:54 INFO - '-c', 16:59:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:59:54 INFO - 'enabled': True, 16:59:54 INFO - 'halt_on_failure': False, 16:59:54 INFO - 'name': 'check_screen_resolution'},), 16:59:54 INFO - 'run_cmd_checks_enabled': True, 16:59:54 INFO - 'sps_profile': False, 16:59:54 INFO - 'sps_profile_interval': 0, 16:59:54 INFO - 'suite': 'dromaeojs-e10s', 16:59:54 INFO - 'system_bits': '32', 16:59:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:54 INFO - 'title': 't-yosemite-r7-0052', 16:59:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:54 INFO - 'use_talos_json': True, 16:59:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:54 INFO - 'work_dir': 'build'} 16:59:54 INFO - [mozharness: 2017-02-14 00:59:54.618391Z] Running clobber step. 16:59:54 INFO - Running pre-action listener: _resource_record_pre_action 16:59:54 INFO - Running main action method: clobber 16:59:54 INFO - rmtree: /builds/slave/test/build 16:59:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:57 INFO - Running post-action listener: _resource_record_post_action 16:59:57 INFO - [mozharness: 2017-02-14 00:59:57.433944Z] Finished clobber step (success) 16:59:57 INFO - [mozharness: 2017-02-14 00:59:57.434137Z] Running read-buildbot-config step. 16:59:57 INFO - Running pre-action listener: _resource_record_pre_action 16:59:57 INFO - Running main action method: read_buildbot_config 16:59:57 INFO - Using buildbot properties: 16:59:57 INFO - { 16:59:57 INFO - "project": "", 16:59:57 INFO - "product": "firefox", 16:59:57 INFO - "script_repo_revision": "production", 16:59:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:59:57 INFO - "repository": "", 16:59:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:59:57 INFO - "buildid": "20170213141724", 16:59:57 INFO - "pgo_build": "False", 16:59:57 INFO - "basedir": "/builds/slave/test", 16:59:57 INFO - "buildnumber": 26, 16:59:57 INFO - "slavename": "t-yosemite-r7-0052", 16:59:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:59:57 INFO - "platform": "yosemite_r7", 16:59:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:59:57 INFO - "branch": "mozilla-beta", 16:59:57 INFO - "repo_path": "releases/mozilla-beta", 16:59:57 INFO - "revision": "bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8", 16:59:57 INFO - "stage_platform": "macosx64", 16:59:57 INFO - "builduid": "2f07f451fcf34e7c822b6dae07363ecb", 16:59:57 INFO - "slavebuilddir": "test" 16:59:57 INFO - } 16:59:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 16:59:57 INFO - Running post-action listener: _resource_record_post_action 16:59:57 INFO - [mozharness: 2017-02-14 00:59:57.437429Z] Finished read-buildbot-config step (success) 16:59:57 INFO - [mozharness: 2017-02-14 00:59:57.437539Z] Running download-and-extract step. 16:59:57 INFO - Running pre-action listener: _resource_record_pre_action 16:59:57 INFO - Running main action method: download_and_extract 16:59:57 INFO - mkdir: /builds/slave/test/build/tests 16:59:57 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')]} 16:59:57 INFO - trying https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 16:59:57 INFO - Downloading https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 16:59:58 INFO - Downloaded 1165 bytes. 16:59:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:59:58 INFO - Using the following test package requirements: 16:59:58 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:59:58 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 16:59:58 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 16:59:58 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:59:58 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 16:59:58 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:59:58 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 16:59:58 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 16:59:58 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 16:59:58 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:59:58 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 16:59:58 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 16:59:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:59:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:59:58 INFO - Fetch https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:59:58 INFO - Http code: 200 16:59:58 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 16:59:58 INFO - x-amz-cf-id: 40CX-X0Ffg_WxPhNcr-unLodb_fUn80oGFFxhHky1ovTqHdQl7-odQ== 16:59:58 INFO - x-amz-version-id: HKDAkcJKBR7HvyEltCpMSeNE96WN.kLh 16:59:59 INFO - Expected file size: 16094118 16:59:59 INFO - Obtained file size: 16094118 17:00:06 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:00:06 INFO - Fetch https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:00:06 INFO - Http code: 200 17:00:06 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 17:00:06 INFO - x-amz-cf-id: 122Sw1UrP0JJhaso_luGIbgFV0bYTkac9JustVs4tbl-IXZ2_V8wcQ== 17:00:06 INFO - x-amz-version-id: HKDAkcJKBR7HvyEltCpMSeNE96WN.kLh 17:00:07 INFO - Expected file size: 16094118 17:00:07 INFO - Obtained file size: 16094118 17:00:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 17:00:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 17:00:13 INFO - Fetch https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 17:00:13 INFO - Http code: 200 17:00:13 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 17:00:13 INFO - x-amz-cf-id: wfsuc3HpsA9WbdfN5merko7niGuQkLS7JyFs3dfB4z4KpLd4d4nIdg== 17:00:13 INFO - x-amz-version-id: LoBuMasADb8huSqWSoHpILZZqOCVXHq_ 17:00:14 INFO - Expected file size: 14403005 17:00:14 INFO - Obtained file size: 14403005 17:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:14 INFO - trying https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:00:14 INFO - Downloading https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 17:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 17:00:16 INFO - Downloaded 82107541 bytes. 17:00:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:00:16 INFO - mkdir: /builds/slave/test/properties 17:00:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:00:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:00:16 INFO - Contents: 17:00:16 INFO - build_url:https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:00:17 INFO - Running post-action listener: _resource_record_post_action 17:00:17 INFO - Running post-action listener: set_extra_try_arguments 17:00:17 INFO - [mozharness: 2017-02-14 01:00:17.548956Z] Finished download-and-extract step (success) 17:00:17 INFO - [mozharness: 2017-02-14 01:00:17.549110Z] Running populate-webroot step. 17:00:17 INFO - Running pre-action listener: _resource_record_pre_action 17:00:17 INFO - Running main action method: populate_webroot 17:00:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:17 INFO - '--tppagecycles', 17:00:17 INFO - '7'], 17:00:17 INFO - 'tests': ['tsvgm']}}, 17:00:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:00:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:00:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:00:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['damp', 'tps']}, 17:00:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'tests': ['damp', 'tps']}, 17:00:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['dromaeo_dom']}, 17:00:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['basic_compositor_video']}, 17:00:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:00:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['a11yr', 17:00:17 INFO - 'ts_paint', 17:00:17 INFO - 'tpaint', 17:00:17 INFO - 'sessionrestore', 17:00:17 INFO - 'sessionrestore_no_auto_restore', 17:00:17 INFO - 'tabpaint']}, 17:00:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:00:17 INFO - 'ts_paint', 17:00:17 INFO - 'tpaint', 17:00:17 INFO - 'sessionrestore', 17:00:17 INFO - 'sessionrestore_no_auto_restore', 17:00:17 INFO - 'tabpaint']}, 17:00:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:00:17 INFO - 'ts_paint', 17:00:17 INFO - 'tpaint', 17:00:17 INFO - 'sessionrestore', 17:00:17 INFO - 'sessionrestore_no_auto_restore', 17:00:17 INFO - 'tabpaint']}, 17:00:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:00:17 INFO - 'ts_paint', 17:00:17 INFO - 'tpaint', 17:00:17 INFO - 'sessionrestore', 17:00:17 INFO - 'sessionrestore_no_auto_restore', 17:00:17 INFO - 'tabpaint']}, 17:00:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['a11yr', 17:00:17 INFO - 'ts_paint', 17:00:17 INFO - 'tpaint', 17:00:17 INFO - 'sessionrestore', 17:00:17 INFO - 'sessionrestore_no_auto_restore', 17:00:17 INFO - 'tabpaint']}, 17:00:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['a11yr', 17:00:17 INFO - 'ts_paint', 17:00:17 INFO - 'tpaint', 17:00:17 INFO - 'sessionrestore', 17:00:17 INFO - 'sessionrestore_no_auto_restore', 17:00:17 INFO - 'tabpaint']}, 17:00:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['tsvgx', 17:00:17 INFO - 'tsvgr_opacity', 17:00:17 INFO - 'tart', 17:00:17 INFO - 'tscrollx', 17:00:17 INFO - 'cart']}, 17:00:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:00:17 INFO - 'tsvgr_opacity', 17:00:17 INFO - 'tart', 17:00:17 INFO - 'tscrollx', 17:00:17 INFO - 'cart']}, 17:00:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'talos_options': ['--disable-e10s'], 17:00:17 INFO - 'tests': ['tp5o']}, 17:00:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'tests': ['tp5o']}, 17:00:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'talos_options': ['--disable-e10s', 17:00:17 INFO - '--xperf_path', 17:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:17 INFO - 'tests': ['tp5n']}, 17:00:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:17 INFO - 'talos_options': ['--xperf_path', 17:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:17 INFO - 'tests': ['tp5n']}}, 17:00:17 INFO - 'talos.zip': {'path': '', 17:00:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:17 INFO - Running post-action listener: _resource_record_post_action 17:00:17 INFO - [mozharness: 2017-02-14 01:00:17.568225Z] Finished populate-webroot step (success) 17:00:17 INFO - [mozharness: 2017-02-14 01:00:17.568361Z] Running create-virtualenv step. 17:00:17 INFO - Running pre-action listener: _resource_record_pre_action 17:00:17 INFO - Running main action method: create_virtualenv 17:00:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:00:17 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 17:00:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:00:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:17 INFO - Using real prefix '/tools/python27' 17:00:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:00:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:21 INFO - Installing pip.................done. 17:00:21 INFO - Return code: 0 17:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:00:21 INFO - Reading from file tmpfile_stdout 17:00:21 INFO - Output received: 17:00:21 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) 17:00:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:00:21 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')]} 17:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:21 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')]} 17:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:21 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:21 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 17:00:21 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 17:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:21 INFO - 'HOME': '/Users/cltbld', 17:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:21 INFO - 'LOGNAME': 'cltbld', 17:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:21 INFO - 'MOZ_NO_REMOTE': '1', 17:00:21 INFO - 'NO_EM_RESTART': '1', 17:00:21 INFO - 'PAGER': '/bin/cat', 17:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:21 INFO - 'PWD': '/builds/slave/test', 17:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:21 INFO - 'SHELL': '/bin/bash', 17:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:21 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:21 INFO - 'USER': 'cltbld', 17:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:21 INFO - 'XPC_FLAGS': '0x0', 17:00:21 INFO - 'XPC_SERVICE_NAME': '0', 17:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:21 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 17:00:21 INFO - Cleaning up... 17:00:21 INFO - Return code: 0 17:00:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:00:21 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')]} 17:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:21 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')]} 17:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:21 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:21 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 17:00:21 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 17:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:21 INFO - 'HOME': '/Users/cltbld', 17:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:21 INFO - 'LOGNAME': 'cltbld', 17:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:21 INFO - 'MOZ_NO_REMOTE': '1', 17:00:21 INFO - 'NO_EM_RESTART': '1', 17:00:21 INFO - 'PAGER': '/bin/cat', 17:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:21 INFO - 'PWD': '/builds/slave/test', 17:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:21 INFO - 'SHELL': '/bin/bash', 17:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:21 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:21 INFO - 'USER': 'cltbld', 17:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:21 INFO - 'XPC_FLAGS': '0x0', 17:00:21 INFO - 'XPC_SERVICE_NAME': '0', 17:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:22 INFO - Downloading/unpacking psutil>=3.1.1 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:25 INFO - Installing collected packages: psutil 17:00:25 INFO - Running setup.py install for psutil 17:00:25 INFO - building 'psutil._psutil_osx' extension 17:00:25 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 INFO - building 'psutil._psutil_posix' extension 17:00:26 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 17:00:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:00:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:00:26 INFO - ^ 17:00:26 INFO - 1 warning generated. 17:00:26 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 17:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:26 INFO - Successfully installed psutil 17:00:26 INFO - Cleaning up... 17:00:26 INFO - Return code: 0 17:00:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:26 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:26 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 17:00:26 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 17:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:26 INFO - 'HOME': '/Users/cltbld', 17:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:26 INFO - 'LOGNAME': 'cltbld', 17:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:26 INFO - 'MOZ_NO_REMOTE': '1', 17:00:26 INFO - 'NO_EM_RESTART': '1', 17:00:26 INFO - 'PAGER': '/bin/cat', 17:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:26 INFO - 'PWD': '/builds/slave/test', 17:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:26 INFO - 'SHELL': '/bin/bash', 17:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:26 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:26 INFO - 'USER': 'cltbld', 17:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:26 INFO - 'XPC_FLAGS': '0x0', 17:00:26 INFO - 'XPC_SERVICE_NAME': '0', 17:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:00:29 INFO - Installing collected packages: mozsystemmonitor 17:00:29 INFO - Running setup.py install for mozsystemmonitor 17:00:29 INFO - Successfully installed mozsystemmonitor 17:00:29 INFO - Cleaning up... 17:00:30 INFO - Return code: 0 17:00:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:00:30 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')]} 17:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 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')]} 17:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:30 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 17:00:30 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 17:00:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:30 INFO - 'HOME': '/Users/cltbld', 17:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:30 INFO - 'LOGNAME': 'cltbld', 17:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:30 INFO - 'MOZ_NO_REMOTE': '1', 17:00:30 INFO - 'NO_EM_RESTART': '1', 17:00:30 INFO - 'PAGER': '/bin/cat', 17:00:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:30 INFO - 'PWD': '/builds/slave/test', 17:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:30 INFO - 'SHELL': '/bin/bash', 17:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:30 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:30 INFO - 'USER': 'cltbld', 17:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:30 INFO - 'XPC_FLAGS': '0x0', 17:00:30 INFO - 'XPC_SERVICE_NAME': '0', 17:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:30 INFO - Downloading/unpacking jsonschema==2.5.1 17:00:30 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 17:00:30 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 17:00:30 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 17:00:30 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 17:00:30 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 17:00:30 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 17:00:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:00:32 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 17:00:32 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 17:00:32 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 17:00:32 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 17:00:32 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 17:00:32 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 17:00:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:33 INFO - warning: no files found matching '*.txt' 17:00:33 INFO - no previously-included directories found matching 'build' 17:00:33 INFO - no previously-included directories found matching 'dist' 17:00:33 INFO - no previously-included directories found matching '.git*' 17:00:33 INFO - Installing collected packages: jsonschema, functools32 17:00:33 INFO - Running setup.py install for functools32 17:00:33 INFO - warning: no files found matching '*.txt' 17:00:33 INFO - no previously-included directories found matching 'build' 17:00:33 INFO - no previously-included directories found matching 'dist' 17:00:33 INFO - no previously-included directories found matching '.git*' 17:00:33 INFO - Successfully installed jsonschema functools32 17:00:33 INFO - Cleaning up... 17:00:33 INFO - Return code: 0 17:00:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:33 INFO - 'HOME': '/Users/cltbld', 17:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:33 INFO - 'LOGNAME': 'cltbld', 17:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:33 INFO - 'MOZ_NO_REMOTE': '1', 17:00:33 INFO - 'NO_EM_RESTART': '1', 17:00:33 INFO - 'PAGER': '/bin/cat', 17:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:33 INFO - 'PWD': '/builds/slave/test', 17:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:33 INFO - 'SHELL': '/bin/bash', 17:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:33 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:33 INFO - 'USER': 'cltbld', 17:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:33 INFO - 'XPC_FLAGS': '0x0', 17:00:33 INFO - 'XPC_SERVICE_NAME': '0', 17:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:00:34 INFO - Cleaning up... 17:00:34 INFO - Return code: 0 17:00:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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', '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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:00: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 blobuploader==1.2.4 17:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:34 INFO - 'HOME': '/Users/cltbld', 17:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:34 INFO - 'LOGNAME': 'cltbld', 17:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:34 INFO - 'MOZ_NO_REMOTE': '1', 17:00:34 INFO - 'NO_EM_RESTART': '1', 17:00:34 INFO - 'PAGER': '/bin/cat', 17:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:34 INFO - 'PWD': '/builds/slave/test', 17:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:34 INFO - 'SHELL': '/bin/bash', 17:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:34 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:34 INFO - 'USER': 'cltbld', 17:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:34 INFO - 'XPC_FLAGS': '0x0', 17:00:34 INFO - 'XPC_SERVICE_NAME': '0', 17:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 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 17:00:36 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 17:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:37 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 17:00:37 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 17:00:37 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 17:00:37 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 17:00:37 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 17:00:37 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 17:00:38 INFO - Downloading docopt-0.6.1.tar.gz 17:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:38 INFO - Running setup.py install for blobuploader 17:00:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:38 INFO - Running setup.py install for requests 17:00:38 INFO - Running setup.py install for docopt 17:00:39 INFO - Successfully installed blobuploader requests docopt 17:00:39 INFO - Cleaning up... 17:00:39 INFO - Return code: 0 17:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:39 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:39 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 17:00:39 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 17:00:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:39 INFO - 'HOME': '/Users/cltbld', 17:00:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:39 INFO - 'LOGNAME': 'cltbld', 17:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:39 INFO - 'MOZ_NO_REMOTE': '1', 17:00:39 INFO - 'NO_EM_RESTART': '1', 17:00:39 INFO - 'PAGER': '/bin/cat', 17:00:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:39 INFO - 'PWD': '/builds/slave/test', 17:00:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:39 INFO - 'SHELL': '/bin/bash', 17:00:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:39 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:39 INFO - 'USER': 'cltbld', 17:00:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:39 INFO - 'XPC_FLAGS': '0x0', 17:00:39 INFO - 'XPC_SERVICE_NAME': '0', 17:00:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:39 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-GSh39P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:39 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-TO8aSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:39 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-9YScW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:39 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-C0AyKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:39 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-8uKLUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:39 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-bQosTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-TtvPR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-Wwr_kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-aG_XBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-gpOPi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-YZyQ9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-Kbn6aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-tob48h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-VYouoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-HPb7dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:40 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-lijR_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:41 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-kZZRxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:41 INFO - Running setup.py install for manifestparser 17:00:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozcrash 17:00:41 INFO - Running setup.py install for mozdebug 17:00:41 INFO - Running setup.py install for mozdevice 17:00:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:41 INFO - Running setup.py install for mozfile 17:00:41 INFO - Running setup.py install for mozhttpd 17:00:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for mozinfo 17:00:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for mozInstall 17:00:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for mozleak 17:00:42 INFO - Running setup.py install for mozlog 17:00:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for moznetwork 17:00:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:42 INFO - Running setup.py install for mozprocess 17:00:42 INFO - Running setup.py install for mozprofile 17:00:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:43 INFO - Running setup.py install for mozrunner 17:00:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:43 INFO - Running setup.py install for mozscreenshot 17:00:43 INFO - Running setup.py install for moztest 17:00:43 INFO - Running setup.py install for mozversion 17:00:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:43 INFO - Cleaning up... 17:00:43 INFO - Return code: 0 17:00:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:43 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')]} 17:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:43 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')]} 17:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:43 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:43 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 17:00:43 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 17:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:43 INFO - 'HOME': '/Users/cltbld', 17:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:43 INFO - 'LOGNAME': 'cltbld', 17:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:43 INFO - 'MOZ_NO_REMOTE': '1', 17:00:43 INFO - 'NO_EM_RESTART': '1', 17:00:43 INFO - 'PAGER': '/bin/cat', 17:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:43 INFO - 'PWD': '/builds/slave/test', 17:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:43 INFO - 'SHELL': '/bin/bash', 17:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:43 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:43 INFO - 'USER': 'cltbld', 17:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:43 INFO - 'XPC_FLAGS': '0x0', 17:00:43 INFO - 'XPC_SERVICE_NAME': '0', 17:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-M49R9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-HzQs7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-bbHamu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-Jk3Nuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-NKmyA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-9caQwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-lohdfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-nCjNFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:44 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)) 17:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:44 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-VQKk5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:45 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)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-Lt_8i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:45 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)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-RmzVLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:45 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)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-D7Sum8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:45 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)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-NBjnJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:45 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)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-VWxwkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-eAb7b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:45 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)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-VXlt9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:45 INFO - Running setup.py (path:/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/pip-lN4hxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:45 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)) 17:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:45 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)) 17:00:45 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)) 17:00:45 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)) 17:00:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:48 INFO - Downloading blessings-1.6.tar.gz 17:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:48 INFO - Installing collected packages: blessings 17:00:48 INFO - Running setup.py install for blessings 17:00:48 INFO - Successfully installed blessings 17:00:48 INFO - Cleaning up... 17:00:48 INFO - Return code: 0 17:00:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:49 INFO - Reading from file tmpfile_stdout 17:00:49 INFO - Current package versions: 17:00:49 INFO - blessings == 1.6 17:00:49 INFO - blobuploader == 1.2.4 17:00:49 INFO - docopt == 0.6.1 17:00:49 INFO - functools32 == 3.2.3-2 17:00:49 INFO - jsonschema == 2.5.1 17:00:49 INFO - manifestparser == 1.1 17:00:49 INFO - mozInstall == 1.12 17:00:49 INFO - mozcrash == 1.0 17:00:49 INFO - mozdebug == 0.1 17:00:49 INFO - mozdevice == 0.48 17:00:49 INFO - mozfile == 1.2 17:00:49 INFO - mozhttpd == 0.7 17:00:49 INFO - mozinfo == 0.9 17:00:49 INFO - mozleak == 0.1 17:00:49 INFO - mozlog == 3.4 17:00:49 INFO - moznetwork == 0.27 17:00:49 INFO - mozprocess == 0.23 17:00:49 INFO - mozprofile == 0.28 17:00:49 INFO - mozrunner == 6.13 17:00:49 INFO - mozscreenshot == 0.1 17:00:49 INFO - mozsystemmonitor == 0.3 17:00:49 INFO - moztest == 0.8 17:00:49 INFO - mozversion == 1.4 17:00:49 INFO - psutil == 3.1.1 17:00:49 INFO - requests == 1.2.3 17:00:49 INFO - wsgiref == 0.1.2 17:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:49 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')]} 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:49 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')]} 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:49 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 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:49 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 17:00:49 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 17:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:49 INFO - 'HOME': '/Users/cltbld', 17:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:49 INFO - 'LOGNAME': 'cltbld', 17:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:49 INFO - 'MOZ_NO_REMOTE': '1', 17:00:49 INFO - 'NO_EM_RESTART': '1', 17:00:49 INFO - 'PAGER': '/bin/cat', 17:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:49 INFO - 'PWD': '/builds/slave/test', 17:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:49 INFO - 'SHELL': '/bin/bash', 17:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:49 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:49 INFO - 'USER': 'cltbld', 17:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:49 INFO - 'XPC_FLAGS': '0x0', 17:00:49 INFO - 'XPC_SERVICE_NAME': '0', 17:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:00:50 INFO - Cleaning up... 17:00:50 INFO - Return code: 0 17:00:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109430490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ead8b1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, '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.225O2pWqAH/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.72OTlEceOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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 17:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:00:50 INFO - 'HOME': '/Users/cltbld', 17:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:00:50 INFO - 'LOGNAME': 'cltbld', 17:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:50 INFO - 'MOZ_NO_REMOTE': '1', 17:00:50 INFO - 'NO_EM_RESTART': '1', 17:00:50 INFO - 'PAGER': '/bin/cat', 17:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:50 INFO - 'PWD': '/builds/slave/test', 17:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:00:50 INFO - 'SHELL': '/bin/bash', 17:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:00:50 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:00:50 INFO - 'USER': 'cltbld', 17:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:50 INFO - 'XPC_FLAGS': '0x0', 17:00:50 INFO - 'XPC_SERVICE_NAME': '0', 17:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:00:51 INFO - Cleaning up... 17:00:51 INFO - Return code: 0 17:00:51 INFO - Running post-action listener: _resource_record_post_action 17:00:51 INFO - Running post-action listener: _start_resource_monitoring 17:00:51 INFO - Starting resource monitoring. 17:00:51 INFO - [mozharness: 2017-02-14 01:00:51.149179Z] Finished create-virtualenv step (success) 17:00:51 INFO - [mozharness: 2017-02-14 01:00:51.150137Z] Running install step. 17:00:51 INFO - Running pre-action listener: _resource_record_pre_action 17:00:51 INFO - Running main action method: install 17:00:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:51 INFO - Reading from file tmpfile_stdout 17:00:51 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:51 INFO - Reading from file tmpfile_stdout 17:00:51 INFO - Output received: 17:00:51 INFO - Usage: mozinstall [options] installer 17:00:51 INFO - Options: 17:00:51 INFO - -h, --help show this help message and exit 17:00:51 INFO - -d DEST, --destination=DEST 17:00:51 INFO - Directory to install application into. [default: 17:00:51 INFO - "/builds/slave/test"] 17:00:51 INFO - --app=APP Application being installed. [default: firefox] 17:00:51 INFO - mkdir: /builds/slave/test/build/application 17:00:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:01:12 INFO - Reading from file tmpfile_stdout 17:01:12 INFO - Output received: 17:01:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:01:12 INFO - Running post-action listener: _resource_record_post_action 17:01:12 INFO - [mozharness: 2017-02-14 01:01:12.730292Z] Finished install step (success) 17:01:12 INFO - [mozharness: 2017-02-14 01:01:12.730452Z] Running run-tests step. 17:01:12 INFO - Running pre-action listener: _resource_record_pre_action 17:01:12 INFO - Running main action method: run_tests 17:01:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:01:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:01:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:01:12 INFO - 2017-02-13 17:01:12.745 screenresolution[1621:7424] starting screenresolution argv=screenresolution get 17:01:12 INFO - 2017-02-13 17:01:12.747 screenresolution[1621:7424] Display 0: 1600x1200x32@60 17:01:12 INFO - 2017-02-13 17:01:12.753 screenresolution[1622:7427] starting screenresolution argv=screenresolution list 17:01:12 INFO - Available Modes on Display 0 17:01:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:01:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:01:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:01:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:01:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:01:12 INFO - Intel Iris: 17:01:12 INFO - Chipset Model: Intel Iris 17:01:12 INFO - Type: GPU 17:01:12 INFO - Bus: Built-In 17:01:12 INFO - VRAM (Dynamic, Max): 1536 MB 17:01:12 INFO - Vendor: Intel (0x8086) 17:01:12 INFO - Device ID: 0x0a2e 17:01:12 INFO - Revision ID: 0x0009 17:01:12 INFO - Displays: 17:01:12 INFO - Display: 17:01:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:01:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:01:12 INFO - Display Serial Number: 1600x1200 60 17:01:12 INFO - Main Display: Yes 17:01:12 INFO - Mirror: Off 17:01:12 INFO - Online: Yes 17:01:12 INFO - Rotation: Supported 17:01:12 INFO - Return code: 0 17:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:01:12 INFO - Python 2.7.3 17:01:12 INFO - Return code: 0 17:01:12 INFO - grabbing minidump binary from tooltool 17:01:12 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')]} 17:01:12 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 0x109244d30>, '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 0x1090aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10923cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:01:12 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 17:01:12 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 17:01:12 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 17:01:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:01:13 INFO - Return code: 0 17:01:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:01:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:01:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:01:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:01:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 17:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 17:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.225O2pWqAH/Render', 17:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:01:13 INFO - 'HOME': '/Users/cltbld', 17:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:01:13 INFO - 'LOGNAME': 'cltbld', 17:01:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:01:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:13 INFO - 'MOZ_NO_REMOTE': '1', 17:01:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:01:13 INFO - 'NO_EM_RESTART': '1', 17:01:13 INFO - 'PAGER': '/bin/cat', 17:01:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:13 INFO - 'PWD': '/builds/slave/test', 17:01:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:01:13 INFO - 'SHELL': '/bin/bash', 17:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.72OTlEceOp/Listeners', 17:01:13 INFO - 'TMPDIR': '/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/', 17:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:01:13 INFO - 'USER': 'cltbld', 17:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:13 INFO - 'XPC_FLAGS': '0x0', 17:01:13 INFO - 'XPC_SERVICE_NAME': '0', 17:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:01:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 17:01:13 INFO - mozversion application_buildid: 20170213141724 17:01:13 INFO - mozversion application_changeset: bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8 17:01:13 INFO - mozversion application_display_name: Firefox 17:01:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:01:13 INFO - mozversion application_name: Firefox 17:01:13 INFO - mozversion application_remotingname: firefox 17:01:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:01:13 INFO - mozversion application_vendor: Mozilla 17:01:13 INFO - mozversion application_version: 52.0 17:01:13 INFO - mozversion platform_buildid: 20170213141724 17:01:13 INFO - mozversion platform_changeset: bd9cd325c4bca4a9f0256d9300c7ac00dd9bf7a8 17:01:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:01:13 INFO - mozversion platform_version: 52.0 17:01:13 INFO - using testdate: 1487034073 17:01:13 INFO - actual date: 1487034073 17:01:13 INFO - starting webserver on 'localhost:49246' 17:01:13 INFO - SUITE-START | Running 2 tests 17:01:13 INFO - TEST-START | dromaeo_css 17:01:13 INFO - operating with platform_type : mac_ 17:01:13 INFO - Initialising browser for dromaeo_css test... 17:01:13 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/tmpUM07S8/profile http://localhost:49246/getInfo.html) 17:01:16 INFO - PROCESS | 1632 | 2017-02-13 17:01:16.453 plugin-container[1635:7609] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 17:01:16 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:01:16 INFO - PROCESS | 1632 | 2017-02-13 17:01:16.453 plugin-container[1635:7609] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 17:01:16 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:01:16 INFO - PROCESS | 1632 | 2017-02-13 17:01:16.454 plugin-container[1635:7609] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:01:16 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 17:01:16 INFO - PROCESS | 1632 | colorDepth:24 17:01:16 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 17:01:16 INFO - PROCESS | 1632 | __metrics 17:01:16 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 17:01:17 INFO - TEST-INFO | 1632: exit 0 17:01:17 INFO - Browser initialized. 17:01:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:01:17 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/tmpUM07S8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:20 INFO - PROCESS | 1636 | 2017-02-13 17:01:20.028 plugin-container[1637:7740] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 17:01:20 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:01:20 INFO - PROCESS | 1636 | 2017-02-13 17:01:20.029 plugin-container[1637:7740] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x421f, name = 'com.apple.CFPasteboardClient' 17:01:20 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:01:20 INFO - PROCESS | 1636 | 2017-02-13 17:01:20.029 plugin-container[1637:7740] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:01:29 INFO - PROCESS | 1636 | RSS: Main: 177143808 17:01:29 INFO - PROCESS | 1636 | 17:04:30 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 17:04:32 INFO - PROCESS | 1636 | RSS: Main: 184725504 17:04:32 INFO - PROCESS | 1636 | 17:07:35 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 17:07:35 INFO - PROCESS | 1636 | RSS: Main: 193699840 17:07:35 INFO - PROCESS | 1636 | 17:10:37 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 17:10:38 INFO - PROCESS | 1636 | RSS: Main: 195637248 17:10:38 INFO - PROCESS | 1636 | 17:13:40 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 17:13:40 INFO - PROCESS | 1636 | RSS: Main: 199213056 17:13:40 INFO - PROCESS | 1636 | 17:16:43 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 17:16:44 INFO - PROCESS | 1636 | RSS: Main: 201527296 17:16:44 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 17:19:46 INFO - PROCESS | 1636 | RSS: Main: 201744384 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | __start_tp_report 17:19:46 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 17:19:46 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 17:19:46 INFO - PROCESS | 1636 | |i|pagename|runs| 17:19:46 INFO - PROCESS | 1636 | |0;dojo.html;2934.794564380494;3016.336405990681;3540.716742660587;3581.426971684531;3588.694960928321;5777.76888924443;5804.854878628036;5877.235959325287;5918.674472903988;5920.822375328737;5916.88166236675;5945.346011938684;5958.8808223835495;5977.312609049961;5986.760529578823;4461.3531037999555;4965.776540055688;5411.945880541203;5420.864478388033;5463.590230732691;5424.972875135619;5451.233813218901;5469.206964990074;5497.120460726284;5528.391876893538;5318.946810531884;5334.733263336818;5466.781328746845;5469.507744303012;5475.288212532385;5354.196870469422;5367.892642147174;5414.539764120015;5451.918221226685;5501.944980550184;5302.814401495968;5395.10980688186;5407.080796264644;5409.6213265071465;5436.994156081138;5691.260136182311;5880.6765627890445;5924.933511967844;5987.491063259628;5995.940040599582;6161.507079433634;6229.4704950079295;6239.438450539473;6317.778877739257;6334.398232167937;6288.748450061992;6295.181626388586;6312.779052733178;6319.431251187415;6319.684015799237;5968.492678122365;5992.310884248367;5995.340512543617;6005.039193728982;6005.579609427298;6201.193844800147;6208.906866397007;6286.49708023357;6290.21372328459;6319.6208227506495;6266.592671476339;6301.590396624205;6310.5898116622275;6311.116443697886;6315.905261421082;6316.399942005502;6320.905186422207;6340.239171299381;6348.174737284216;6348.333424990402;6131.896637733196;6152.569320147636;6179;6192.164057852132;6235.345288744707;6237.251529816361;6285.120083188357;6296.275928268216;6302.275238347649;6306.527010474233;4986.152354099811;5020.59835213182;5021.171506701427;5023.196288593807;5029.321041659329;4448.532904045093;4453.4433195850515;4476.865694029184;4531.682782205214;4532.5694059064335;5807.361190269067;5864.912026319608;5939.346671866091;5987.491063259672;6025.457708806229;6256.937430625727;6274.717637706223;6287.49700023997;6289.339619339995;6341.017142342944;5769.874874399536;5831.562632802472;5867.853303667443;5934.703264836741;5940.405959404112;5536.640118392292;5552.944470555242;5564.165375193753;5567.276254086943;5572.693501857356;6398.2322121344805;6428.967855160694;6433.260175079926;6441.1304473895425;6451.3548645135115;6154.107654390178;6167.814965551041;6212.347703491068;6260.248770147611;6308.589941653778;6396.232452105777;6408.679566021773;6423.164988551458;6446.323136070645;6455.806325810233;4757.738324392191;5169.4830516949505;5552.7778888843995;6322.399372059647;6328.493720502441;6160.753569857335;6210.5652604317265;6245.313015568375;6275.309715931153;6303;6062.120992455981;6289.874202515833;6309.810705678837;6311.779087731908;6316.368363163647;6210.875782484415;6236.095766113797;6286.497080233662;6293.244810622755;6294.307626161027;5834.854128646818;6035.668038257938;6090.177825993434;6126.1423400724825;6184.505239580732;5023.799048038038;6150.846228844136;6159.014557670751;6164.7842325518395;6170.568060235741;6127.158986117617;6128.136482154648;6141.792871882774;6146;6161 17:19:46 INFO - PROCESS | 1636 | |1;ext.html;480.67314226326096;487.46865916151387;507.29486014439914;548.6324162810917;550.0456707612294;38870.61129388705;40492.78521644352;40732.77801665951;42468.362974555406;42537.7873110634;41804.37293440593;42416.78791606038;42424;42425.93935151623;42463.3630495542;9554.761130971747;9726.465044422554;9727.221822254203;9741;9756.365836220659;9682.854757178648;9784.706458806211;9785.315027948047;9788.902110978906;9795.706128816148;9733.124018838304;9765;9765.902340976605;9774.462404567746;9809.558569864374;9729.464879431629;9748.610055597768;9766.462844543546;9794.265430092735;9818.950905245429;9340.299477539213;9379.01520340368;9405.106514881076;9433.764155896157;9512.857307140399;39790;39850;39902.80048599738;40063.99840003994;40231.7988410059;3348.9497657535157;3483.5819701635965;3513.0514761014383;3547.6984456321243;3724.888253352404;30194.84902575495;30456;30616.928407505853;30808.767649294;31048.689513104804;2558.5522533556555;2600.2849216465434;3143.874245030196;3285.917852053718;3307.603087629476;396628;469206;486034;489500.99999999645;490772;62105;62466.375336246965;62665.37334626687;62811.05783413252;62863.799767007935;63672.681636592446;64738.67630661817;64873;64887;65059.67470162713;14968.550943471713;16217.51347459578;16907.91546042262;16963.491095267163;17093.57266068358;12562;12862.292573908524;13011.21932684042;13076.542321018718;13108.80336794949;17597.994768548706;18993.05034748257;19007.38437232823;19107.90446047761;19217;7940.682372705142;7968.322692571081;8122.675092996332;8168.754937351889;8269.568129226423;854.7905763088083;897.8518544440094;965.290511474066;984.2077127911956;1093.3439936038314;26853.791579378976;29776.10671679853;29874.551881721793;30136;30456.086317410514;777.6928113395177;915.4736026784492;1002.9218590015762;1062.5484169228048;1094.6332978452308;15706.9214653926;15743.68512629764;15820.525384238492;15822.60443488922;16130.032198068153;610048;616993;624535.7546424569;624923;625648;58208;58254;58396.24811255584;58402;58544;1380.6341319550327;1386.660268234289;1405.6837211627303;1415;1418.099506813181;29211.415771684024;29986.400271994873;30004.699953001065;30026.699733003265;30540.236494087825;48788.512114878395;48846.755766220944;49681.50318496769;49828;49910.25314113989;540475;542800;548424;548794;549692;26313.21060368192;26688.733112668626;26701.599476007486;26785.866070669523;27474;45729;45922.54077459183;46759.76620116878;46816.53183468122;47062.294065589726;37950.62049379581;38389;39196.80401597974;39830.60169398269;40222.19000144942;38353.23293534169;38699.41950870683;38746.80626596849;39012;39723;38069.80965095157;38145.427818583295;38495;38551;38606;28306.575401368584;34588.65411345854;34645.65354346424;35195.82402087973;35199.47200791939;20291.79708202958;25661.3584660385;25762.742372576035;25893.6115958257;26250.606240906785 17:19:46 INFO - PROCESS | 1636 | |2;jquery.html;380.77914809410544;382.59064284125435;387.42080589518673;394.8262764383671;415.4889485932303;16706;16946.152692365362;19157.04214789262;20527.897360513194;20549.589008219828;11820.881791182086;12102.515899364014;12152.392380380968;13024.869751302484;20544.280950166747;5471.452854714526;5564.972175139139;5671.631343962629;5679.858003549903;5686.0617998030275;5562.360328562207;5865.736041878125;6141.662208578527;6195.659238741868;6270.372962703739;5211.42674305826;5759.568032397566;6216.627002379849;6229.1902052733085;6239.563230573862;5248.396434410053;5530.336359636829;6122.663253521055;6234.719437625317;6245.6252624842655;5159.277701121846;5290.576753859682;5579.832605021856;6051.697415129226;6088.269407671108;13254.66863328415;13291.86708132916;13374.598762037154;13487.325633718276;13542.119762215523;2195.4621117826077;2277.6128058230142;2293.5183611441616;2460.4095017195923;2667.66654168229;9973.152282056033;10083.697489075266;10094.697159085166;10114.9494252529;10338.793224135476;1800.1449311577028;1857.3220774417375;1867.8038805925319;1951.1219951022097;2012.6779715245636;105805.94194058038;126883;130316.69683303236;130883;141120;21263.68104478434;21785.019674114705;22214.55570888573;22469.325920222418;22485.88757056204;35947.82026089853;36038.63961360405;36455.635443645755;36508.45237321442;36607.718729844324;9041.547922603844;10142.594296228215;11043.392613406178;11246.1565382595;11272.436378181059;7081.822954426078;8405.949256342958;9162.587683554257;9272.490013049348;9279.211267042378;9698.224142068617;10168.796624067478;10188.643397481053;10200.724909386327;10219.437930913871;3865.8840234793;3981.5222173339384;3984.8007599620482;3991.5409727881665;3992.181602771425;838.3377132065722;880.5377176982007;916.3677062826629;982.7936133412063;1009.65671671632;20257.189712411633;21365.46586335354;22052.032326127748;22298.44253893633;23045.732484713502;896.8340856941487;1014.9441780702132;1017.5370206555999;1017.8524114003576;1047.5914393386586;10530.736731581772;11192.720181995352;11240.943795280971;11303.982641562134;11335.603253886075;582462;590517;605253;610158;616449;67320;108083.70744110167;140982.29508852595;142097;149060;961.8653388525612;1000.7398076500308;1004.6935684616116;1005.939643621385;1014.031599822168;16168.67662646764;17817.93092414459;18977;19418.90290548538;19495.317663881695;56365.436345636015;56661.71669141628;57848.71075644595;58382.4161758377;58722;81876.18123818685;84700;85188;85914;86371.56814215888;7862.685492580233;8008.719694810887;8142.307903828004;8193.262606365455;8214.055383630719;10204.38773673582;11462.197646164688;12438.315892625993;12517;12640.620781376574;10414.843777343194;10423.21825863048;10608.575656973635;10696.358218506915;10901.672949811518;9845.163161131384;9906.554205060933;9916.355436896578;10000.099991000845;10026.899731002597;10758.515866785858;10767.300125491818;11000.174986876176;11098.944505277423;11154.498047587716;7932.960335198287;7955.602219889098;8033;8265.504069755834;8300.667973281;7917.168697286702;9386.95306523463;10647.840282395926;10657.307275027099;10855.023047925724 17:19:46 INFO - PROCESS | 1636 | |3;mootools.html;1318.498970391251;1490.0538158269496;1677.8238284980077;1854.3417086934146;1906.8283854453096;7736.38108951284;7978.561179135145;8262.132476090006;8736.21374076333;8754.212120909116;6822.454203663708;8442.155784421555;8467.98384193896;8541.359398045155;8545.572721363938;2345.589521833681;2389.880505974703;2395.8203134764876;2396.149366974725;2396.940076498084;2397.3766820626674;2421.152596591188;2432.1852179519883;2434.5982912819363;2440.9389765255833;2374.465745207332;2375.714914210297;2393.4614711689906;2402.5915594348917;2408.4460574067975;2343.9648405273933;2347.049444974788;2350.0834674476796;2357.705286839145;2387.7373488916205;2384.8569085854906;2398.1606437746823;2417.6857008588945;2417.92746217612;2422.5881600127846;8451.028131764802;8504.447210931332;8568.528730919797;8605.526696031779;8680.479171249683;5134.948650513522;5282.7622756976025;5289.497497737709;5320.973395133038;5409.188621706776;3476.89569312921;3538.150843797496;3538.3630946429635;3608.1520842601967;3624.003399065252;1024.6157690865925;1032.02989190161;1076.2358725305044;1109.3233127792041;1116.7878103160374;11085.612003579916;11157.553697852076;11165.106791456745;11216.551337946472;11276.830847537294;4529.207388706963;4629.537046295343;4732.692374995683;4746.28805679144;4797.688150270221;9618.278629102706;9636.988116247834;9650.179734722627;9651.90348096524;9659.517024148765;5268.578513718893;5323.893522129536;5325.680459172462;5339.919901201485;5397.78408863641;4352.630026447788;4378.10248898975;4754.95245047552;4811.615070794328;4868.367112275381;3861.9034524137123;3911.5892831252877;3984.7808370539897;4000.5599384067727;4005.539362973237;1286.3696788573532;1300.63582196985;1303.0422639360252;1317.2030921292671;1319.5381616434172;806.1253539909147;883.4655033704645;884.8628462588309;911.0070023674227;915.771057235691;4730.290456431563;5566.35986861508;5678.063119585305;5760.596758226968;5862.091375836752;843.8396704626101;957.8132264208551;976.1800087926176;1001.5743309093606;1066.6693325069098;3027.2885871820104;3583.104223944014;3585.928281434357;3631.800250986168;3793.430985352219;9957.452340121363;10365.533550990223;10373.792524149474;10375.533101010473;10432.478376081166;10046.69859904204;10234.846477302846;10332.276740628084;10385.2211084169;10413.42726150069;7840.294373506412;7864.331531819745;7867.803304917308;8031.196880311922;8117.675292988214;5424.918626220531;5516.641418307797;5575.0243707351865;5604.8318550443555;5722.998475266895;9365.812683746151;9468.905310946802;9511.857322140035;9530.142287193908;9657.517124143624;9222.40054396462;9625.422474651543;9631.470269135265;9750.951245243728;9833.557489912828;6784.559003664746;6922.723091076502;7100.680469378787;7288.781336559911;7380.852382952204;7864.567448790372;8137.430379873352;8144.837103257783;8145.470544414594;8157.714479993172;7167.068281123421;7300.393913339057;7326.890096648448;7381.966524686441;7434.256574342522;5482.972585137209;7036.964815175891;7113.75101871432;7142.357187853118;7287.27127287267;6758.797236082925;6767.763128290486;6843.7604683835825;6852.0749698792015;6879.105716256855;4655.06898620284;4674.485806561208;4735.337052812678;4736.952630473651;4741.478437371818;4682.953170468251;4703.294505824154;4735;4891.241857512091;4932.136876046749 17:19:46 INFO - PROCESS | 1636 | |4;prototype.html;251.3853627879832;269.32399676811224;312.1182658988358;317.5332261575483;324.16042450054357;5312.309399778023;5481.5340696040785;5506.449355064497;5543.916841247379;5618.77524899004;4836.516348365161;4956.752162391884;5456.7544460499275;5478.753456094475;5565.888682226353;3639.636036396366;4015.437838702584;4227.788610569474;4254.234237837188;4278.358246263055;3396.371671240828;4027.919441611166;4263.658907287409;4280.186764514748;4280.443542339492;4137.303705480754;4148.522919864224;4151.23202207591;4184.435101261336;4222.725522841006;4143.82449214162;4148.419221309019;4198.999999999969;4205.3481710334945;4216.262154123016;2971.762259019295;3573.4282514797505;3644.7084233261276;3657.3782456982112;3669.908252293714;5052.671576347526;5208.322918020633;5278.627556835212;5336.706481143536;5424.457554244584;3504.8981651238582;4454.754988475633;4674.415698037746;4692.507286734878;4748.287756836467;4915.967646794177;5725.1698503716725;5752.712364381764;5760.020796464569;5789.65262084272;3787.3750831112834;3952.7628342299554;3955.6044395560502;3986.40203969404;3986.886949916549;4698;5868.647881127146;6123.693815309217;6154.44609985099;6225.548732656172;4015.4177644242004;4018.65375099345;4028.5568587455355;4051.372037334218;4082;3782.2624588205035;3944.2703099926607;4050.6354428101613;4093.3655283431117;4122.546519882811;4138.482689663792;4673.60274376675;4734.928976065362;4787.640926930494;4803;5128.615353848476;5508.595308196384;5649.389923871759;5837.532997360201;5942.8811423771285;1088.9074428673493;1249.5064449542563;1269.4702883025932;1272.338384040294;1287.7939529675207;789.1674283630824;877.6708734224666;892.5585179934488;903.421810041574;904.3172404834309;4576.565226303496;4659.370984916993;5068.366454193226;5156.272648662665;5198.792048318101;4901.50984901507;5216.63483556155;5404.108322126884;5664.405237450091;5707.942920570741;4875.585575226146;4940.590053890984;5059.87350316245;5089.702125957857;5234.895302093937;2940.2502361897577;2958.0238521287924;3008.5787989681025;3072.4008818280668;3083.367909578531;5650.971745141248;5651.576131790132;5990.041593345131;6060.909086363708;6189.96905015481;4856.576113839735;5187.054854429589;5220.9738951305;5458.836234912959;5860.015189671065;4718.764061796896;5401.5948803839865;5513.807016754475;6055.364186760415;6084.482818960438;4746.8164644264025;5299.655522391032;5596.9571106545;5713.057345538106;5881.588288819741;4486.64106871456;5012.491256120657;5462;5703.287089113861;5782.913256301243;5142.64001519905;6022.90965635507;6064.786352981218;6070.544709146743;6149.877002460015;3421.7091547218765;3770.3024940386117;3817.732758706864;3829.693624509977;3896.298666239991;5670.74481648335;5885.411458854081;5986.820395387971;5987.31145918225;5996.102533353355;4861.368022157097;5955.612885162624;5968.283805943314;5980.192673988956;6051.186198417757;5142.871428214325;5702.914456283242;5707.914381284201;5823.155642431909;5890;4797.8080876765935;5407.78368865241;5715.199552219299;5790.160426738184;5801.738921748616;4882.2432522959;4917.778699958439;5872.354041055395;5937.3468918418075;5958.603595950267;4803.327534145153;5748.310202775694;5825.854353641023;5843.912341314969;5925.881482370414 17:19:46 INFO - PROCESS | 1636 | |5;yui.html;700.6986995591897;733.1605311917854;769.6113462701335;771.2942657468417;832.1345800367618;14586.854131458682;15111.546653600382;15228.314725837336;15278.46525371611;15335.309911054;12316.5073397064;13869.514566990158;14044.157350558973;15383.846161538382;15409.998350107235;804.2158895077297;818.3207937411963;827.8592639251342;828.6188353357433;829.2163905109674;805.3718099882072;813.1786895235825;815.4536460571402;815.7348861619968;816.244973399606;824.4846970643348;846.0608724316004;849.6686292345959;852.4629483425433;853.0914575976565;819.7622689420091;829.713748756678;844.3751623798406;849.902261239953;850.37497439382;624.3257282135284;626.8338890194102;628.3684896678855;631.0439683878927;631.2488139114439;14633.853661463356;14736;14745.631359215999;14753.631159221106;14763.26183690822;14177.362018709182;14427.78358324626;14490.42038318466;14521.78217326741;14537.491187808377;11182.105431565455;11194.720131996684;11205.327680339205;11582.594609188638;11704.122190835722;3660.68884144848;3673.8163091845568;3701.0747313171705;3730.1793605406765;3748.456473811282;89218;95385;95539.0446095537;96901;97084;10948.178886583539;11114.610988615521;11160.776784464428;11162.162837787198;11206;21764.673529897063;21976.780232197474;21978.780212197995;22238;22244.66633000474;7616.314531692175;7782;7846.489978151402;8034.879476807736;8105.311048560939;4333.393324934512;4344.196323680129;4379.934300985487;4437.378766972626;4452.8218871245435;3428.708559772447;3479.9560131960816;3505.8948231553095;3534.8939531814085;3568.2506673598314;584.4155844155844;626.0015275635354;631.9557630965788;643.7585905285518;651.8272657745702;612.5405945540845;635.9077933699588;651.5992664511291;670.6914819183132;684.6097724297202;9015.684451044182;9085.36402451822;9454.196393306509;9530.618775249051;9552.665656701982;638.4381744065192;644.690548536705;666.6067020457953;671.70445004198;671.9227288861746;3864.71014673895;4400.471943366816;4594.356790049395;4980.5019498049905;4990;80260.79608805872;80336;102466.46300305502;104703;105390;27039.864800676263;27350.863245683646;56670.716646416506;70991;83688.58155709182;79631.60184199041;81621.36757264822;81725;82937;84720.57639711886;8271.669133234604;9586.945436002174;9999.35004224723;10003;10017.949910250401;48440.03119937652;51376.74311628418;51875.74062129665;52096;53358;71955;73440.63279683568;75215;77357;77704;12408.498836114886;12543.372831358578;12653;12929.353532323157;13166.144200626928;14123.43506259738;14181.007329486836;14327;14515;15291;12851.513256504262;13327.866721332663;13583.45666173342;13665.248411337472;14167.574972750834;12016.038716902453;13246.801297980346;13364.064515483822;13687.931560342135;14028.08817426864;12632.431540580512;13207.801882971571;13469.865301346861;13935.721285574435;13990.790138147733;10454;10973.982154907464;11125.888741112485;11398.245963723406;11939.880601193878;11394.430278485877;11419.37193454368;11615.941920290345;11706.76586468283;11731.648050558497 17:19:46 INFO - PROCESS | 1636 | __end_tp_report 17:19:46 INFO - PROCESS | 1636 | __start_cc_report 17:19:46 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,352 17:19:46 INFO - PROCESS | 1636 | __end_cc_report 17:19:46 INFO - PROCESS | 1636 | __startTimestamp1487035186924__endTimestamp 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | ------- Summary: start ------- 17:19:46 INFO - PROCESS | 1636 | Number of tests: 6 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5834.68 Median:6090.18 stddev:655.58 (10.8%) stddev-sans-first:616.86 17:19:46 INFO - PROCESS | 1636 | Values: 2934.8 3016.3 3540.7 3581.4 3588.7 5777.8 5804.9 5877.2 5918.7 5920.8 5916.9 5945.3 5958.9 5977.3 5986.8 4461.4 4965.8 5411.9 5420.9 5463.6 5425.0 5451.2 5469.2 5497.1 5528.4 5318.9 5334.7 5466.8 5469.5 5475.3 5354.2 5367.9 5414.5 5451.9 5501.9 5302.8 5395.1 5407.1 5409.6 5437.0 5691.3 5880.7 5924.9 5987.5 5995.9 6161.5 6229.5 6239.4 6317.8 6334.4 6288.7 6295.2 6312.8 6319.4 6319.7 5968.5 5992.3 5995.3 6005.0 6005.6 6201.2 6208.9 6286.5 6290.2 6319.6 6266.6 6301.6 6310.6 6311.1 6315.9 6316.4 6320.9 6340.2 6348.2 6348.3 6131.9 6152.6 6179.0 6192.2 6235.3 6237.3 6285.1 6296.3 6302.3 6306.5 4986.2 5020.6 5021.2 5023.2 5029.3 4448.5 4453.4 4476.9 4531.7 4532.6 5807.4 5864.9 5939.3 5987.5 6025.5 6256.9 6274.7 6287.5 6289.3 6341.0 5769.9 5831.6 5867.9 5934.7 5940.4 5536.6 5552.9 5564.2 5567.3 5572.7 6398.2 6429.0 6433.3 6441.1 6451.4 6154.1 6167.8 6212.3 6260.2 6308.6 6396.2 6408.7 6423.2 6446.3 6455.8 4757.7 5169.5 5552.8 6322.4 6328.5 6160.8 6210.6 6245.3 6275.3 6303.0 6062.1 6289.9 6309.8 6311.8 6316.4 6210.9 6236.1 6286.5 6293.2 6294.3 5834.9 6035.7 6090.2 6126.1 6184.5 5023.8 6150.8 6159.0 6164.8 6170.6 6127.2 6128.1 6141.8 6146.0 6161.0 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:68334.64 Median:40362.29 stddev:146307.87 (362.5%) stddev-sans-first:146629.60 17:19:46 INFO - PROCESS | 1636 | Values: 480.7 487.5 507.3 548.6 550.0 38870.6 40492.8 40732.8 42468.4 42537.8 41804.4 42416.8 42424.0 42425.9 42463.4 9554.8 9726.5 9727.2 9741.0 9756.4 9682.9 9784.7 9785.3 9788.9 9795.7 9733.1 9765.0 9765.9 9774.5 9809.6 9729.5 9748.6 9766.5 9794.3 9819.0 9340.3 9379.0 9405.1 9433.8 9512.9 39790.0 39850.0 39902.8 40064.0 40231.8 3348.9 3483.6 3513.1 3547.7 3724.9 30194.8 30456.0 30616.9 30808.8 31048.7 2558.6 2600.3 3143.9 3285.9 3307.6 396628.0 469206.0 486034.0 489501.0 490772.0 62105.0 62466.4 62665.4 62811.1 62863.8 63672.7 64738.7 64873.0 64887.0 65059.7 14968.6 16217.5 16907.9 16963.5 17093.6 12562.0 12862.3 13011.2 13076.5 13108.8 17598.0 18993.1 19007.4 19107.9 19217.0 7940.7 7968.3 8122.7 8168.8 8269.6 854.8 897.9 965.3 984.2 1093.3 26853.8 29776.1 29874.6 30136.0 30456.1 777.7 915.5 1002.9 1062.5 1094.6 15706.9 15743.7 15820.5 15822.6 16130.0 610048.0 616993.0 624535.8 624923.0 625648.0 58208.0 58254.0 58396.2 58402.0 58544.0 1380.6 1386.7 1405.7 1415.0 1418.1 29211.4 29986.4 30004.7 30026.7 30540.2 48788.5 48846.8 49681.5 49828.0 49910.3 540475.0 542800.0 548424.0 548794.0 549692.0 26313.2 26688.7 26701.6 26785.9 27474.0 45729.0 45922.5 46759.8 46816.5 47062.3 37950.6 38389.0 39196.8 39830.6 40222.2 38353.2 38699.4 38746.8 39012.0 39723.0 38069.8 38145.4 38495.0 38551.0 38606.0 28306.6 34588.7 34645.7 35195.8 35199.5 20291.8 25661.4 25762.7 25893.6 26250.6 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:36030.29 Median:2285.57 stddev:100534.96 (4398.7%) stddev-sans-first:100781.35 17:19:46 INFO - PROCESS | 1636 | Values: 380.8 382.6 387.4 394.8 415.5 16706.0 16946.2 19157.0 20527.9 20549.6 11820.9 12102.5 12152.4 13024.9 20544.3 5471.5 5565.0 5671.6 5679.9 5686.1 5562.4 5865.7 6141.7 6195.7 6270.4 5211.4 5759.6 6216.6 6229.2 6239.6 5248.4 5530.3 6122.7 6234.7 6245.6 5159.3 5290.6 5579.8 6051.7 6088.3 13254.7 13291.9 13374.6 13487.3 13542.1 2195.5 2277.6 2293.5 2460.4 2667.7 9973.2 10083.7 10094.7 10114.9 10338.8 1800.1 1857.3 1867.8 1951.1 2012.7 105805.9 126883.0 130316.7 130883.0 141120.0 21263.7 21785.0 22214.6 22469.3 22485.9 35947.8 36038.6 36455.6 36508.5 36607.7 9041.5 10142.6 11043.4 11246.2 11272.4 7081.8 8405.9 9162.6 9272.5 9279.2 9698.2 10168.8 10188.6 10200.7 10219.4 3865.9 3981.5 3984.8 3991.5 3992.2 838.3 880.5 916.4 982.8 1009.7 20257.2 21365.5 22052.0 22298.4 23045.7 896.8 1014.9 1017.5 1017.9 1047.6 10530.7 11192.7 11240.9 11304.0 11335.6 582462.0 590517.0 605253.0 610158.0 616449.0 67320.0 108083.7 140982.3 142097.0 149060.0 961.9 1000.7 1004.7 1005.9 1014.0 16168.7 17817.9 18977.0 19418.9 19495.3 56365.4 56661.7 57848.7 58382.4 58722.0 81876.2 84700.0 85188.0 85914.0 86371.6 7862.7 8008.7 8142.3 8193.3 8214.1 10204.4 11462.2 12438.3 12517.0 12640.6 10414.8 10423.2 10608.6 10696.4 10901.7 9845.2 9906.6 9916.4 10000.1 10026.9 10758.5 10767.3 11000.2 11098.9 11154.5 7933.0 7955.6 8033.0 8265.5 8300.7 7917.2 9387.0 10647.8 10657.3 10855.0 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5528.69 Median:4911.69 stddev:3041.09 (61.9%) stddev-sans-first:3033.16 17:19:46 INFO - PROCESS | 1636 | Values: 1318.5 1490.1 1677.8 1854.3 1906.8 7736.4 7978.6 8262.1 8736.2 8754.2 6822.5 8442.2 8468.0 8541.4 8545.6 2345.6 2389.9 2395.8 2396.1 2396.9 2397.4 2421.2 2432.2 2434.6 2440.9 2374.5 2375.7 2393.5 2402.6 2408.4 2344.0 2347.0 2350.1 2357.7 2387.7 2384.9 2398.2 2417.7 2417.9 2422.6 8451.0 8504.4 8568.5 8605.5 8680.5 5134.9 5282.8 5289.5 5321.0 5409.2 3476.9 3538.2 3538.4 3608.2 3624.0 1024.6 1032.0 1076.2 1109.3 1116.8 11085.6 11157.6 11165.1 11216.6 11276.8 4529.2 4629.5 4732.7 4746.3 4797.7 9618.3 9637.0 9650.2 9651.9 9659.5 5268.6 5323.9 5325.7 5339.9 5397.8 4352.6 4378.1 4755.0 4811.6 4868.4 3861.9 3911.6 3984.8 4000.6 4005.5 1286.4 1300.6 1303.0 1317.2 1319.5 806.1 883.5 884.9 911.0 915.8 4730.3 5566.4 5678.1 5760.6 5862.1 843.8 957.8 976.2 1001.6 1066.7 3027.3 3583.1 3585.9 3631.8 3793.4 9957.5 10365.5 10373.8 10375.5 10432.5 10046.7 10234.8 10332.3 10385.2 10413.4 7840.3 7864.3 7867.8 8031.2 8117.7 5424.9 5516.6 5575.0 5604.8 5723.0 9365.8 9468.9 9511.9 9530.1 9657.5 9222.4 9625.4 9631.5 9751.0 9833.6 6784.6 6922.7 7100.7 7288.8 7380.9 7864.6 8137.4 8144.8 8145.5 8157.7 7167.1 7300.4 7326.9 7382.0 7434.3 5483.0 7037.0 7113.8 7142.4 7287.3 6758.8 6767.8 6843.8 6852.1 6879.1 4655.1 4674.5 4735.3 4737.0 4741.5 4683.0 4703.3 4735.0 4891.2 4932.1 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4608.81 Median:5064.12 stddev:1422.24 (28.1%) stddev-sans-first:1388.11 17:19:46 INFO - PROCESS | 1636 | Values: 251.4 269.3 312.1 317.5 324.2 5312.3 5481.5 5506.4 5543.9 5618.8 4836.5 4956.8 5456.8 5478.8 5565.9 3639.6 4015.4 4227.8 4254.2 4278.4 3396.4 4027.9 4263.7 4280.2 4280.4 4137.3 4148.5 4151.2 4184.4 4222.7 4143.8 4148.4 4199.0 4205.3 4216.3 2971.8 3573.4 3644.7 3657.4 3669.9 5052.7 5208.3 5278.6 5336.7 5424.5 3504.9 4454.8 4674.4 4692.5 4748.3 4916.0 5725.2 5752.7 5760.0 5789.7 3787.4 3952.8 3955.6 3986.4 3986.9 4698.0 5868.6 6123.7 6154.4 6225.5 4015.4 4018.7 4028.6 4051.4 4082.0 3782.3 3944.3 4050.6 4093.4 4122.5 4138.5 4673.6 4734.9 4787.6 4803.0 5128.6 5508.6 5649.4 5837.5 5942.9 1088.9 1249.5 1269.5 1272.3 1287.8 789.2 877.7 892.6 903.4 904.3 4576.6 4659.4 5068.4 5156.3 5198.8 4901.5 5216.6 5404.1 5664.4 5707.9 4875.6 4940.6 5059.9 5089.7 5234.9 2940.3 2958.0 3008.6 3072.4 3083.4 5651.0 5651.6 5990.0 6060.9 6190.0 4856.6 5187.1 5221.0 5458.8 5860.0 4718.8 5401.6 5513.8 6055.4 6084.5 4746.8 5299.7 5597.0 5713.1 5881.6 4486.6 5012.5 5462.0 5703.3 5782.9 5142.6 6022.9 6064.8 6070.5 6149.9 3421.7 3770.3 3817.7 3829.7 3896.3 5670.7 5885.4 5986.8 5987.3 5996.1 4861.4 5955.6 5968.3 5980.2 6051.2 5142.9 5702.9 5707.9 5823.2 5890.0 4797.8 5407.8 5715.2 5790.2 5801.7 4882.2 4917.8 5872.4 5937.3 5958.6 4803.3 5748.3 5825.9 5843.9 5925.9 17:19:46 INFO - PROCESS | 1636 | 17:19:46 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19280.60 Median:4390.20 stddev:27043.74 (616.0%) stddev-sans-first:27083.62 17:19:46 INFO - PROCESS | 1636 | Values: 700.7 733.2 769.6 771.3 832.1 14586.9 15111.5 15228.3 15278.5 15335.3 12316.5 13869.5 14044.2 15383.8 15410.0 804.2 818.3 827.9 828.6 829.2 805.4 813.2 815.5 815.7 816.2 824.5 846.1 849.7 852.5 853.1 819.8 829.7 844.4 849.9 850.4 624.3 626.8 628.4 631.0 631.2 14633.9 14736.0 14745.6 14753.6 14763.3 14177.4 14427.8 14490.4 14521.8 14537.5 11182.1 11194.7 11205.3 11582.6 11704.1 3660.7 3673.8 3701.1 3730.2 3748.5 89218.0 95385.0 95539.0 96901.0 97084.0 10948.2 11114.6 11160.8 11162.2 11206.0 21764.7 21976.8 21978.8 22238.0 22244.7 7616.3 7782.0 7846.5 8034.9 8105.3 4333.4 4344.2 4379.9 4437.4 4452.8 3428.7 3480.0 3505.9 3534.9 3568.3 584.4 626.0 632.0 643.8 651.8 612.5 635.9 651.6 670.7 684.6 9015.7 9085.4 9454.2 9530.6 9552.7 638.4 644.7 666.6 671.7 671.9 3864.7 4400.5 4594.4 4980.5 4990.0 80260.8 80336.0 102466.5 104703.0 105390.0 27039.9 27350.9 56670.7 70991.0 83688.6 79631.6 81621.4 81725.0 82937.0 84720.6 8271.7 9586.9 9999.4 10003.0 10017.9 48440.0 51376.7 51875.7 52096.0 53358.0 71955.0 73440.6 75215.0 77357.0 77704.0 12408.5 12543.4 12653.0 12929.4 13166.1 14123.4 14181.0 14327.0 14515.0 15291.0 12851.5 13327.9 13583.5 13665.2 14167.6 12016.0 13246.8 13364.1 13687.9 14028.1 12632.4 13207.8 13469.9 13935.7 13990.8 10454.0 10974.0 11125.9 11398.2 11939.9 11394.4 11419.4 11615.9 11706.8 11731.6 17:19:46 INFO - PROCESS | 1636 | -------- Summary: end -------- 17:19:46 INFO - PROCESS | 1636 | 17:19:47 INFO - TEST-INFO | 1636: exit 0 17:19:47 INFO - TEST-OK | dromaeo_css | took 1114171ms 17:19:47 INFO - TEST-START | kraken 17:19:47 INFO - operating with platform_type : mac_ 17:19:47 INFO - Initialising browser for kraken test... 17:19:47 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/tmpUHDUmN/profile http://localhost:49246/getInfo.html) 17:19:50 INFO - PROCESS | 1648 | 2017-02-13 17:19:50.261 plugin-container[1650:10012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 17:19:50 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:50 INFO - PROCESS | 1648 | 2017-02-13 17:19:50.263 plugin-container[1650:10012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 17:19:50 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:50 INFO - PROCESS | 1648 | 2017-02-13 17:19:50.263 plugin-container[1650:10012] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:19:50 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 17:19:50 INFO - PROCESS | 1648 | colorDepth:24 17:19:50 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 17:19:50 INFO - PROCESS | 1648 | __metrics 17:19:50 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 17:19:51 INFO - TEST-INFO | 1648: exit 0 17:19:51 INFO - Browser initialized. 17:19:51 INFO - Running cycle 1/1 for kraken test... 17:19:51 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/T/tmpUHDUmN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:53 INFO - PROCESS | 1651 | 2017-02-13 17:19:53.674 plugin-container[1652:10140] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.tsm.portname' 17:19:53 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:53 INFO - PROCESS | 1651 | 2017-02-13 17:19:53.675 plugin-container[1652:10140] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x871b, name = 'com.apple.CFPasteboardClient' 17:19:53 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:53 INFO - PROCESS | 1651 | 2017-02-13 17:19:53.675 plugin-container[1652:10140] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:20:03 INFO - PROCESS | 1651 | RSS: Main: 177471488 17:20:03 INFO - PROCESS | 1651 | 17:20:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 17:20:07 INFO - PROCESS | 1651 | RSS: Main: 190234624 17:20:07 INFO - PROCESS | 1651 | 17:20:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 17:20:10 INFO - PROCESS | 1651 | RSS: Main: 198135808 17:20:10 INFO - PROCESS | 1651 | 17:20:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 17:20:14 INFO - PROCESS | 1651 | RSS: Main: 201867264 17:20:14 INFO - PROCESS | 1651 | 17:20:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 17:20:16 INFO - PROCESS | 1651 | RSS: Main: 202309632 17:20:16 INFO - PROCESS | 1651 | 17:20:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:19 INFO - PROCESS | 1651 | RSS: Main: 202309632 17:20:19 INFO - PROCESS | 1651 | 17:20:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:22 INFO - PROCESS | 1651 | RSS: Main: 205832192 17:20:22 INFO - PROCESS | 1651 | 17:20:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:26 INFO - PROCESS | 1651 | RSS: Main: 206315520 17:20:26 INFO - PROCESS | 1651 | 17:20:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 17:20:29 INFO - PROCESS | 1651 | RSS: Main: 205717504 17:20:29 INFO - PROCESS | 1651 | 17:20:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:32 INFO - PROCESS | 1651 | RSS: Main: 205033472 17:20:32 INFO - PROCESS | 1651 | 17:20:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:34 INFO - PROCESS | 1651 | RSS: Main: 206385152 17:20:34 INFO - PROCESS | 1651 | 17:20:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:37 INFO - PROCESS | 1651 | RSS: Main: 206360576 17:20:37 INFO - PROCESS | 1651 | 17:20:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:40 INFO - PROCESS | 1651 | RSS: Main: 206381056 17:20:40 INFO - PROCESS | 1651 | 17:20:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:44 INFO - PROCESS | 1651 | RSS: Main: 206745600 17:20:44 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 17:20:46 INFO - PROCESS | 1651 | RSS: Main: 208646144 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | __start_tp_report 17:20:46 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 17:20:46 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 17:20:46 INFO - PROCESS | 1651 | |i|pagename|runs| 17:20:46 INFO - PROCESS | 1651 | |0;ai-astar;107;117;119;117;118;118;117;118;119;116 17:20:46 INFO - PROCESS | 1651 | |1;audio-beat-detection;138;106;110;141;114;98;144;143;170;124 17:20:46 INFO - PROCESS | 1651 | |2;audio-dft;193;202;194;200;196;199;197;197;200;196 17:20:46 INFO - PROCESS | 1651 | |3;audio-fft;75;59;67;73;61;72;83;81;79;61 17:20:46 INFO - PROCESS | 1651 | |4;audio-oscillator;82;72;82;58;101;94;84;68;74;109 17:20:46 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;86;95;85;88;85;88;86;92;84 17:20:46 INFO - PROCESS | 1651 | |6;imaging-darkroom;96;155;154;118;131;94;95;95;95;95 17:20:46 INFO - PROCESS | 1651 | |7;imaging-desaturate;76;77;135;76;73;127;143;142;87;89 17:20:46 INFO - PROCESS | 1651 | |8;json-parse-financial;57;56;56;57;58;58;60;59;58;58 17:20:46 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;68;73;66;75;68;66;68;68;68;70 17:20:46 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;83;84;83;83;102;78;85;93;78 17:20:46 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;135;140;139;137;137;142;150;136;200;167 17:20:46 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;167;164;165;164;168;164;163;189;226;172 17:20:46 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;68;66;67;66;69;67;79;88;91;75 17:20:46 INFO - PROCESS | 1651 | __end_tp_report 17:20:46 INFO - PROCESS | 1651 | __start_cc_report 17:20:46 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,897 17:20:46 INFO - PROCESS | 1651 | __end_cc_report 17:20:46 INFO - PROCESS | 1651 | __startTimestamp1487035246433__endTimestamp 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | ------- Summary: start ------- 17:20:46 INFO - PROCESS | 1651 | Number of tests: 14 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:116.60 Median:118.00 stddev:3.50 (3.0%) stddev-sans-first:1.00 17:20:46 INFO - PROCESS | 1651 | Values: 107.0 117.0 119.0 117.0 118.0 118.0 117.0 118.0 119.0 116.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:142.00 stddev:22.18 (15.6%) stddev-sans-first:23.27 17:20:46 INFO - PROCESS | 1651 | Values: 138.0 106.0 110.0 141.0 114.0 98.0 144.0 143.0 170.0 124.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:197.40 Median:198.00 stddev:2.84 (1.4%) stddev-sans-first:2.52 17:20:46 INFO - PROCESS | 1651 | Values: 193.0 202.0 194.0 200.0 196.0 199.0 197.0 197.0 200.0 196.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:71.10 Median:74.00 stddev:8.75 (11.8%) stddev-sans-first:9.17 17:20:46 INFO - PROCESS | 1651 | Values: 75.0 59.0 67.0 73.0 61.0 72.0 83.0 81.0 79.0 61.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:78.00 stddev:15.54 (19.9%) stddev-sans-first:16.48 17:20:46 INFO - PROCESS | 1651 | Values: 82.0 72.0 82.0 58.0 101.0 94.0 84.0 68.0 74.0 109.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:3.43 (3.9%) stddev-sans-first:3.64 17:20:46 INFO - PROCESS | 1651 | Values: 88.0 86.0 95.0 85.0 88.0 85.0 88.0 86.0 92.0 84.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:112.80 Median:95.00 stddev:25.25 (26.6%) stddev-sans-first:26.04 17:20:46 INFO - PROCESS | 1651 | Values: 96.0 155.0 154.0 118.0 131.0 94.0 95.0 95.0 95.0 95.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:102.50 Median:76.00 stddev:30.19 (39.7%) stddev-sans-first:30.46 17:20:46 INFO - PROCESS | 1651 | Values: 76.0 77.0 135.0 76.0 73.0 127.0 143.0 142.0 87.0 89.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.25 (2.2%) stddev-sans-first:1.30 17:20:46 INFO - PROCESS | 1651 | Values: 57.0 56.0 56.0 57.0 58.0 58.0 60.0 59.0 58.0 58.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.00 stddev:2.91 (4.3%) stddev-sans-first:3.06 17:20:46 INFO - PROCESS | 1651 | Values: 68.0 73.0 66.0 75.0 68.0 66.0 68.0 68.0 68.0 70.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.00 stddev:7.21 (8.7%) stddev-sans-first:7.60 17:20:46 INFO - PROCESS | 1651 | Values: 83.0 83.0 84.0 83.0 83.0 102.0 78.0 85.0 93.0 78.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:141.00 stddev:20.56 (14.6%) stddev-sans-first:21.24 17:20:46 INFO - PROCESS | 1651 | Values: 135.0 140.0 139.0 137.0 137.0 142.0 150.0 136.0 200.0 167.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:167.50 stddev:19.78 (11.8%) stddev-sans-first:20.80 17:20:46 INFO - PROCESS | 1651 | Values: 167.0 164.0 165.0 164.0 168.0 164.0 163.0 189.0 226.0 172.0 17:20:46 INFO - PROCESS | 1651 | 17:20:46 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:72.00 stddev:9.41 (13.1%) stddev-sans-first:9.76 17:20:46 INFO - PROCESS | 1651 | Values: 68.0 66.0 67.0 66.0 69.0 67.0 79.0 88.0 91.0 75.0 17:20:46 INFO - PROCESS | 1651 | -------- Summary: end -------- 17:20:46 INFO - PROCESS | 1651 | 17:20:47 INFO - TEST-INFO | 1651: exit 0 17:20:47 INFO - TEST-OK | kraken | took 59892ms 17:20:47 INFO - SUITE-END | took 1174s 17:20:47 INFO - Completed test suite (00:19:34) 17:20:47 INFO - javascript benchmark 17:20:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7371.486363036422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2934.794564380494, 3016.336405990681, 3540.716742660587, 3581.426971684531, 3588.694960928321, 5777.76888924443, 5804.854878628036, 5877.235959325287, 5918.674472903988, 5920.822375328737, 5916.88166236675, 5945.346011938684, 5958.8808223835495, 5977.312609049961, 5986.760529578823, 4461.3531037999555, 4965.776540055688, 5411.945880541203, 5420.864478388033, 5463.590230732691, 5424.972875135619, 5451.233813218901, 5469.206964990074, 5497.120460726284, 5528.391876893538, 5318.946810531884, 5334.733263336818, 5466.781328746845, 5469.507744303012, 5475.288212532385, 5354.196870469422, 5367.892642147174, 5414.539764120015, 5451.918221226685, 5501.944980550184, 5302.814401495968, 5395.10980688186, 5407.080796264644, 5409.6213265071465, 5436.994156081138, 5691.260136182311, 5880.6765627890445, 5924.933511967844, 5987.491063259628, 5995.940040599582, 6161.507079433634, 6229.4704950079295, 6239.438450539473, 6317.778877739257, 6334.398232167937, 6288.748450061992, 6295.181626388586, 6312.779052733178, 6319.431251187415, 6319.684015799237, 5968.492678122365, 5992.310884248367, 5995.340512543617, 6005.039193728982, 6005.579609427298, 6201.193844800147, 6208.906866397007, 6286.49708023357, 6290.21372328459, 6319.6208227506495, 6266.592671476339, 6301.590396624205, 6310.5898116622275, 6311.116443697886, 6315.905261421082, 6316.399942005502, 6320.905186422207, 6340.239171299381, 6348.174737284216, 6348.333424990402, 6131.896637733196, 6152.569320147636, 6179.0, 6192.164057852132, 6235.345288744707, 6237.251529816361, 6285.120083188357, 6296.275928268216, 6302.275238347649, 6306.527010474233, 4986.152354099811, 5020.59835213182, 5021.171506701427, 5023.196288593807, 5029.321041659329, 4448.532904045093, 4453.4433195850515, 4476.865694029184, 4531.682782205214, 4532.5694059064335, 5807.361190269067, 5864.912026319608, 5939.346671866091, 5987.491063259672, 6025.457708806229, 6256.937430625727, 6274.717637706223, 6287.49700023997, 6289.339619339995, 6341.017142342944, 5769.874874399536, 5831.562632802472, 5867.853303667443, 5934.703264836741, 5940.405959404112, 5536.640118392292, 5552.944470555242, 5564.165375193753, 5567.276254086943, 5572.693501857356, 6398.2322121344805, 6428.967855160694, 6433.260175079926, 6441.1304473895425, 6451.3548645135115, 6154.107654390178, 6167.814965551041, 6212.347703491068, 6260.248770147611, 6308.589941653778, 6396.232452105777, 6408.679566021773, 6423.164988551458, 6446.323136070645, 6455.806325810233, 4757.738324392191, 5169.4830516949505, 5552.7778888843995, 6322.399372059647, 6328.493720502441, 6160.753569857335, 6210.5652604317265, 6245.313015568375, 6275.309715931153, 6303.0, 6062.120992455981, 6289.874202515833, 6309.810705678837, 6311.779087731908, 6316.368363163647, 6210.875782484415, 6236.095766113797, 6286.497080233662, 6293.244810622755, 6294.307626161027, 5834.854128646818, 6035.668038257938, 6090.177825993434, 6126.1423400724825, 6184.505239580732, 5023.799048038038, 6150.846228844136, 6159.014557670751, 6164.7842325518395, 6170.568060235741, 6127.158986117617, 6128.136482154648, 6141.792871882774, 6146.0, 6161.0], "value": 5792.79589586295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.67314226326096, 487.46865916151387, 507.29486014439914, 548.6324162810917, 550.0456707612294, 38870.61129388705, 40492.78521644352, 40732.77801665951, 42468.362974555406, 42537.7873110634, 41804.37293440593, 42416.78791606038, 42424.0, 42425.93935151623, 42463.3630495542, 9554.761130971747, 9726.465044422554, 9727.221822254203, 9741.0, 9756.365836220659, 9682.854757178648, 9784.706458806211, 9785.315027948047, 9788.902110978906, 9795.706128816148, 9733.124018838304, 9765.0, 9765.902340976605, 9774.462404567746, 9809.558569864374, 9729.464879431629, 9748.610055597768, 9766.462844543546, 9794.265430092735, 9818.950905245429, 9340.299477539213, 9379.01520340368, 9405.106514881076, 9433.764155896157, 9512.857307140399, 39790.0, 39850.0, 39902.80048599738, 40063.99840003994, 40231.7988410059, 3348.9497657535157, 3483.5819701635965, 3513.0514761014383, 3547.6984456321243, 3724.888253352404, 30194.84902575495, 30456.0, 30616.928407505853, 30808.767649294, 31048.689513104804, 2558.5522533556555, 2600.2849216465434, 3143.874245030196, 3285.917852053718, 3307.603087629476, 396628.0, 469206.0, 486034.0, 489500.99999999645, 490772.0, 62105.0, 62466.375336246965, 62665.37334626687, 62811.05783413252, 62863.799767007935, 63672.681636592446, 64738.67630661817, 64873.0, 64887.0, 65059.67470162713, 14968.550943471713, 16217.51347459578, 16907.91546042262, 16963.491095267163, 17093.57266068358, 12562.0, 12862.292573908524, 13011.21932684042, 13076.542321018718, 13108.80336794949, 17597.994768548706, 18993.05034748257, 19007.38437232823, 19107.90446047761, 19217.0, 7940.682372705142, 7968.322692571081, 8122.675092996332, 8168.754937351889, 8269.568129226423, 854.7905763088083, 897.8518544440094, 965.290511474066, 984.2077127911956, 1093.3439936038314, 26853.791579378976, 29776.10671679853, 29874.551881721793, 30136.0, 30456.086317410514, 777.6928113395177, 915.4736026784492, 1002.9218590015762, 1062.5484169228048, 1094.6332978452308, 15706.9214653926, 15743.68512629764, 15820.525384238492, 15822.60443488922, 16130.032198068153, 610048.0, 616993.0, 624535.7546424569, 624923.0, 625648.0, 58208.0, 58254.0, 58396.24811255584, 58402.0, 58544.0, 1380.6341319550327, 1386.660268234289, 1405.6837211627303, 1415.0, 1418.099506813181, 29211.415771684024, 29986.400271994873, 30004.699953001065, 30026.699733003265, 30540.236494087825, 48788.512114878395, 48846.755766220944, 49681.50318496769, 49828.0, 49910.25314113989, 540475.0, 542800.0, 548424.0, 548794.0, 549692.0, 26313.21060368192, 26688.733112668626, 26701.599476007486, 26785.866070669523, 27474.0, 45729.0, 45922.54077459183, 46759.76620116878, 46816.53183468122, 47062.294065589726, 37950.62049379581, 38389.0, 39196.80401597974, 39830.60169398269, 40222.19000144942, 38353.23293534169, 38699.41950870683, 38746.80626596849, 39012.0, 39723.0, 38069.80965095157, 38145.427818583295, 38495.0, 38551.0, 38606.0, 28306.575401368584, 34588.65411345854, 34645.65354346424, 35195.82402087973, 35199.47200791939, 20291.79708202958, 25661.3584660385, 25762.742372576035, 25893.6115958257, 26250.606240906785], "value": 19964.122580627733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.77914809410544, 382.59064284125435, 387.42080589518673, 394.8262764383671, 415.4889485932303, 16706.0, 16946.152692365362, 19157.04214789262, 20527.897360513194, 20549.589008219828, 11820.881791182086, 12102.515899364014, 12152.392380380968, 13024.869751302484, 20544.280950166747, 5471.452854714526, 5564.972175139139, 5671.631343962629, 5679.858003549903, 5686.0617998030275, 5562.360328562207, 5865.736041878125, 6141.662208578527, 6195.659238741868, 6270.372962703739, 5211.42674305826, 5759.568032397566, 6216.627002379849, 6229.1902052733085, 6239.563230573862, 5248.396434410053, 5530.336359636829, 6122.663253521055, 6234.719437625317, 6245.6252624842655, 5159.277701121846, 5290.576753859682, 5579.832605021856, 6051.697415129226, 6088.269407671108, 13254.66863328415, 13291.86708132916, 13374.598762037154, 13487.325633718276, 13542.119762215523, 2195.4621117826077, 2277.6128058230142, 2293.5183611441616, 2460.4095017195923, 2667.66654168229, 9973.152282056033, 10083.697489075266, 10094.697159085166, 10114.9494252529, 10338.793224135476, 1800.1449311577028, 1857.3220774417375, 1867.8038805925319, 1951.1219951022097, 2012.6779715245636, 105805.94194058038, 126883.0, 130316.69683303236, 130883.0, 141120.0, 21263.68104478434, 21785.019674114705, 22214.55570888573, 22469.325920222418, 22485.88757056204, 35947.82026089853, 36038.63961360405, 36455.635443645755, 36508.45237321442, 36607.718729844324, 9041.547922603844, 10142.594296228215, 11043.392613406178, 11246.1565382595, 11272.436378181059, 7081.822954426078, 8405.949256342958, 9162.587683554257, 9272.490013049348, 9279.211267042378, 9698.224142068617, 10168.796624067478, 10188.643397481053, 10200.724909386327, 10219.437930913871, 3865.8840234793, 3981.5222173339384, 3984.8007599620482, 3991.5409727881665, 3992.181602771425, 838.3377132065722, 880.5377176982007, 916.3677062826629, 982.7936133412063, 1009.65671671632, 20257.189712411633, 21365.46586335354, 22052.032326127748, 22298.44253893633, 23045.732484713502, 896.8340856941487, 1014.9441780702132, 1017.5370206555999, 1017.8524114003576, 1047.5914393386586, 10530.736731581772, 11192.720181995352, 11240.943795280971, 11303.982641562134, 11335.603253886075, 582462.0, 590517.0, 605253.0, 610158.0, 616449.0, 67320.0, 108083.70744110167, 140982.29508852595, 142097.0, 149060.0, 961.8653388525612, 1000.7398076500308, 1004.6935684616116, 1005.939643621385, 1014.031599822168, 16168.67662646764, 17817.93092414459, 18977.0, 19418.90290548538, 19495.317663881695, 56365.436345636015, 56661.71669141628, 57848.71075644595, 58382.4161758377, 58722.0, 81876.18123818685, 84700.0, 85188.0, 85914.0, 86371.56814215888, 7862.685492580233, 8008.719694810887, 8142.307903828004, 8193.262606365455, 8214.055383630719, 10204.38773673582, 11462.197646164688, 12438.315892625993, 12517.0, 12640.620781376574, 10414.843777343194, 10423.21825863048, 10608.575656973635, 10696.358218506915, 10901.672949811518, 9845.163161131384, 9906.554205060933, 9916.355436896578, 10000.099991000845, 10026.899731002597, 10758.515866785858, 10767.300125491818, 11000.174986876176, 11098.944505277423, 11154.498047587716, 7932.960335198287, 7955.602219889098, 8033.0, 8265.504069755834, 8300.667973281, 7917.168697286702, 9386.95306523463, 10647.840282395926, 10657.307275027099, 10855.023047925724], "value": 10196.469846612654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.498970391251, 1490.0538158269496, 1677.8238284980077, 1854.3417086934146, 1906.8283854453096, 7736.38108951284, 7978.561179135145, 8262.132476090006, 8736.21374076333, 8754.212120909116, 6822.454203663708, 8442.155784421555, 8467.98384193896, 8541.359398045155, 8545.572721363938, 2345.589521833681, 2389.880505974703, 2395.8203134764876, 2396.149366974725, 2396.940076498084, 2397.3766820626674, 2421.152596591188, 2432.1852179519883, 2434.5982912819363, 2440.9389765255833, 2374.465745207332, 2375.714914210297, 2393.4614711689906, 2402.5915594348917, 2408.4460574067975, 2343.9648405273933, 2347.049444974788, 2350.0834674476796, 2357.705286839145, 2387.7373488916205, 2384.8569085854906, 2398.1606437746823, 2417.6857008588945, 2417.92746217612, 2422.5881600127846, 8451.028131764802, 8504.447210931332, 8568.528730919797, 8605.526696031779, 8680.479171249683, 5134.948650513522, 5282.7622756976025, 5289.497497737709, 5320.973395133038, 5409.188621706776, 3476.89569312921, 3538.150843797496, 3538.3630946429635, 3608.1520842601967, 3624.003399065252, 1024.6157690865925, 1032.02989190161, 1076.2358725305044, 1109.3233127792041, 1116.7878103160374, 11085.612003579916, 11157.553697852076, 11165.106791456745, 11216.551337946472, 11276.830847537294, 4529.207388706963, 4629.537046295343, 4732.692374995683, 4746.28805679144, 4797.688150270221, 9618.278629102706, 9636.988116247834, 9650.179734722627, 9651.90348096524, 9659.517024148765, 5268.578513718893, 5323.893522129536, 5325.680459172462, 5339.919901201485, 5397.78408863641, 4352.630026447788, 4378.10248898975, 4754.95245047552, 4811.615070794328, 4868.367112275381, 3861.9034524137123, 3911.5892831252877, 3984.7808370539897, 4000.5599384067727, 4005.539362973237, 1286.3696788573532, 1300.63582196985, 1303.0422639360252, 1317.2030921292671, 1319.5381616434172, 806.1253539909147, 883.4655033704645, 884.8628462588309, 911.0070023674227, 915.771057235691, 4730.290456431563, 5566.35986861508, 5678.063119585305, 5760.596758226968, 5862.091375836752, 843.8396704626101, 957.8132264208551, 976.1800087926176, 1001.5743309093606, 1066.6693325069098, 3027.2885871820104, 3583.104223944014, 3585.928281434357, 3631.800250986168, 3793.430985352219, 9957.452340121363, 10365.533550990223, 10373.792524149474, 10375.533101010473, 10432.478376081166, 10046.69859904204, 10234.846477302846, 10332.276740628084, 10385.2211084169, 10413.42726150069, 7840.294373506412, 7864.331531819745, 7867.803304917308, 8031.196880311922, 8117.675292988214, 5424.918626220531, 5516.641418307797, 5575.0243707351865, 5604.8318550443555, 5722.998475266895, 9365.812683746151, 9468.905310946802, 9511.857322140035, 9530.142287193908, 9657.517124143624, 9222.40054396462, 9625.422474651543, 9631.470269135265, 9750.951245243728, 9833.557489912828, 6784.559003664746, 6922.723091076502, 7100.680469378787, 7288.781336559911, 7380.852382952204, 7864.567448790372, 8137.430379873352, 8144.837103257783, 8145.470544414594, 8157.714479993172, 7167.068281123421, 7300.393913339057, 7326.890096648448, 7381.966524686441, 7434.256574342522, 5482.972585137209, 7036.964815175891, 7113.75101871432, 7142.357187853118, 7287.27127287267, 6758.797236082925, 6767.763128290486, 6843.7604683835825, 6852.0749698792015, 6879.105716256855, 4655.06898620284, 4674.485806561208, 4735.337052812678, 4736.952630473651, 4741.478437371818, 4682.953170468251, 4703.294505824154, 4735.0, 4891.241857512091, 4932.136876046749], "value": 4491.344088757006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.3853627879832, 269.32399676811224, 312.1182658988358, 317.5332261575483, 324.16042450054357, 5312.309399778023, 5481.5340696040785, 5506.449355064497, 5543.916841247379, 5618.77524899004, 4836.516348365161, 4956.752162391884, 5456.7544460499275, 5478.753456094475, 5565.888682226353, 3639.636036396366, 4015.437838702584, 4227.788610569474, 4254.234237837188, 4278.358246263055, 3396.371671240828, 4027.919441611166, 4263.658907287409, 4280.186764514748, 4280.443542339492, 4137.303705480754, 4148.522919864224, 4151.23202207591, 4184.435101261336, 4222.725522841006, 4143.82449214162, 4148.419221309019, 4198.999999999969, 4205.3481710334945, 4216.262154123016, 2971.762259019295, 3573.4282514797505, 3644.7084233261276, 3657.3782456982112, 3669.908252293714, 5052.671576347526, 5208.322918020633, 5278.627556835212, 5336.706481143536, 5424.457554244584, 3504.8981651238582, 4454.754988475633, 4674.415698037746, 4692.507286734878, 4748.287756836467, 4915.967646794177, 5725.1698503716725, 5752.712364381764, 5760.020796464569, 5789.65262084272, 3787.3750831112834, 3952.7628342299554, 3955.6044395560502, 3986.40203969404, 3986.886949916549, 4698.0, 5868.647881127146, 6123.693815309217, 6154.44609985099, 6225.548732656172, 4015.4177644242004, 4018.65375099345, 4028.5568587455355, 4051.372037334218, 4082.0, 3782.2624588205035, 3944.2703099926607, 4050.6354428101613, 4093.3655283431117, 4122.546519882811, 4138.482689663792, 4673.60274376675, 4734.928976065362, 4787.640926930494, 4803.0, 5128.615353848476, 5508.595308196384, 5649.389923871759, 5837.532997360201, 5942.8811423771285, 1088.9074428673493, 1249.5064449542563, 1269.4702883025932, 1272.338384040294, 1287.7939529675207, 789.1674283630824, 877.6708734224666, 892.5585179934488, 903.421810041574, 904.3172404834309, 4576.565226303496, 4659.370984916993, 5068.366454193226, 5156.272648662665, 5198.792048318101, 4901.50984901507, 5216.63483556155, 5404.108322126884, 5664.405237450091, 5707.942920570741, 4875.585575226146, 4940.590053890984, 5059.87350316245, 5089.702125957857, 5234.895302093937, 2940.2502361897577, 2958.0238521287924, 3008.5787989681025, 3072.4008818280668, 3083.367909578531, 5650.971745141248, 5651.576131790132, 5990.041593345131, 6060.909086363708, 6189.96905015481, 4856.576113839735, 5187.054854429589, 5220.9738951305, 5458.836234912959, 5860.015189671065, 4718.764061796896, 5401.5948803839865, 5513.807016754475, 6055.364186760415, 6084.482818960438, 4746.8164644264025, 5299.655522391032, 5596.9571106545, 5713.057345538106, 5881.588288819741, 4486.64106871456, 5012.491256120657, 5462.0, 5703.287089113861, 5782.913256301243, 5142.64001519905, 6022.90965635507, 6064.786352981218, 6070.544709146743, 6149.877002460015, 3421.7091547218765, 3770.3024940386117, 3817.732758706864, 3829.693624509977, 3896.298666239991, 5670.74481648335, 5885.411458854081, 5986.820395387971, 5987.31145918225, 5996.102533353355, 4861.368022157097, 5955.612885162624, 5968.283805943314, 5980.192673988956, 6051.186198417757, 5142.871428214325, 5702.914456283242, 5707.914381284201, 5823.155642431909, 5890.0, 4797.8080876765935, 5407.78368865241, 5715.199552219299, 5790.160426738184, 5801.738921748616, 4882.2432522959, 4917.778699958439, 5872.354041055395, 5937.3468918418075, 5958.603595950267, 4803.327534145153, 5748.310202775694, 5825.854353641023, 5843.912341314969, 5925.881482370414], "value": 4145.026907130728, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.6986995591897, 733.1605311917854, 769.6113462701335, 771.2942657468417, 832.1345800367618, 14586.854131458682, 15111.546653600382, 15228.314725837336, 15278.46525371611, 15335.309911054, 12316.5073397064, 13869.514566990158, 14044.157350558973, 15383.846161538382, 15409.998350107235, 804.2158895077297, 818.3207937411963, 827.8592639251342, 828.6188353357433, 829.2163905109674, 805.3718099882072, 813.1786895235825, 815.4536460571402, 815.7348861619968, 816.244973399606, 824.4846970643348, 846.0608724316004, 849.6686292345959, 852.4629483425433, 853.0914575976565, 819.7622689420091, 829.713748756678, 844.3751623798406, 849.902261239953, 850.37497439382, 624.3257282135284, 626.8338890194102, 628.3684896678855, 631.0439683878927, 631.2488139114439, 14633.853661463356, 14736.0, 14745.631359215999, 14753.631159221106, 14763.26183690822, 14177.362018709182, 14427.78358324626, 14490.42038318466, 14521.78217326741, 14537.491187808377, 11182.105431565455, 11194.720131996684, 11205.327680339205, 11582.594609188638, 11704.122190835722, 3660.68884144848, 3673.8163091845568, 3701.0747313171705, 3730.1793605406765, 3748.456473811282, 89218.0, 95385.0, 95539.0446095537, 96901.0, 97084.0, 10948.178886583539, 11114.610988615521, 11160.776784464428, 11162.162837787198, 11206.0, 21764.673529897063, 21976.780232197474, 21978.780212197995, 22238.0, 22244.66633000474, 7616.314531692175, 7782.0, 7846.489978151402, 8034.879476807736, 8105.311048560939, 4333.393324934512, 4344.196323680129, 4379.934300985487, 4437.378766972626, 4452.8218871245435, 3428.708559772447, 3479.9560131960816, 3505.8948231553095, 3534.8939531814085, 3568.2506673598314, 584.4155844155844, 626.0015275635354, 631.9557630965788, 643.7585905285518, 651.8272657745702, 612.5405945540845, 635.9077933699588, 651.5992664511291, 670.6914819183132, 684.6097724297202, 9015.684451044182, 9085.36402451822, 9454.196393306509, 9530.618775249051, 9552.665656701982, 638.4381744065192, 644.690548536705, 666.6067020457953, 671.70445004198, 671.9227288861746, 3864.71014673895, 4400.471943366816, 4594.356790049395, 4980.5019498049905, 4990.0, 80260.79608805872, 80336.0, 102466.46300305502, 104703.0, 105390.0, 27039.864800676263, 27350.863245683646, 56670.716646416506, 70991.0, 83688.58155709182, 79631.60184199041, 81621.36757264822, 81725.0, 82937.0, 84720.57639711886, 8271.669133234604, 9586.945436002174, 9999.35004224723, 10003.0, 10017.949910250401, 48440.03119937652, 51376.74311628418, 51875.74062129665, 52096.0, 53358.0, 71955.0, 73440.63279683568, 75215.0, 77357.0, 77704.0, 12408.498836114886, 12543.372831358578, 12653.0, 12929.353532323157, 13166.144200626928, 14123.43506259738, 14181.007329486836, 14327.0, 14515.0, 15291.0, 12851.513256504262, 13327.866721332663, 13583.45666173342, 13665.248411337472, 14167.574972750834, 12016.038716902453, 13246.801297980346, 13364.064515483822, 13687.931560342135, 14028.08817426864, 12632.431540580512, 13207.801882971571, 13469.865301346861, 13935.721285574435, 13990.790138147733, 10454.0, 10973.982154907464, 11125.888741112485, 11398.245963723406, 11939.880601193878, 11394.430278485877, 11419.37193454368, 11615.941920290345, 11706.76586468283, 11731.648050558497], "value": 7307.8851096814615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 118.0, 119.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 106.0, 110.0, 141.0, 114.0, 98.0, 144.0, 143.0, 170.0, 124.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 202.0, 194.0, 200.0, 196.0, 199.0, 197.0, 197.0, 200.0, 196.0], "value": 197.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 59.0, 67.0, 73.0, 61.0, 72.0, 83.0, 81.0, 79.0, 61.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 82.0, 58.0, 101.0, 94.0, 84.0, 68.0, 74.0, 109.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 95.0, 85.0, 88.0, 85.0, 88.0, 86.0, 92.0, 84.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 155.0, 154.0, 118.0, 131.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 112.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 135.0, 76.0, 73.0, 127.0, 143.0, 142.0, 87.0, 89.0], "value": 102.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 58.0, 58.0, 60.0, 59.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 66.0, 75.0, 68.0, 66.0, 68.0, 68.0, 68.0, 70.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 83.0, 102.0, 78.0, 85.0, 93.0, 78.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 139.0, 137.0, 137.0, 142.0, 150.0, 136.0, 200.0, 167.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 165.0, 164.0, 168.0, 164.0, 163.0, 189.0, 226.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 66.0, 69.0, 67.0, 79.0, 88.0, 91.0, 75.0], "value": 73.6, "unit": "score"}]}]} 17:20:47 INFO - Return code: 0 17:20:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:20:47 ERROR - # TBPL SUCCESS # 17:20:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:20:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:20:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:20:47 INFO - 2017-02-13 17:20:47.774 screenresolution[1656:10517] starting screenresolution argv=screenresolution get 17:20:47 INFO - 2017-02-13 17:20:47.777 screenresolution[1656:10517] Display 0: 1600x1200x32@60 17:20:47 INFO - 2017-02-13 17:20:47.783 screenresolution[1657:10520] starting screenresolution argv=screenresolution list 17:20:47 INFO - Available Modes on Display 0 17:20:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:20:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:20:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:20:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:20:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:20:48 INFO - Intel Iris: 17:20:48 INFO - Chipset Model: Intel Iris 17:20:48 INFO - Type: GPU 17:20:48 INFO - Bus: Built-In 17:20:48 INFO - VRAM (Dynamic, Max): 1536 MB 17:20:48 INFO - Vendor: Intel (0x8086) 17:20:48 INFO - Device ID: 0x0a2e 17:20:48 INFO - Revision ID: 0x0009 17:20:48 INFO - Displays: 17:20:48 INFO - Display: 17:20:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:20:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:20:48 INFO - Display Serial Number: 1600x1200 60 17:20:48 INFO - Main Display: Yes 17:20:48 INFO - Mirror: Off 17:20:48 INFO - Online: Yes 17:20:48 INFO - Rotation: Supported 17:20:48 INFO - Return code: 0 17:20:48 INFO - Running post-action listener: _resource_record_post_action 17:20:48 INFO - [mozharness: 2017-02-14 01:20:48.019553Z] Finished run-tests step (success) 17:20:48 INFO - Running post-run listener: _resource_record_post_run 17:20:48 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 38135808; Write bytes: 504428544; Read time: 399; Write time: 1704 17:20:48 INFO - TinderboxPrint: CPU usage
54.1% 17:20:48 INFO - TinderboxPrint: I/O read bytes / time
38,135,808 / 399 17:20:48 INFO - TinderboxPrint: I/O write bytes / time
504,428,544 / 1,704 17:20:48 INFO - TinderboxPrint: CPU idle
2,198.1 (45.9%) 17:20:48 INFO - TinderboxPrint: CPU system
962.5 (20.1%) 17:20:48 INFO - TinderboxPrint: CPU user
1,625.1 (34.0%) 17:20:48 INFO - TinderboxPrint: Swap in / out
230,256,640 / 0 17:20:48 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 187034112; Write bytes: 184283136; Read time: 17003; Write time: 321 17:20:48 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36190208; Write bytes: 307139072; Read time: 379; Write time: 1272 17:20:48 INFO - Running post-run listener: _upload_blobber_files 17:20:48 INFO - Blob upload gear active. 17:20:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:48 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 17:20:48 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20:48 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:50 INFO - (blobuploader) - INFO - Done attempting. 17:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:51 INFO - (blobuploader) - INFO - Done attempting. 17:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:53 INFO - (blobuploader) - INFO - Done attempting. 17:20:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:53 INFO - Return code: 0 17:20:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec0ce077f1bc55afa30164428f576ceffe93f536c6494b33e14da071c7e1fbb90b221c69e6da6af4c787dedf94580e735c597d2e4e512e910fe83fec85a64215", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea0be449d319212d043f577988c0025259633077c8798fd0cb432aecb57f156e968156d4795e3915c1b91479fae41c7258c6fabb0669fdec4e5f0f0a7571b2f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9e00a7c39aab49f4b0265dae3654e90b2178b777b8a01b64761801a665095ef4471f0eb33fd208fa991461b238b067ee86d2adf5b00f0542a0583f7b5ce7773"} 17:20:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:53 INFO - Contents: 17:20:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec0ce077f1bc55afa30164428f576ceffe93f536c6494b33e14da071c7e1fbb90b221c69e6da6af4c787dedf94580e735c597d2e4e512e910fe83fec85a64215", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea0be449d319212d043f577988c0025259633077c8798fd0cb432aecb57f156e968156d4795e3915c1b91479fae41c7258c6fabb0669fdec4e5f0f0a7571b2f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9e00a7c39aab49f4b0265dae3654e90b2178b777b8a01b64761801a665095ef4471f0eb33fd208fa991461b238b067ee86d2adf5b00f0542a0583f7b5ce7773"} 17:20:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:53 INFO - Copying logs to upload dir... 17:20:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.519582 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-13 17:20:53.980807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 17:20:53.983960) ========= 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.225O2pWqAH/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.72OTlEceOp/Listeners TMPDIR=/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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/Mozilla-Beta/sha512/ec0ce077f1bc55afa30164428f576ceffe93f536c6494b33e14da071c7e1fbb90b221c69e6da6af4c787dedf94580e735c597d2e4e512e910fe83fec85a64215", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea0be449d319212d043f577988c0025259633077c8798fd0cb432aecb57f156e968156d4795e3915c1b91479fae41c7258c6fabb0669fdec4e5f0f0a7571b2f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9e00a7c39aab49f4b0265dae3654e90b2178b777b8a01b64761801a665095ef4471f0eb33fd208fa991461b238b067ee86d2adf5b00f0542a0583f7b5ce7773"} build_url:https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010983 build_url: 'https://queue.taskcluster.net/v1/task/J2P3ujpoTVCuE7VuHvb8mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec0ce077f1bc55afa30164428f576ceffe93f536c6494b33e14da071c7e1fbb90b221c69e6da6af4c787dedf94580e735c597d2e4e512e910fe83fec85a64215", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea0be449d319212d043f577988c0025259633077c8798fd0cb432aecb57f156e968156d4795e3915c1b91479fae41c7258c6fabb0669fdec4e5f0f0a7571b2f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9e00a7c39aab49f4b0265dae3654e90b2178b777b8a01b64761801a665095ef4471f0eb33fd208fa991461b238b067ee86d2adf5b00f0542a0583f7b5ce7773"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 17:20:54.017595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 17:20:54.017960) ========= 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.225O2pWqAH/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.72OTlEceOp/Listeners TMPDIR=/var/folders/dm/mjgvqsnx6cj20gvj80clxb7c00000w/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.005080 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 17:20:54.066823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 17:20:54.067261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 17:20:54.067683) ========= ========= Total master_lag: 0.18 =========