builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0205 starttime: 1479131202.29 results: success (0) buildid: 20161114030203 builduid: 2925079056124088a53f561f478b114c revision: 1196bf3032e1bce1fb07a01fd9082a767426c5fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.289099) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.289500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.289771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.316135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.316634) ========= 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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 05:46:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 79.0M=0s 2016-11-14 05:46:42 (79.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173561 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.523662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.525608) ========= 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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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.024258 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:42.573767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-14 05:46:42.574137) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1196bf3032e1bce1fb07a01fd9082a767426c5fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1196bf3032e1bce1fb07a01fd9082a767426c5fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 05:46:42,590 truncating revision to first 12 chars 2016-11-14 05:46:42,590 Setting DEBUG logging. 2016-11-14 05:46:42,591 attempt 1/10 2016-11-14 05:46:42,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1196bf3032e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 05:46:44,747 unpacking tar archive at: mozilla-central-1196bf3032e1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.428339 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-14 05:46:45.024503) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:45.024824) ========= script_repo_revision: 1196bf3032e1bce1fb07a01fd9082a767426c5fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:45.025218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:45.025484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 05:46:45.044311) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-14 05:46:45.044708) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:46:45 INFO - MultiFileLogger online at 20161114 05:46:45 in /builds/slave/test 05:46:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:46:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:45 INFO - {'append_to_log': False, 05:46:45 INFO - 'base_work_dir': '/builds/slave/test', 05:46:45 INFO - 'blob_upload_branch': 'Firefox', 05:46:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:45 INFO - 'branch': 'Firefox', 05:46:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:45 INFO - 'config_files': ('talos/mac_config.py',), 05:46:45 INFO - 'default_actions': ('clobber', 05:46:45 INFO - 'read-buildbot-config', 05:46:45 INFO - 'download-and-extract', 05:46:45 INFO - 'populate-webroot', 05:46:45 INFO - 'create-virtualenv', 05:46:45 INFO - 'install', 05:46:45 INFO - 'run-tests'), 05:46:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:45 INFO - 'download_minidump_stackwalk': True, 05:46:45 INFO - 'download_symbols': 'ondemand', 05:46:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:45 INFO - 'installer_path': 'installer.exe', 05:46:45 INFO - 'log_level': 'info', 05:46:45 INFO - 'log_name': 'talos', 05:46:45 INFO - 'log_to_console': True, 05:46:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:46:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:46:45 INFO - 'opt_config_files': (), 05:46:45 INFO - 'pip_index': False, 05:46:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:46:45 INFO - 'cmd': ('bash', 05:46:45 INFO - '-c', 05:46:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:46:45 INFO - 'enabled': True, 05:46:45 INFO - 'halt_on_failure': False, 05:46:45 INFO - 'name': 'check_screen_resolution'},), 05:46:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:46:45 INFO - 'cmd': ('bash', 05:46:45 INFO - '-c', 05:46:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:46:45 INFO - 'enabled': True, 05:46:45 INFO - 'halt_on_failure': False, 05:46:45 INFO - 'name': 'check_screen_resolution'},), 05:46:45 INFO - 'run_cmd_checks_enabled': True, 05:46:45 INFO - 'sps_profile': False, 05:46:45 INFO - 'sps_profile_interval': 0, 05:46:45 INFO - 'suite': 'dromaeojs-e10s', 05:46:45 INFO - 'system_bits': '32', 05:46:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:45 INFO - 'title': 't-yosemite-r7-0205', 05:46:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:45 INFO - 'use_talos_json': True, 05:46:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:45 INFO - 'work_dir': 'build'} 05:46:45 INFO - [mozharness: 2016-11-14 13:46:45.181858Z] Running clobber step. 05:46:45 INFO - Running pre-action listener: _resource_record_pre_action 05:46:45 INFO - Running main action method: clobber 05:46:45 INFO - rmtree: /builds/slave/test/build 05:46:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:47 INFO - Running post-action listener: _resource_record_post_action 05:46:47 INFO - [mozharness: 2016-11-14 13:46:47.543483Z] Finished clobber step (success) 05:46:47 INFO - [mozharness: 2016-11-14 13:46:47.543618Z] Running read-buildbot-config step. 05:46:47 INFO - Running pre-action listener: _resource_record_pre_action 05:46:47 INFO - Running main action method: read_buildbot_config 05:46:47 INFO - Using buildbot properties: 05:46:47 INFO - { 05:46:47 INFO - "project": "", 05:46:47 INFO - "product": "firefox", 05:46:47 INFO - "script_repo_revision": "production", 05:46:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:46:47 INFO - "repository": "", 05:46:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:46:47 INFO - "buildid": "20161114030203", 05:46:47 INFO - "stage_platform": "macosx64", 05:46:47 INFO - "basedir": "/builds/slave/test", 05:46:47 INFO - "nightly_build": "True", 05:46:47 INFO - "buildnumber": 8, 05:46:47 INFO - "slavename": "t-yosemite-r7-0205", 05:46:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:46:47 INFO - "platform": "yosemite_r7", 05:46:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:46:47 INFO - "branch": "mozilla-central", 05:46:47 INFO - "repo_path": "mozilla-central", 05:46:47 INFO - "revision": "1196bf3032e1bce1fb07a01fd9082a767426c5fb", 05:46:47 INFO - "pgo_build": "False", 05:46:47 INFO - "builduid": "2925079056124088a53f561f478b114c", 05:46:47 INFO - "slavebuilddir": "test" 05:46:47 INFO - } 05:46:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:46:47 INFO - Running post-action listener: _resource_record_post_action 05:46:47 INFO - [mozharness: 2016-11-14 13:46:47.547062Z] Finished read-buildbot-config step (success) 05:46:47 INFO - [mozharness: 2016-11-14 13:46:47.547166Z] Running download-and-extract step. 05:46:47 INFO - Running pre-action listener: _resource_record_pre_action 05:46:47 INFO - Running main action method: download_and_extract 05:46:47 INFO - mkdir: /builds/slave/test/build/tests 05:46:47 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')]} 05:46:47 INFO - trying https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:46:47 INFO - Downloading https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:46:48 INFO - Downloaded 1199 bytes. 05:46:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:46:48 INFO - Using the following test package requirements: 05:46:48 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:46:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:46:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:46:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'jsshell-mac.zip'], 05:46:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:46:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:46:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:46:48 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:46:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:46:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:48 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:46:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:46:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:46:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:46:48 INFO - Fetch https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:46:49 INFO - Http code: 200 05:46:49 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 05:46:49 INFO - x-amz-cf-id: SOFkNbYIofJnflp4JCk05pRl2LhsqXQin5Z2Cs-BUybeWbEJdsq9cQ== 05:46:49 INFO - x-amz-version-id: Zln0psDCYounqj9A4Op.ffwwoaSy4Fav 05:46:49 INFO - Expected file size: 16328891 05:46:49 INFO - Obtained file size: 16328891 05:46:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:46:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:46:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:46:56 INFO - Fetch https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:46:56 INFO - Http code: 200 05:46:56 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 05:46:56 INFO - x-amz-cf-id: 4C2wbD4Nve3sTUZt_cClZFMscR8fHgt8tMA_m3DMaNn0G9XksEDyVA== 05:46:56 INFO - x-amz-version-id: Zln0psDCYounqj9A4Op.ffwwoaSy4Fav 05:46:57 INFO - Expected file size: 16328891 05:46:57 INFO - Obtained file size: 16328891 05:47:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:47:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:47:03 INFO - Fetch https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:47:04 INFO - Http code: 200 05:47:04 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 05:47:04 INFO - x-amz-cf-id: byKnz7KSvTYZKK1dsGUrrMcrpJAWj0U1eCypCjkjntmU6GN6znrw2g== 05:47:04 INFO - x-amz-version-id: IRiVa.sIZhg7g44Ds_YZnJAnm90Hzeow 05:47:04 INFO - Expected file size: 14409038 05:47:04 INFO - Obtained file size: 14409038 05:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:04 INFO - trying https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:47:04 INFO - Downloading https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:47:07 INFO - Downloaded 111106455 bytes. 05:47:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:47:07 INFO - mkdir: /builds/slave/test/properties 05:47:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:07 INFO - Contents: 05:47:07 INFO - build_url:https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:47:08 INFO - Running post-action listener: _resource_record_post_action 05:47:08 INFO - Running post-action listener: set_extra_try_arguments 05:47:08 INFO - [mozharness: 2016-11-14 13:47:08.275072Z] Finished download-and-extract step (success) 05:47:08 INFO - [mozharness: 2016-11-14 13:47:08.275189Z] Running populate-webroot step. 05:47:08 INFO - Running pre-action listener: _resource_record_pre_action 05:47:08 INFO - Running main action method: populate_webroot 05:47:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:08 INFO - '--tppagecycles', 05:47:08 INFO - '7'], 05:47:08 INFO - 'tests': ['tsvgm']}}, 05:47:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['damp', 'tps']}, 05:47:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'tests': ['damp', 'tps']}, 05:47:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['dromaeo_dom']}, 05:47:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['basic_compositor_video']}, 05:47:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:47:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['a11yr', 05:47:08 INFO - 'ts_paint', 05:47:08 INFO - 'tpaint', 05:47:08 INFO - 'sessionrestore', 05:47:08 INFO - 'sessionrestore_no_auto_restore', 05:47:08 INFO - 'tabpaint']}, 05:47:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:08 INFO - 'ts_paint', 05:47:08 INFO - 'tpaint', 05:47:08 INFO - 'sessionrestore', 05:47:08 INFO - 'sessionrestore_no_auto_restore', 05:47:08 INFO - 'tabpaint']}, 05:47:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:08 INFO - 'ts_paint', 05:47:08 INFO - 'tpaint', 05:47:08 INFO - 'sessionrestore', 05:47:08 INFO - 'sessionrestore_no_auto_restore', 05:47:08 INFO - 'tabpaint']}, 05:47:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:08 INFO - 'ts_paint', 05:47:08 INFO - 'tpaint', 05:47:08 INFO - 'sessionrestore', 05:47:08 INFO - 'sessionrestore_no_auto_restore', 05:47:08 INFO - 'tabpaint']}, 05:47:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['a11yr', 05:47:08 INFO - 'ts_paint', 05:47:08 INFO - 'tpaint', 05:47:08 INFO - 'sessionrestore', 05:47:08 INFO - 'sessionrestore_no_auto_restore', 05:47:08 INFO - 'tabpaint']}, 05:47:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['a11yr', 05:47:08 INFO - 'ts_paint', 05:47:08 INFO - 'tpaint', 05:47:08 INFO - 'sessionrestore', 05:47:08 INFO - 'sessionrestore_no_auto_restore', 05:47:08 INFO - 'tabpaint']}, 05:47:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['tsvgx', 05:47:08 INFO - 'tsvgr_opacity', 05:47:08 INFO - 'tart', 05:47:08 INFO - 'tscrollx', 05:47:08 INFO - 'cart']}, 05:47:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:08 INFO - 'tsvgr_opacity', 05:47:08 INFO - 'tart', 05:47:08 INFO - 'tscrollx', 05:47:08 INFO - 'cart']}, 05:47:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'talos_options': ['--disable-e10s'], 05:47:08 INFO - 'tests': ['tp5o']}, 05:47:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'tests': ['tp5o']}, 05:47:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'talos_options': ['--disable-e10s', 05:47:08 INFO - '--xperf_path', 05:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:08 INFO - 'tests': ['tp5n']}, 05:47:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:08 INFO - 'talos_options': ['--xperf_path', 05:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:08 INFO - 'tests': ['tp5n']}}, 05:47:08 INFO - 'talos.zip': {'path': '', 05:47:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:08 INFO - Running post-action listener: _resource_record_post_action 05:47:08 INFO - [mozharness: 2016-11-14 13:47:08.294096Z] Finished populate-webroot step (success) 05:47:08 INFO - [mozharness: 2016-11-14 13:47:08.294221Z] Running create-virtualenv step. 05:47:08 INFO - Running pre-action listener: _resource_record_pre_action 05:47:08 INFO - Running main action method: create_virtualenv 05:47:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:08 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 05:47:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:08 INFO - Using real prefix '/tools/python27' 05:47:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:11 INFO - Installing pip.................done. 05:47:11 INFO - Return code: 0 05:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:47:12 INFO - Reading from file tmpfile_stdout 05:47:12 INFO - Output received: 05:47:12 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) 05:47:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:12 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:12 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 05:47:12 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 05:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:12 INFO - 'HOME': '/Users/cltbld', 05:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:12 INFO - 'LOGNAME': 'cltbld', 05:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:12 INFO - 'MOZ_NO_REMOTE': '1', 05:47:12 INFO - 'NO_EM_RESTART': '1', 05:47:12 INFO - 'PAGER': '/bin/cat', 05:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:12 INFO - 'PWD': '/builds/slave/test', 05:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:12 INFO - 'SHELL': '/bin/bash', 05:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:12 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:12 INFO - 'USER': 'cltbld', 05:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:12 INFO - 'XPC_FLAGS': '0x0', 05:47:12 INFO - 'XPC_SERVICE_NAME': '0', 05:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:12 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 05:47:12 INFO - Cleaning up... 05:47:12 INFO - Return code: 0 05:47:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:12 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:12 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 05:47:12 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 05:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:12 INFO - 'HOME': '/Users/cltbld', 05:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:12 INFO - 'LOGNAME': 'cltbld', 05:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:12 INFO - 'MOZ_NO_REMOTE': '1', 05:47:12 INFO - 'NO_EM_RESTART': '1', 05:47:12 INFO - 'PAGER': '/bin/cat', 05:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:12 INFO - 'PWD': '/builds/slave/test', 05:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:12 INFO - 'SHELL': '/bin/bash', 05:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:12 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:12 INFO - 'USER': 'cltbld', 05:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:12 INFO - 'XPC_FLAGS': '0x0', 05:47:12 INFO - 'XPC_SERVICE_NAME': '0', 05:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:12 INFO - Downloading/unpacking psutil>=3.1.1 05:47:12 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 05:47:12 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 05:47:12 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 05:47:12 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 05:47:12 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 05:47:12 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 05:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:16 INFO - Installing collected packages: psutil 05:47:16 INFO - Running setup.py install for psutil 05:47:16 INFO - building 'psutil._psutil_osx' extension 05:47:16 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 05:47:16 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 05:47:16 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 05:47:17 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 05:47:17 INFO - building 'psutil._psutil_posix' extension 05:47:17 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 05:47:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:47:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:47:17 INFO - ^ 05:47:17 INFO - 1 warning generated. 05:47:17 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 05:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:17 INFO - Successfully installed psutil 05:47:17 INFO - Cleaning up... 05:47:17 INFO - Return code: 0 05:47:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47:17 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')]} 05:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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')]} 05:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:17 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 05:47:17 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 05:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:17 INFO - 'HOME': '/Users/cltbld', 05:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:17 INFO - 'LOGNAME': 'cltbld', 05:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:17 INFO - 'MOZ_NO_REMOTE': '1', 05:47:17 INFO - 'NO_EM_RESTART': '1', 05:47:17 INFO - 'PAGER': '/bin/cat', 05:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:17 INFO - 'PWD': '/builds/slave/test', 05:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:17 INFO - 'SHELL': '/bin/bash', 05:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:17 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:17 INFO - 'USER': 'cltbld', 05:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:17 INFO - 'XPC_FLAGS': '0x0', 05:47:17 INFO - 'XPC_SERVICE_NAME': '0', 05:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47:17 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 05:47:17 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 05:47:17 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 05:47:17 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 05:47:17 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 05:47:17 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 05:47:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:20 INFO - Installing collected packages: mozsystemmonitor 05:47:20 INFO - Running setup.py install for mozsystemmonitor 05:47:20 INFO - Successfully installed mozsystemmonitor 05:47:20 INFO - Cleaning up... 05:47:20 INFO - Return code: 0 05:47:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47:20 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')]} 05:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:20 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')]} 05:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:20 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:20 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 05:47:20 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 05:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:20 INFO - 'HOME': '/Users/cltbld', 05:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:20 INFO - 'LOGNAME': 'cltbld', 05:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:20 INFO - 'MOZ_NO_REMOTE': '1', 05:47:20 INFO - 'NO_EM_RESTART': '1', 05:47:20 INFO - 'PAGER': '/bin/cat', 05:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:20 INFO - 'PWD': '/builds/slave/test', 05:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:20 INFO - 'SHELL': '/bin/bash', 05:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:20 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:20 INFO - 'USER': 'cltbld', 05:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:20 INFO - 'XPC_FLAGS': '0x0', 05:47:20 INFO - 'XPC_SERVICE_NAME': '0', 05:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:20 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:20 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 05:47:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:23 INFO - warning: no files found matching '*.txt' 05:47:23 INFO - no previously-included directories found matching 'build' 05:47:23 INFO - no previously-included directories found matching 'dist' 05:47:23 INFO - no previously-included directories found matching '.git*' 05:47:23 INFO - Installing collected packages: jsonschema, functools32 05:47:23 INFO - Running setup.py install for functools32 05:47:23 INFO - warning: no files found matching '*.txt' 05:47:23 INFO - no previously-included directories found matching 'build' 05:47:23 INFO - no previously-included directories found matching 'dist' 05:47:23 INFO - no previously-included directories found matching '.git*' 05:47:23 INFO - Successfully installed jsonschema functools32 05:47:23 INFO - Cleaning up... 05:47:24 INFO - Return code: 0 05:47:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:47:24 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')]} 05:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:24 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')]} 05:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:24 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:24 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 05:47:24 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 05:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:24 INFO - 'HOME': '/Users/cltbld', 05:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:24 INFO - 'LOGNAME': 'cltbld', 05:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:24 INFO - 'MOZ_NO_REMOTE': '1', 05:47:24 INFO - 'NO_EM_RESTART': '1', 05:47:24 INFO - 'PAGER': '/bin/cat', 05:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:24 INFO - 'PWD': '/builds/slave/test', 05:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:24 INFO - 'SHELL': '/bin/bash', 05:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:24 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:24 INFO - 'USER': 'cltbld', 05:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:24 INFO - 'XPC_FLAGS': '0x0', 05:47:24 INFO - 'XPC_SERVICE_NAME': '0', 05:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:47:24 INFO - Cleaning up... 05:47:24 INFO - Return code: 0 05:47:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47:24 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')]} 05:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:24 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')]} 05:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:24 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:24 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 05:47:24 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 05:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:24 INFO - 'HOME': '/Users/cltbld', 05:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:24 INFO - 'LOGNAME': 'cltbld', 05:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:24 INFO - 'MOZ_NO_REMOTE': '1', 05:47:24 INFO - 'NO_EM_RESTART': '1', 05:47:24 INFO - 'PAGER': '/bin/cat', 05:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:24 INFO - 'PWD': '/builds/slave/test', 05:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:24 INFO - 'SHELL': '/bin/bash', 05:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:24 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:24 INFO - 'USER': 'cltbld', 05:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:24 INFO - 'XPC_FLAGS': '0x0', 05:47:24 INFO - 'XPC_SERVICE_NAME': '0', 05:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:24 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 05:47:24 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 05:47:24 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 05:47:24 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 05:47:24 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 05:47:24 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 05:47:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:28 INFO - Downloading docopt-0.6.1.tar.gz 05:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:28 INFO - Running setup.py install for blobuploader 05:47:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:28 INFO - Running setup.py install for requests 05:47:28 INFO - Running setup.py install for docopt 05:47:29 INFO - Successfully installed blobuploader requests docopt 05:47:29 INFO - Cleaning up... 05:47:29 INFO - Return code: 0 05:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:29 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')]} 05:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:29 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')]} 05:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:29 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:29 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 05:47:29 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 05:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:29 INFO - 'HOME': '/Users/cltbld', 05:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:29 INFO - 'LOGNAME': 'cltbld', 05:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:29 INFO - 'MOZ_NO_REMOTE': '1', 05:47:29 INFO - 'NO_EM_RESTART': '1', 05:47:29 INFO - 'PAGER': '/bin/cat', 05:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:29 INFO - 'PWD': '/builds/slave/test', 05:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:29 INFO - 'SHELL': '/bin/bash', 05:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:29 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:29 INFO - 'USER': 'cltbld', 05:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:29 INFO - 'XPC_FLAGS': '0x0', 05:47:29 INFO - 'XPC_SERVICE_NAME': '0', 05:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:29 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-DoxiP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:29 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-UrhIPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:29 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-psK8CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:29 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-IB9s0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:29 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-JsFK5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:29 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-COzLIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-_6_en1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-EKQlIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-7wCFMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Jpkywz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-3cnDDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-KQOqBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-0ue_4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-m8LZXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:30 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Eab5EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:31 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-9vOmw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:31 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-3KfgQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:31 INFO - Running setup.py install for manifestparser 05:47:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:31 INFO - Running setup.py install for mozcrash 05:47:31 INFO - Running setup.py install for mozdebug 05:47:31 INFO - Running setup.py install for mozdevice 05:47:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:31 INFO - Running setup.py install for mozfile 05:47:31 INFO - Running setup.py install for mozhttpd 05:47:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Running setup.py install for mozinfo 05:47:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Running setup.py install for mozInstall 05:47:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Running setup.py install for mozleak 05:47:32 INFO - Running setup.py install for mozlog 05:47:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Running setup.py install for moznetwork 05:47:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:32 INFO - Running setup.py install for mozprocess 05:47:33 INFO - Running setup.py install for mozprofile 05:47:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:33 INFO - Running setup.py install for mozrunner 05:47:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:33 INFO - Running setup.py install for mozscreenshot 05:47:33 INFO - Running setup.py install for moztest 05:47:33 INFO - Running setup.py install for mozversion 05:47:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:33 INFO - Cleaning up... 05:47:33 INFO - Return code: 0 05:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:33 INFO - 'HOME': '/Users/cltbld', 05:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:33 INFO - 'LOGNAME': 'cltbld', 05:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:33 INFO - 'MOZ_NO_REMOTE': '1', 05:47:33 INFO - 'NO_EM_RESTART': '1', 05:47:33 INFO - 'PAGER': '/bin/cat', 05:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:33 INFO - 'PWD': '/builds/slave/test', 05:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:33 INFO - 'SHELL': '/bin/bash', 05:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:33 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:33 INFO - 'USER': 'cltbld', 05:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:33 INFO - 'XPC_FLAGS': '0x0', 05:47:33 INFO - 'XPC_SERVICE_NAME': '0', 05:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-qS5knO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:34 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)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-ChGIHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:34 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)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-mEnSjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:34 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)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-crN_7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:34 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)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-k_AYVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:34 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)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-UsAWLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:34 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)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-xrQ6qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-i51nf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Jy3HnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-qw6k4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-nc5PTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-VQHXkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-6Aq4fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-UXxlx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-GaZFlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:35 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)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-yZFDTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:35 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-ubZQg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:47:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:38 INFO - Downloading blessings-1.6.tar.gz 05:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:38 INFO - Installing collected packages: blessings 05:47:38 INFO - Running setup.py install for blessings 05:47:38 INFO - Successfully installed blessings 05:47:38 INFO - Cleaning up... 05:47:38 INFO - Return code: 0 05:47:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:39 INFO - Reading from file tmpfile_stdout 05:47:39 INFO - Current package versions: 05:47:39 INFO - blessings == 1.6 05:47:39 INFO - blobuploader == 1.2.4 05:47:39 INFO - docopt == 0.6.1 05:47:39 INFO - functools32 == 3.2.3-2 05:47:39 INFO - jsonschema == 2.5.1 05:47:39 INFO - manifestparser == 1.1 05:47:39 INFO - mozInstall == 1.12 05:47:39 INFO - mozcrash == 1.0 05:47:39 INFO - mozdebug == 0.1 05:47:39 INFO - mozdevice == 0.48 05:47:39 INFO - mozfile == 1.2 05:47:39 INFO - mozhttpd == 0.7 05:47:39 INFO - mozinfo == 0.9 05:47:39 INFO - mozleak == 0.1 05:47:39 INFO - mozlog == 3.4 05:47:39 INFO - moznetwork == 0.27 05:47:39 INFO - mozprocess == 0.23 05:47:39 INFO - mozprofile == 0.28 05:47:39 INFO - mozrunner == 6.13 05:47:39 INFO - mozscreenshot == 0.1 05:47:39 INFO - mozsystemmonitor == 0.3 05:47:39 INFO - moztest == 0.7 05:47:39 INFO - mozversion == 1.4 05:47:39 INFO - psutil == 3.1.1 05:47:39 INFO - requests == 1.2.3 05:47:39 INFO - wsgiref == 0.1.2 05:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:39 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:39 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 05:47:39 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 05:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:39 INFO - 'HOME': '/Users/cltbld', 05:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:39 INFO - 'LOGNAME': 'cltbld', 05:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:39 INFO - 'MOZ_NO_REMOTE': '1', 05:47:39 INFO - 'NO_EM_RESTART': '1', 05:47:39 INFO - 'PAGER': '/bin/cat', 05:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:39 INFO - 'PWD': '/builds/slave/test', 05:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:39 INFO - 'SHELL': '/bin/bash', 05:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:39 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:39 INFO - 'USER': 'cltbld', 05:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:39 INFO - 'XPC_FLAGS': '0x0', 05:47:39 INFO - 'XPC_SERVICE_NAME': '0', 05:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 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)) 05:47:40 INFO - Cleaning up... 05:47:40 INFO - Return code: 0 05:47:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:40 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 0x10bf67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bedd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d8caa420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, '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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 05:47:40 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 05:47:40 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 05:47:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:47:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:40 INFO - 'HOME': '/Users/cltbld', 05:47:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:40 INFO - 'LOGNAME': 'cltbld', 05:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:40 INFO - 'MOZ_NO_REMOTE': '1', 05:47:40 INFO - 'NO_EM_RESTART': '1', 05:47:40 INFO - 'PAGER': '/bin/cat', 05:47:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:40 INFO - 'PWD': '/builds/slave/test', 05:47:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:40 INFO - 'SHELL': '/bin/bash', 05:47:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:47:40 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:47:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:40 INFO - 'USER': 'cltbld', 05:47:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:40 INFO - 'XPC_FLAGS': '0x0', 05:47:40 INFO - 'XPC_SERVICE_NAME': '0', 05:47:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:47:40 INFO - Cleaning up... 05:47:40 INFO - Return code: 0 05:47:40 INFO - Running post-action listener: _resource_record_post_action 05:47:40 INFO - Running post-action listener: _start_resource_monitoring 05:47:40 INFO - Starting resource monitoring. 05:47:40 INFO - [mozharness: 2016-11-14 13:47:40.766538Z] Finished create-virtualenv step (success) 05:47:40 INFO - [mozharness: 2016-11-14 13:47:40.767555Z] Running install step. 05:47:40 INFO - Running pre-action listener: _resource_record_pre_action 05:47:40 INFO - Running main action method: install 05:47:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:41 INFO - Reading from file tmpfile_stdout 05:47:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:41 INFO - Reading from file tmpfile_stdout 05:47:41 INFO - Output received: 05:47:41 INFO - Usage: mozinstall [options] installer 05:47:41 INFO - Options: 05:47:41 INFO - -h, --help show this help message and exit 05:47:41 INFO - -d DEST, --destination=DEST 05:47:41 INFO - Directory to install application into. [default: 05:47:41 INFO - "/builds/slave/test"] 05:47:41 INFO - --app=APP Application being installed. [default: firefox] 05:47:41 INFO - mkdir: /builds/slave/test/build/application 05:47:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:48:15 INFO - Reading from file tmpfile_stdout 05:48:15 INFO - Output received: 05:48:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:48:15 INFO - Running post-action listener: _resource_record_post_action 05:48:15 INFO - [mozharness: 2016-11-14 13:48:15.071813Z] Finished install step (success) 05:48:15 INFO - [mozharness: 2016-11-14 13:48:15.071953Z] Running run-tests step. 05:48:15 INFO - Running pre-action listener: _resource_record_pre_action 05:48:15 INFO - Running main action method: run_tests 05:48:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:15 INFO - 2016-11-14 05:48:15.086 screenresolution[1641:7496] starting screenresolution argv=screenresolution get 05:48:15 INFO - 2016-11-14 05:48:15.089 screenresolution[1641:7496] Display 0: 1600x1200x32@60 05:48:15 INFO - 2016-11-14 05:48:15.094 screenresolution[1642:7498] starting screenresolution argv=screenresolution list 05:48:15 INFO - Available Modes on Display 0 05:48:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:15 INFO - Intel Iris: 05:48:15 INFO - Chipset Model: Intel Iris 05:48:15 INFO - Type: GPU 05:48:15 INFO - Bus: Built-In 05:48:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:48:15 INFO - Vendor: Intel (0x8086) 05:48:15 INFO - Device ID: 0x0a2e 05:48:15 INFO - Revision ID: 0x0009 05:48:15 INFO - Displays: 05:48:15 INFO - Display: 05:48:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:15 INFO - Display Serial Number: 1600x1200 60 05:48:15 INFO - Main Display: Yes 05:48:15 INFO - Mirror: Off 05:48:15 INFO - Online: Yes 05:48:15 INFO - Rotation: Supported 05:48:15 INFO - Return code: 0 05:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:15 INFO - Python 2.7.3 05:48:15 INFO - Return code: 0 05:48:15 INFO - grabbing minidump binary from tooltool 05:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:15 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 0x10bd7bd30>, '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 0x10bba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd73b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:15 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 05:48:15 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 05:48:15 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 05:48:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:15 INFO - Return code: 0 05:48:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:48:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:48:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0205', '--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 05:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0205 --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 05:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pt0fZ96Zqz/Render', 05:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:15 INFO - 'HOME': '/Users/cltbld', 05:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:15 INFO - 'LOGNAME': 'cltbld', 05:48:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:15 INFO - 'MOZ_NO_REMOTE': '1', 05:48:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:15 INFO - 'NO_EM_RESTART': '1', 05:48:15 INFO - 'PAGER': '/bin/cat', 05:48:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:15 INFO - 'PWD': '/builds/slave/test', 05:48:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:15 INFO - 'SHELL': '/bin/bash', 05:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OXDnDUtFi0/Listeners', 05:48:15 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 05:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:15 INFO - 'USER': 'cltbld', 05:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:15 INFO - 'XPC_FLAGS': '0x0', 05:48:15 INFO - 'XPC_SERVICE_NAME': '0', 05:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0205', '--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 05:48:15 INFO - mozversion application_buildid: 20161114030203 05:48:15 INFO - mozversion application_changeset: 1196bf3032e1bce1fb07a01fd9082a767426c5fb 05:48:15 INFO - mozversion application_display_name: Nightly 05:48:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:15 INFO - mozversion application_name: Firefox 05:48:15 INFO - mozversion application_remotingname: firefox 05:48:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:15 INFO - mozversion application_vendor: Mozilla 05:48:15 INFO - mozversion application_version: 52.0a1 05:48:15 INFO - mozversion platform_buildid: 20161114030203 05:48:15 INFO - mozversion platform_changeset: 1196bf3032e1bce1fb07a01fd9082a767426c5fb 05:48:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:15 INFO - mozversion platform_version: 52.0a1 05:48:15 INFO - using testdate: 1479131295 05:48:15 INFO - actual date: 1479131295 05:48:15 INFO - starting webserver on 'localhost:49268' 05:48:15 INFO - SUITE-START | Running 2 tests 05:48:15 INFO - TEST-START | dromaeo_css 05:48:15 INFO - operating with platform_type : mac_ 05:48:15 INFO - Initialising browser for dromaeo_css test... 05:48:15 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpHuESPw/profile http://localhost:49268/getInfo.html) 05:48:18 INFO - PROCESS | 1652 | 2016-11-14 05:48:18.744 plugin-container[1655:7664] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 05:48:18 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:48:18 INFO - PROCESS | 1652 | 2016-11-14 05:48:18.745 plugin-container[1655:7664] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 05:48:18 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:48:18 INFO - PROCESS | 1652 | 2016-11-14 05:48:18.745 plugin-container[1655:7664] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:48:18 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 05:48:18 INFO - PROCESS | 1652 | colorDepth:24 05:48:18 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 05:48:18 INFO - PROCESS | 1652 | __metrics 05:48:18 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 05:48:19 INFO - TEST-INFO | 1652: exit 0 05:48:19 INFO - Browser initialized. 05:48:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:19 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpHuESPw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:22 INFO - PROCESS | 1656 | 2016-11-14 05:48:22.228 plugin-container[1657:7787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:48:22 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:48:22 INFO - PROCESS | 1656 | 2016-11-14 05:48:22.229 plugin-container[1657:7787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 05:48:22 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:48:22 INFO - PROCESS | 1656 | 2016-11-14 05:48:22.229 plugin-container[1657:7787] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:48:31 INFO - PROCESS | 1656 | RSS: Main: 237899776 05:48:31 INFO - PROCESS | 1656 | 05:49:21 INFO - PROCESS | 1656 | 1479131361454 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:51:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 05:51:36 INFO - PROCESS | 1656 | RSS: Main: 251650048 05:51:36 INFO - PROCESS | 1656 | 05:54:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 05:54:39 INFO - PROCESS | 1656 | RSS: Main: 264028160 05:54:39 INFO - PROCESS | 1656 | 05:57:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 05:57:42 INFO - PROCESS | 1656 | RSS: Main: 267440128 05:57:42 INFO - PROCESS | 1656 | 06:00:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 06:00:44 INFO - PROCESS | 1656 | RSS: Main: 266891264 06:00:44 INFO - PROCESS | 1656 | 06:03:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 06:03:48 INFO - PROCESS | 1656 | RSS: Main: 271290368 06:03:48 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 06:06:51 INFO - PROCESS | 1656 | RSS: Main: 273436672 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | __start_tp_report 06:06:51 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 06:06:51 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 06:06:51 INFO - PROCESS | 1656 | |i|pagename|runs| 06:06:51 INFO - PROCESS | 1656 | |0;dojo.html;2968.688287729787;3039.8480075996204;3426.5888093428784;3430.953559164454;3431.6739909708567;5659.886802263957;5663.150527420884;5684.772609095637;5735.053716136843;5736.368999410061;5488.313960754906;5621.4659607337235;5647.802326918549;5672.262605861232;5673.943260567393;4444.400005999198;5103.770330335125;5116.820911268106;5183.896322073556;5343;5253.8949221015555;5307.495787900143;5333.706646134461;5335.5198032177095;5347.786088556453;5224.21636754488;5322.2282768998475;5327.973360133214;5332.520073193412;5337.332833395825;5231.738413079369;5251.76367063483;5308.6549374290935;5336.4930331618625;5359.115745901921;5003.274525193827;5023.447420783711;5119.923201151985;5168.198929165986;5204.869878253036;5037.042961837239;5610;5665.603407761459;5667.971660141714;5753.913691294634;6214.130021796952;6228.408301211378;6280.1835761351185;6283.905741413882;6306.180196574462;6227.875442491125;6232.158658581079;6237.064440333941;6312.179416675849;6336.081268216083;5860.853478663067;5878.118282257696;5884.32330282023;5884.794032208895;5902.32123305821;6278.905816412757;6279.780207692709;6295.842603934847;6305.495560355161;6307.432331090224;6081.118237855486;6111.135969295249;6115.057807494094;6119.929102025404;6145.217886812864;6144.631322120687;6260.561760676709;6278.560500764994;6296.150019747367;6308.053791931247;6141.539384546177;6222.848772977014;6233.1273621693;6261.499080073583;6270.028145637433;6106.612350340322;6145.770845830852;6160.383961603893;6192.504599632019;6235.064740288903;4213.536510983789;4904.509549045139;4949.802007919643;4972.7513624318635;4982.825601103944;4418.226810308183;4436.3567282743825;4460;4463.37512748209;4471.6646251531265;4889.926651100236;4975.0547395994645;5778.133280008033;5802.100674395476;5933.2286802716235;4726.929096063562;5749.741261643236;6091.843511185564;6181.474574661114;6253.96873015632;5980.102984552352;5981.970090149522;5982.910256346158;5995.370486098896;6042.879142417215;5363.865903352447;5433.864153396196;5439.401665816757;5450.91823622646;5507.311586051744;6186.566940314135;6272.372762723691;6290.528210384148;6299.716512756937;6371.203599550056;5443.237946687546;6138.324784273816;6283.2774230962195;6289.591176573508;6300.495960323255;6313.463355614824;6349;6383;6392.20097487814;6418.614883107029;6053.213082299273;6092.969535152296;6253.624782513064;6272.843178920563;6281.057841323838;6137.570370074052;6138.235132557229;6198.535109866688;6243.750249989949;6282.654454004891;6027.246594175728;6050.122732203894;6120.877582448237;6124.601900876429;6143.109249158936;6110.984061328523;6132.478739307209;6133.73253493014;6145.187169784835;6155.938440615537;5979.970100149471;6011.939880601138;6069.939300607114;6079.483243924316;6092.390760923872;6014.548908831943;6046.365131661289;6093.268807743099;6132.17215675878;6180.7527698891545;5972.790952316648;6007.939920600913;6012.759489620366;6062.060380641008;6104.603200791934 06:06:51 INFO - PROCESS | 1656 | |1;ext.html;470.3133425199209;482.4138671514112;496.58783209935757;513.6840842881628;530.8991291654586;35103.2979340413;39258.99999999996;39353.016174595614;40994.795026024825;41004.179916401656;39764;40073.19853602926;40119.197616047735;40141.799291003575;40327.395089073616;9190.586423610954;9298.72103836886;9342.486163261017;9354.719358419225;9367.484788336673;9140.680076197334;9270.860937085916;9354.345195836295;9359.859602105973;9366.20387267083;9202.907970920305;9334;9339.06609339064;9348.205402540758;9369.67206147785;9274.304427167956;9316.8602470963;9335.393199442082;9355.48544830034;9412.058794120601;7758.806029849243;9191.172794448532;9198.356115071947;9200.953995230047;9206.309526785519;38248.61751382506;38580.649677261164;38609;38757.41863872044;38795;3201.2725555500137;3327.866885324584;3369.2082360645472;3499.230169362736;3896.80515974203;25576.616350754754;27068.323291917663;27897.884084636793;29736;29765.404691906257;3132.859021344045;3140;3282.425575524274;3293.357795229931;3324.833758312099;493884;498815;500311;501638.96722065355;502036;57474.5631359211;57866.421335786945;58294.7085264571;58386.708066459396;58420.70789646025;60984.69507652522;61198;61309.69345153335;61409.07886381708;61564;15258.542243732705;15348.002379845275;15606.3757449703;15619.921900390425;15624.76562851558;9782.902170978341;11591.6522504325;11610.187286890006;11614.70963225926;11620.360880151504;13844.515441959484;17830.37593684215;17878.195481203376;17894.642107157782;17914.55213619644;6554.901676474857;6875.346842049998;7573.053368328959;7592.354649854714;7617.314441700273;820.8399362124447;889.1508609278123;961.3606951377395;1009.3388830316155;1020.1226944827442;26081;27539.724602753715;28539.57190642142;28624.998125065522;28682.282942926595;1020.4081632653043;1056.5351245451977;1062.9202809789297;1063.2769716592636;1103.1450625765096;14725.55823325302;14727.631809204642;14810.185439800915;14868.794485427801;14982;689056;690373;691439;697678;698692;53961.730191349576;54080;54336.72831635817;54378.64053398697;54619.45380546223;1310.9541166059332;1321.5044358365612;1337.571976967361;1341.745467987435;1346.6431395680152;19778.90110549438;26005.089821856145;26652.60021099724;28266.85866570654;28532.714672853006;42133;42142;42442.57557424386;42451.15097697967;42495.15009699727;498006;499597;499713;500138;500587;25017.999280028595;25140.74859251384;25449.491010180063;25557.744422555537;25593.488130237663;37158.07104822401;43684.12631747284;43836.90407739704;44672.776636116614;45268.094638107716;36352;36526;36537;37338.62661373351;37840.243195135394;36694.735059929546;36702.89891303265;37407.251854963295;37903.62096379001;38051;36063;36084.639153609176;36136.45795313125;36307;36846.44730329101;31304;31780;32940.50589241115;33018.33963320768;33058.669413306525;24182.63726044146;24607.87696061508;24750.876245618656;25082.498350032532;25095 06:06:51 INFO - PROCESS | 1656 | |2;jquery.html;369.99260014799705;372.46923134533284;377.62615011138973;382.84303435591414;401.0555142639085;17902.910485447555;18676.719849202273;18687.439376818682;19482.707759383622;20342;17620.11899405031;18382.44852654419;19445.805541944577;19898.90050549745;19964.600707985832;4159.355299928501;5138.64029517933;5292.100342941709;5334.399680095975;5336.38631557372;5303.7348132593215;5317.627766056377;5359.651622644536;5359.812406565771;5360.865978350553;5061.468545802693;5347.866303342409;5358.973205133969;5361.51746342829;5370;5170.793168273264;5173.586113110942;5263.263143159922;5264.921026184591;5281.656692314988;4440.91197656573;4754.548317909793;4817.325574419584;5113.69317840927;6910.274421185753;26421.47157056848;26795.33011674704;27142.457150856873;27199.86400067987;27577.44845103107;2136.5192831612917;2365.680633114525;2492.9750702492925;2506.636537702041;2536.8604726740023;15302.923485382502;15850.920745396315;15977.201139942956;16538.421155259628;17026.89325193871;1844.8561891627144;1878;1879.4585014967129;1985.0967809646577;2021.090509270834;123720.38139809333;134033;136133.3193334027;136850;137115.999999999;19534.5116372089;20708.378748637566;20919.26782562603;20950.790492094882;21050;32105.839470802497;32719.50920736191;32777.50833737496;32790.21283190956;32808.179795504824;8612.956935215409;10158.390496570082;10199.592016319413;10256.487175641189;10348.896511034793;8427.87841813688;8506.829863402698;8519.57402129891;8553.700620478254;8663;7818;9309.115634014757;9437.197838183694;9533.094356036165;9591.42451452915;3679.889603311905;3809.790461524643;3812.923741525154;3830.731848770615;3835.328817456934;815.5555222403805;826.2109685250572;859.3168431097292;894.7539426657592;944.3059351376733;19407;20163.79836201619;20189.596208075756;20285.78285302857;20617.690734638993;836.5947899788109;901.2249465459699;920.6409500294891;924.2467389078014;951.2580187453797;10109.635199248154;10382.42896640677;10748.54894589236;10756.462176891124;10794.514246858911;493641;500761;502608;521943;559308;108873;117011.6597668042;118777;120331.39834300772;123621.25598068169;388.91638297766116;440.50883265159115;447.2106731618696;448.5514485514486;451.58679807975335;8462.957685211535;9802.019798020141;10386.48067596602;10726.517306721373;11421.543138274375;36950;42137.41831944197;50292.87113669974;52736.73631631817;53011.20483192832;50348.74825625995;74803.62598186974;75111.62444187744;76034.4793104146;76296.61851690707;7037.190723066913;7683.692652293846;7900.920990790019;7922.286994170552;8094.797630059295;9208.861867072133;10149.949250253701;12126.27242365461;12233.266004039786;12277.570285039981;10309.329893556895;10330.586776528855;10513.264071514921;10585.629502967358;10773.407462589634;10342.172626189737;10395.272330936761;10463;10644.84032739525;10727.356358618508;10674.519646615765;10787.730306742395;10896.346219226873;10999.560017599206;11051.336919784839;7792.181820908723;7851.685932562634;7951.165127661512;7969;7983.32141767933;8023.4784738991775;9822.361546499455;10247.231457640557;10909;10920.235583509078 06:06:51 INFO - PROCESS | 1656 | |3;mootools.html;1464.6631274806791;1514.644058646218;1644.0382376309858;1690.3069741406025;1765.6821772081037;7472.663730132143;7754.883676744853;7997.8400431991395;8434.620442080106;8438.704645337415;7950.920490795091;8273.95863020684;8316.334693224542;8377.036640786311;8392.244697977181;2253.8985745641403;2294.3117064880553;2294.827887908405;2300.735415427222;2305.804006659436;2289.427643089228;2321.071571371448;2332.7084114485688;2338.2751347082376;2347.4366152123453;2277.8974946127464;2291.0721157931066;2291.346966114658;2319.8492098013658;2325.5581439526436;2275.7496675365696;2283.075354481438;2301.0335659023335;2303.447172678562;2312.90748370065;1752.535578071812;1801.9369322073665;1909.4080834941074;2328.6507023946374;2336.0772494864605;8349.248567628882;8372.706955256597;8390.664373425117;8397.622107005138;8417.452865563719;4969.900601987976;5133.204353325241;5147.330846989905;5155.690658560498;5181.274621552986;2737.630419893309;2954.409118176352;3317.9170520737175;3558.87543935961;3574.3566158091535;937.929655275857;941.8493041113458;951.4053716427233;1082.815921293382;1084.4740300954031;8723.651053957834;10911.945440272748;11009.339439633648;11014.50434730431;11052.392118433403;4064.6748260139116;4632.2125238709505;4672.672912896064;4678.578927896506;4691.132140554008;9417.152456278967;9475.241980641533;9514.857277140849;9515.048495150568;9516.524173791422;5161.974190129025;5176.637635365563;5187.0922588546855;5195.480451954774;5200.97399513;3532;4050.1494686116243;4665.883352916204;4688.2030054890065;4753.215719406328;3502.264524449843;3656.597774244831;3731.9626803731617;3811.8284677189595;3846.6922646188236;1146.9598564050384;1244.4089057697522;1252.1422825364655;1253.9373031348396;1266.1263728027816;601.482724856623;896.2650626486219;897.6454300551246;907.3421769217265;908.0692290402259;5639.3232812062815;5812.186293918855;5822.737976791054;5888.911666325009;5984.461398474071;925.6991477769752;931.4364809290417;933.7898972731081;948.2982592881218;962.5043102802063;3764.378877485184;3959.208158368338;3995.360742281221;3995.9800200998807;4039.474868267165;9896.950515247378;9939.155171810477;10247.538860751283;10263.9486802567;10279.845802312972;7949.6025198739835;9865.654702085392;10173.08442240202;10199.13307368867;10214.336068155546;6450.612963222222;6456.0961465394885;7000.439964802804;7553.584552849646;7926.286634202834;4763.952360476351;5518.041095411232;5680.346760122638;5688.203651488878;5732.57005724564;9301.906980930104;9307.836520434945;9339.346245762732;9482.620695172116;9490.050994900455;9477.952610236905;9530.237580993642;9555.808883822145;9574.760630984281;9672.468014259282;6215.564910456405;6477.611343319416;6563.835904102245;6582;6836.213835408793;7875.173106823701;8009.91990080115;8025.2777250047775;8029.759107226792;8038.075621303625;7009.1589009319205;7116.573005619679;7168.390686791681;7173.461990350849;7244.89132663;6946.826329341605;6997.685104170223;7018.894716579153;7079.752208672672;7092.503524753218;6599.703013364314;6626.801195964129;6694.59832410057;6728.125343705287;6744.527883048139;4045.7167998239843;4774.904501910012;4817.879553011203;4858.271259311132;4905.48492408292;4809.470958194665;4906.607471402351;4923.950760492349;4956.058348913695;4970.204767237225 06:06:51 INFO - PROCESS | 1656 | |4;prototype.html;298.2989973562128;299.63594233006893;302.3182722959726;310.19968481318193;313.6377484005973;4024.3359845625473;4530.433695788027;4605.332226827108;5220.190870415087;5534.391216966135;4546.272596384579;4963.975180124095;5177.404598471167;5340.489969714228;5369.785208591652;3630.4009838376637;3647.9420967919273;3964.5242570891533;4127.4427952226515;4188.602082802129;3699.519062521882;3851.287511810324;4168.95776055986;4178.56125106864;4180.958190418102;3994.3009973254566;4068.904514175202;4074.5314288856716;4098.139390727951;4115.48955137366;4064.0855807443236;4074.470318858544;4089.2434899543678;4089.85685501009;4090.2637525245445;2924.6490421149388;3354.228527438678;3534.7348948828685;3547.5033495310417;3594.0835087052897;5153.56194723449;5233.953209358106;5240.95180963805;5280.577553795687;5413.26920865682;3743.6069212732814;4613.907721845578;4619.528552224544;4640.67515273931;4698.577128058457;4965.4041515018425;4965.553100220997;5644.971775141139;5699.316082070137;5704.3154821421695;3761.6426439488478;3810.6951443884423;3829.6744776694013;3889.8444062237477;3893.06566424059;5006.6245031622775;5363;5748.2527271454865;5793.073108302693;5936.465718085393;3585.175409655794;3717.981410092932;3911.02224443889;3917.2948869203815;3941.6649584785614;3788.734788564829;3814.8664796731982;3967;3980.661643760313;3991.7405368650943;3888.319544079775;4597.264627546671;4621.12198682256;4629.930551041737;4656.138614356355;5691.345495268097;5697.088465845445;5711.8000869969355;5721.313442386857;5754.625949313281;1068.1881769854965;1208.7642909632536;1233.4387853526623;1277.993610031944;1281.6859869332072;725.3834240895197;785.1598789295399;866.5104216117874;878.6995247034297;889.1286539191628;4318.784060796947;4624.676272660949;4636.522608043967;4657.278121891112;4680.092123077201;4981.352424184833;5171.741412929414;5259.8422047338645;5275.472452754694;5333.413324534298;4306.870793876189;4617.607503362252;5048.268001139814;5061.6962982221185;5094.7962081516325;2607.5658387886588;2806.6424203669017;2928.282570770132;2950.4689155952133;2965.41350377547;5625.943740562624;5626.578006649435;5765.308163020464;5831.475167234969;5896.378495913658;5315.6279060465395;5466.562674985991;5687.60186786921;5730.796532728091;5766;4798.808047678054;5673.74468148926;5769.68266745333;5795.82612521625;5906.379830117776;4934.8766280843265;5137.897242055213;5499.532539734168;5921.319048309328;5923.763049478145;4750.406199225097;4917.26241063829;5898.439648233411;5904.61619994699;5907.586468947133;4959.305697202467;5176.456472070529;6108.633481991094;6214.72033758491;6285.397223707925;3367.4641626291805;3866.2022159695875;3906.7655940643654;3929.9607003929596;3943.408488726714;5873.329169269206;5914.645121292736;5919.260092488439;5938.376470470538;5951.702414879325;5123.692578445305;5217.034848553029;5654.604177707521;5739.483446489836;5745.368009519033;4358.520562738159;5327.539272245824;5657.643614416794;5756.920047774421;5784.392638772868;5231.215317702375;5491.203775452617;5619.915701264403;5665.716714164193;5676.801311954062;4847.854564363075;5111.623095260722;5803.709814509342;5851.502622277154;5867.178594996789;5362.731863406892;5531.197976293334;5657.3593657838765;5729.828105156852;5731.254936858182 06:06:51 INFO - PROCESS | 1656 | |5;yui.html;630.3853742600965;704.9118860142482;710.6091649592722;717.9589595087125;727.4471401734687;14064.22646754428;14137.363818628148;14349.139051656895;14512.564623061298;14639.487617933375;12842.614721558368;12929.224246545215;12969.286689232113;12986;13000.674983125404;658.3844105761104;832.8584140696096;842.5660784695887;843.2200214801314;844.1389782421957;645.7223393940603;667;800.3757069485781;832.309183377795;832.7293629570383;881.039666763228;881.4006475596592;881.418263945796;882.311796798495;883.0815951410525;847.3560094328354;872.437277955715;876.447837862146;876.7238319929234;877.1272583779116;651.0169643837839;652.5562617420153;653.0465520340261;654.1790053482896;655.8721049395369;13208.801867971988;13720.65698357539;13909.30453477322;13947.58157255284;13965.231912244823;12829.61511154667;13059.412326445332;13093.345332733325;13100.541481048118;13341.399637016357;10974.396408197546;11034.337939723562;11127.387993660346;11259.718507037307;11388.715282118013;3556.3776339140545;3623.601403845575;3686.0600546860646;3698.4082546792383;3720.8883733488037;85165.72251416233;86532.56733716291;90839.54580227123;91297.54351228202;91812.54093729555;10135.64525241613;10306.227032972407;10405.115565176893;10513.158947284352;10769.407682577534;19924.402267931986;19958.401247962585;19995.40013799559;20016.199352026048;20066.297679581145;7372.1583171989305;7553.8866916996285;7554.848903021909;7694.422918281151;7705.30652241301;4201.642860356904;4228.851990180329;4296.935545966813;4399.868003959887;4405.889852753707;3269.2644155065395;3331.9666803331656;3382.9323413531592;3388.373150967079;3393;643.4144928115393;663.9269680335159;663.9800805975829;675.895236238374;681.5978572642165;569.3281927325795;615.827568280882;640.9936399852187;649.2351476342898;659.4987809264993;8193.180681931759;8289.917100829036;8373.413861029669;8375.874361884577;8390.622421991025;612.2408213814927;630.130420020369;634.3751404866204;653.6894974886891;661.2362721057186;4093.7339072960162;4134.627883490501;4196.118815048813;4248.936265956013;4275.5724427557;105763.4711826436;107979.46010269898;108320;110702.89297106926;112073;71488.28511714921;73872.89190662037;82116;92183.53908230415;94271;79836.40327193424;80189;80399.35207775104;80468.19531804725;83060.75408868871;7624.580648064188;8905.866412003696;8996.28029757631;9085.091490850862;9177.495237761721;48124.27813582729;48631.5136848627;49699.75150124226;49932.25101623406;50694.23958640549;66893;68449.63100737857;69727.65136174287;70238;71314.57370852657;12009.939950300193;12080.879191208327;12203.877961220274;12265.325407102695;12347.345320755721;13460.93269533646;13582.660433489242;13719.45122195101;13866.791998119834;14416.855831441972;12288.81566776517;12463.688407789878;12484.563040293546;12703.42834572465;12887.16233444823;12614.750951167258;12661.683457913627;12798.488060477477;12811.551595694105;12859.871401285867;12162.878371216175;12276.202046866925;12375.133740638068;12496.187747796364;12763.93618031941;8189.1808836504715;10474;10565.63020294286;10750.517236209746;10799.40603266828;9716.75708107303;10101.797964040825;10176.389416635026;10268.281220314506;10365.170786337225 06:06:51 INFO - PROCESS | 1656 | __end_tp_report 06:06:51 INFO - PROCESS | 1656 | __start_cc_report 06:06:51 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,375 06:06:51 INFO - PROCESS | 1656 | __end_cc_report 06:06:51 INFO - PROCESS | 1656 | __startTimestamp1479132411644__endTimestamp 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | ------- Summary: start ------- 06:06:51 INFO - PROCESS | 1656 | Number of tests: 6 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5732.29 Median:6014.55 stddev:674.84 (11.2%) stddev-sans-first:641.15 06:06:51 INFO - PROCESS | 1656 | Values: 2968.7 3039.8 3426.6 3431.0 3431.7 5659.9 5663.2 5684.8 5735.1 5736.4 5488.3 5621.5 5647.8 5672.3 5673.9 4444.4 5103.8 5116.8 5183.9 5343.0 5253.9 5307.5 5333.7 5335.5 5347.8 5224.2 5322.2 5328.0 5332.5 5337.3 5231.7 5251.8 5308.7 5336.5 5359.1 5003.3 5023.4 5119.9 5168.2 5204.9 5037.0 5610.0 5665.6 5668.0 5753.9 6214.1 6228.4 6280.2 6283.9 6306.2 6227.9 6232.2 6237.1 6312.2 6336.1 5860.9 5878.1 5884.3 5884.8 5902.3 6278.9 6279.8 6295.8 6305.5 6307.4 6081.1 6111.1 6115.1 6119.9 6145.2 6144.6 6260.6 6278.6 6296.2 6308.1 6141.5 6222.8 6233.1 6261.5 6270.0 6106.6 6145.8 6160.4 6192.5 6235.1 4213.5 4904.5 4949.8 4972.8 4982.8 4418.2 4436.4 4460.0 4463.4 4471.7 4889.9 4975.1 5778.1 5802.1 5933.2 4726.9 5749.7 6091.8 6181.5 6254.0 5980.1 5982.0 5982.9 5995.4 6042.9 5363.9 5433.9 5439.4 5450.9 5507.3 6186.6 6272.4 6290.5 6299.7 6371.2 5443.2 6138.3 6283.3 6289.6 6300.5 6313.5 6349.0 6383.0 6392.2 6418.6 6053.2 6093.0 6253.6 6272.8 6281.1 6137.6 6138.2 6198.5 6243.8 6282.7 6027.2 6050.1 6120.9 6124.6 6143.1 6111.0 6132.5 6133.7 6145.2 6155.9 5980.0 6011.9 6069.9 6079.5 6092.4 6014.5 6046.4 6093.3 6132.2 6180.8 5972.8 6007.9 6012.8 6062.1 6104.6 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68514.81 Median:38776.21 stddev:153106.93 (394.8%) stddev-sans-first:153451.19 06:06:51 INFO - PROCESS | 1656 | Values: 470.3 482.4 496.6 513.7 530.9 35103.3 39259.0 39353.0 40994.8 41004.2 39764.0 40073.2 40119.2 40141.8 40327.4 9190.6 9298.7 9342.5 9354.7 9367.5 9140.7 9270.9 9354.3 9359.9 9366.2 9202.9 9334.0 9339.1 9348.2 9369.7 9274.3 9316.9 9335.4 9355.5 9412.1 7758.8 9191.2 9198.4 9201.0 9206.3 38248.6 38580.6 38609.0 38757.4 38795.0 3201.3 3327.9 3369.2 3499.2 3896.8 25576.6 27068.3 27897.9 29736.0 29765.4 3132.9 3140.0 3282.4 3293.4 3324.8 493884.0 498815.0 500311.0 501639.0 502036.0 57474.6 57866.4 58294.7 58386.7 58420.7 60984.7 61198.0 61309.7 61409.1 61564.0 15258.5 15348.0 15606.4 15619.9 15624.8 9782.9 11591.7 11610.2 11614.7 11620.4 13844.5 17830.4 17878.2 17894.6 17914.6 6554.9 6875.3 7573.1 7592.4 7617.3 820.8 889.2 961.4 1009.3 1020.1 26081.0 27539.7 28539.6 28625.0 28682.3 1020.4 1056.5 1062.9 1063.3 1103.1 14725.6 14727.6 14810.2 14868.8 14982.0 689056.0 690373.0 691439.0 697678.0 698692.0 53961.7 54080.0 54336.7 54378.6 54619.5 1311.0 1321.5 1337.6 1341.7 1346.6 19778.9 26005.1 26652.6 28266.9 28532.7 42133.0 42142.0 42442.6 42451.2 42495.2 498006.0 499597.0 499713.0 500138.0 500587.0 25018.0 25140.7 25449.5 25557.7 25593.5 37158.1 43684.1 43836.9 44672.8 45268.1 36352.0 36526.0 36537.0 37338.6 37840.2 36694.7 36702.9 37407.3 37903.6 38051.0 36063.0 36084.6 36136.5 36307.0 36846.4 31304.0 31780.0 32940.5 33018.3 33058.7 24182.6 24607.9 24750.9 25082.5 25095.0 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:33139.26 Median:18660.00 stddev:86995.49 (466.2%) stddev-sans-first:87204.74 06:06:51 INFO - PROCESS | 1656 | Values: 370.0 372.5 377.6 382.8 401.1 17902.9 18676.7 18687.4 19482.7 20342.0 17620.1 18382.4 19445.8 19898.9 19964.6 4159.4 5138.6 5292.1 5334.4 5336.4 5303.7 5317.6 5359.7 5359.8 5360.9 5061.5 5347.9 5359.0 5361.5 5370.0 5170.8 5173.6 5263.3 5264.9 5281.7 4440.9 4754.5 4817.3 5113.7 6910.3 26421.5 26795.3 27142.5 27199.9 27577.4 2136.5 2365.7 2493.0 2506.6 2536.9 15302.9 15850.9 15977.2 16538.4 17026.9 1844.9 1878.0 1879.5 1985.1 2021.1 123720.4 134033.0 136133.3 136850.0 137116.0 19534.5 20708.4 20919.3 20950.8 21050.0 32105.8 32719.5 32777.5 32790.2 32808.2 8613.0 10158.4 10199.6 10256.5 10348.9 8427.9 8506.8 8519.6 8553.7 8663.0 7818.0 9309.1 9437.2 9533.1 9591.4 3679.9 3809.8 3812.9 3830.7 3835.3 815.6 826.2 859.3 894.8 944.3 19407.0 20163.8 20189.6 20285.8 20617.7 836.6 901.2 920.6 924.2 951.3 10109.6 10382.4 10748.5 10756.5 10794.5 493641.0 500761.0 502608.0 521943.0 559308.0 108873.0 117011.7 118777.0 120331.4 123621.3 388.9 440.5 447.2 448.6 451.6 8463.0 9802.0 10386.5 10726.5 11421.5 36950.0 42137.4 50292.9 52736.7 53011.2 50348.7 74803.6 75111.6 76034.5 76296.6 7037.2 7683.7 7900.9 7922.3 8094.8 9208.9 10149.9 12126.3 12233.3 12277.6 10309.3 10330.6 10513.3 10585.6 10773.4 10342.2 10395.3 10463.0 10644.8 10727.4 10674.5 10787.7 10896.3 10999.6 11051.3 7792.2 7851.7 7951.2 7969.0 7983.3 8023.5 9822.4 10247.2 10909.0 10920.2 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5382.00 Median:5191.29 stddev:2971.77 (57.2%) stddev-sans-first:2965.53 06:06:51 INFO - PROCESS | 1656 | Values: 1464.7 1514.6 1644.0 1690.3 1765.7 7472.7 7754.9 7997.8 8434.6 8438.7 7950.9 8274.0 8316.3 8377.0 8392.2 2253.9 2294.3 2294.8 2300.7 2305.8 2289.4 2321.1 2332.7 2338.3 2347.4 2277.9 2291.1 2291.3 2319.8 2325.6 2275.7 2283.1 2301.0 2303.4 2312.9 1752.5 1801.9 1909.4 2328.7 2336.1 8349.2 8372.7 8390.7 8397.6 8417.5 4969.9 5133.2 5147.3 5155.7 5181.3 2737.6 2954.4 3317.9 3558.9 3574.4 937.9 941.8 951.4 1082.8 1084.5 8723.7 10911.9 11009.3 11014.5 11052.4 4064.7 4632.2 4672.7 4678.6 4691.1 9417.2 9475.2 9514.9 9515.0 9516.5 5162.0 5176.6 5187.1 5195.5 5201.0 3532.0 4050.1 4665.9 4688.2 4753.2 3502.3 3656.6 3732.0 3811.8 3846.7 1147.0 1244.4 1252.1 1253.9 1266.1 601.5 896.3 897.6 907.3 908.1 5639.3 5812.2 5822.7 5888.9 5984.5 925.7 931.4 933.8 948.3 962.5 3764.4 3959.2 3995.4 3996.0 4039.5 9897.0 9939.2 10247.5 10263.9 10279.8 7949.6 9865.7 10173.1 10199.1 10214.3 6450.6 6456.1 7000.4 7553.6 7926.3 4764.0 5518.0 5680.3 5688.2 5732.6 9301.9 9307.8 9339.3 9482.6 9490.1 9478.0 9530.2 9555.8 9574.8 9672.5 6215.6 6477.6 6563.8 6582.0 6836.2 7875.2 8009.9 8025.3 8029.8 8038.1 7009.2 7116.6 7168.4 7173.5 7244.9 6946.8 6997.7 7018.9 7079.8 7092.5 6599.7 6626.8 6694.6 6728.1 6744.5 4045.7 4774.9 4817.9 4858.3 4905.5 4809.5 4906.6 4924.0 4956.1 4970.2 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4512.88 Median:4973.45 stddev:1406.32 (28.3%) stddev-sans-first:1374.23 06:06:51 INFO - PROCESS | 1656 | Values: 298.3 299.6 302.3 310.2 313.6 4024.3 4530.4 4605.3 5220.2 5534.4 4546.3 4964.0 5177.4 5340.5 5369.8 3630.4 3647.9 3964.5 4127.4 4188.6 3699.5 3851.3 4169.0 4178.6 4181.0 3994.3 4068.9 4074.5 4098.1 4115.5 4064.1 4074.5 4089.2 4089.9 4090.3 2924.6 3354.2 3534.7 3547.5 3594.1 5153.6 5234.0 5241.0 5280.6 5413.3 3743.6 4613.9 4619.5 4640.7 4698.6 4965.4 4965.6 5645.0 5699.3 5704.3 3761.6 3810.7 3829.7 3889.8 3893.1 5006.6 5363.0 5748.3 5793.1 5936.5 3585.2 3718.0 3911.0 3917.3 3941.7 3788.7 3814.9 3967.0 3980.7 3991.7 3888.3 4597.3 4621.1 4629.9 4656.1 5691.3 5697.1 5711.8 5721.3 5754.6 1068.2 1208.8 1233.4 1278.0 1281.7 725.4 785.2 866.5 878.7 889.1 4318.8 4624.7 4636.5 4657.3 4680.1 4981.4 5171.7 5259.8 5275.5 5333.4 4306.9 4617.6 5048.3 5061.7 5094.8 2607.6 2806.6 2928.3 2950.5 2965.4 5625.9 5626.6 5765.3 5831.5 5896.4 5315.6 5466.6 5687.6 5730.8 5766.0 4798.8 5673.7 5769.7 5795.8 5906.4 4934.9 5137.9 5499.5 5921.3 5923.8 4750.4 4917.3 5898.4 5904.6 5907.6 4959.3 5176.5 6108.6 6214.7 6285.4 3367.5 3866.2 3906.8 3930.0 3943.4 5873.3 5914.6 5919.3 5938.4 5951.7 5123.7 5217.0 5654.6 5739.5 5745.4 4358.5 5327.5 5657.6 5756.9 5784.4 5231.2 5491.2 5619.9 5665.7 5676.8 4847.9 5111.6 5803.7 5851.5 5867.2 5362.7 5531.2 5657.4 5729.8 5731.3 06:06:51 INFO - PROCESS | 1656 | 06:06:51 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:19635.37 Median:4348.40 stddev:28620.97 (658.2%) stddev-sans-first:28665.68 06:06:51 INFO - PROCESS | 1656 | Values: 630.4 704.9 710.6 718.0 727.4 14064.2 14137.4 14349.1 14512.6 14639.5 12842.6 12929.2 12969.3 12986.0 13000.7 658.4 832.9 842.6 843.2 844.1 645.7 667.0 800.4 832.3 832.7 881.0 881.4 881.4 882.3 883.1 847.4 872.4 876.4 876.7 877.1 651.0 652.6 653.0 654.2 655.9 13208.8 13720.7 13909.3 13947.6 13965.2 12829.6 13059.4 13093.3 13100.5 13341.4 10974.4 11034.3 11127.4 11259.7 11388.7 3556.4 3623.6 3686.1 3698.4 3720.9 85165.7 86532.6 90839.5 91297.5 91812.5 10135.6 10306.2 10405.1 10513.2 10769.4 19924.4 19958.4 19995.4 20016.2 20066.3 7372.2 7553.9 7554.8 7694.4 7705.3 4201.6 4228.9 4296.9 4399.9 4405.9 3269.3 3332.0 3382.9 3388.4 3393.0 643.4 663.9 664.0 675.9 681.6 569.3 615.8 641.0 649.2 659.5 8193.2 8289.9 8373.4 8375.9 8390.6 612.2 630.1 634.4 653.7 661.2 4093.7 4134.6 4196.1 4248.9 4275.6 105763.5 107979.5 108320.0 110702.9 112073.0 71488.3 73872.9 82116.0 92183.5 94271.0 79836.4 80189.0 80399.4 80468.2 83060.8 7624.6 8905.9 8996.3 9085.1 9177.5 48124.3 48631.5 49699.8 49932.3 50694.2 66893.0 68449.6 69727.7 70238.0 71314.6 12009.9 12080.9 12203.9 12265.3 12347.3 13460.9 13582.7 13719.5 13866.8 14416.9 12288.8 12463.7 12484.6 12703.4 12887.2 12614.8 12661.7 12798.5 12811.6 12859.9 12162.9 12276.2 12375.1 12496.2 12763.9 8189.2 10474.0 10565.6 10750.5 10799.4 9716.8 10101.8 10176.4 10268.3 10365.2 06:06:51 INFO - PROCESS | 1656 | -------- Summary: end -------- 06:06:51 INFO - PROCESS | 1656 | 06:06:52 INFO - TEST-INFO | 1656: exit 0 06:06:52 INFO - TEST-OK | dromaeo_css | took 1116634ms 06:06:52 INFO - TEST-START | kraken 06:06:52 INFO - operating with platform_type : mac_ 06:06:52 INFO - Initialising browser for kraken test... 06:06:52 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpmdyVOs/profile http://localhost:49268/getInfo.html) 06:06:55 INFO - PROCESS | 1664 | 2016-11-14 06:06:55.198 plugin-container[1666:10021] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 06:06:55 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:06:55 INFO - PROCESS | 1664 | 2016-11-14 06:06:55.199 plugin-container[1666:10021] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 06:06:55 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:06:55 INFO - PROCESS | 1664 | 2016-11-14 06:06:55.199 plugin-container[1666:10021] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:06:55 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:06:55 INFO - PROCESS | 1664 | colorDepth:24 06:06:55 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:06:55 INFO - PROCESS | 1664 | __metrics 06:06:55 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 06:06:56 INFO - TEST-INFO | 1664: exit 0 06:06:56 INFO - Browser initialized. 06:06:56 INFO - Running cycle 1/1 for kraken test... 06:06:56 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpmdyVOs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:58 INFO - PROCESS | 1667 | 2016-11-14 06:06:58.863 plugin-container[1668:10148] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454f, name = 'com.apple.tsm.portname' 06:06:58 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:06:58 INFO - PROCESS | 1667 | 2016-11-14 06:06:58.863 plugin-container[1668:10148] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e17, name = 'com.apple.CFPasteboardClient' 06:06:58 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:06:58 INFO - PROCESS | 1667 | 2016-11-14 06:06:58.863 plugin-container[1668:10148] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:07:08 INFO - PROCESS | 1667 | RSS: Main: 237596672 06:07:08 INFO - PROCESS | 1667 | 06:07:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:12 INFO - PROCESS | 1667 | RSS: Main: 250023936 06:07:12 INFO - PROCESS | 1667 | 06:07:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 06:07:15 INFO - PROCESS | 1667 | RSS: Main: 257740800 06:07:15 INFO - PROCESS | 1667 | 06:07:19 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 06:07:19 INFO - PROCESS | 1667 | RSS: Main: 260612096 06:07:19 INFO - PROCESS | 1667 | 06:07:21 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 06:07:22 INFO - PROCESS | 1667 | RSS: Main: 261693440 06:07:22 INFO - PROCESS | 1667 | 06:07:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:25 INFO - PROCESS | 1667 | RSS: Main: 263299072 06:07:25 INFO - PROCESS | 1667 | 06:07:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:28 INFO - PROCESS | 1667 | RSS: Main: 269004800 06:07:28 INFO - PROCESS | 1667 | 06:07:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:32 INFO - PROCESS | 1667 | RSS: Main: 268275712 06:07:32 INFO - PROCESS | 1667 | 06:07:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 06:07:36 INFO - PROCESS | 1667 | RSS: Main: 268095488 06:07:36 INFO - PROCESS | 1667 | 06:07:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:38 INFO - PROCESS | 1667 | RSS: Main: 267386880 06:07:38 INFO - PROCESS | 1667 | 06:07:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:41 INFO - PROCESS | 1667 | RSS: Main: 267436032 06:07:41 INFO - PROCESS | 1667 | 06:07:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:44 INFO - PROCESS | 1667 | RSS: Main: 268009472 06:07:44 INFO - PROCESS | 1667 | 06:07:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:48 INFO - PROCESS | 1667 | RSS: Main: 267956224 06:07:48 INFO - PROCESS | 1667 | 06:07:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:51 INFO - PROCESS | 1667 | RSS: Main: 267567104 06:07:51 INFO - PROCESS | 1667 | 06:07:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 06:07:54 INFO - PROCESS | 1667 | RSS: Main: 270741504 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | __start_tp_report 06:07:54 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:07:54 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:07:54 INFO - PROCESS | 1667 | |i|pagename|runs| 06:07:54 INFO - PROCESS | 1667 | |0;ai-astar;104;116;117;119;118;117;120;119;149;116 06:07:54 INFO - PROCESS | 1667 | |1;audio-beat-detection;148;104;140;169;99;133;144;111;175;140 06:07:54 INFO - PROCESS | 1667 | |2;audio-dft;205;236;211;202;209;277;248;198;192;199 06:07:54 INFO - PROCESS | 1667 | |3;audio-fft;82;58;58;82;59;63;72;85;73;52 06:07:54 INFO - PROCESS | 1667 | |4;audio-oscillator;84;56;85;86;100;104;111;70;70;89 06:07:54 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;108;132;96;110;137;75;87;123;138;133 06:07:54 INFO - PROCESS | 1667 | |6;imaging-darkroom;107;166;142;95;96;116;90;93;122;118 06:07:54 INFO - PROCESS | 1667 | |7;imaging-desaturate;84;141;109;90;111;136;83;147;144;113 06:07:54 INFO - PROCESS | 1667 | |8;json-parse-financial;58;56;56;56;57;58;60;88;88;84 06:07:54 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;68;68;73;75;75;69;70;71;70;70 06:07:54 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;95;85;90;77;96;91;94;111;111;110 06:07:54 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;149;152;161;165;167;142;160;179;225;189 06:07:54 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;179;178;176;175;177;175;173;176;177;234 06:07:54 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;60;97;89;62;79;93;90;92;85;76 06:07:54 INFO - PROCESS | 1667 | __end_tp_report 06:07:54 INFO - PROCESS | 1667 | __start_cc_report 06:07:54 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,961 06:07:54 INFO - PROCESS | 1667 | __end_cc_report 06:07:54 INFO - PROCESS | 1667 | __startTimestamp1479132474020__endTimestamp 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:07:54 INFO - PROCESS | 1667 | Number of tests: 14 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:119.50 Median:118.50 stddev:11.31 (9.5%) stddev-sans-first:10.51 06:07:54 INFO - PROCESS | 1667 | Values: 104.0 116.0 117.0 119.0 118.0 117.0 120.0 119.0 149.0 116.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:146.00 stddev:25.55 (17.5%) stddev-sans-first:26.75 06:07:54 INFO - PROCESS | 1667 | Values: 148.0 104.0 140.0 169.0 99.0 133.0 144.0 111.0 175.0 140.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:217.70 Median:210.00 stddev:27.28 (13.0%) stddev-sans-first:28.54 06:07:54 INFO - PROCESS | 1667 | Values: 205.0 236.0 211.0 202.0 209.0 277.0 248.0 198.0 192.0 199.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:68.40 Median:72.50 stddev:11.94 (16.5%) stddev-sans-first:11.60 06:07:54 INFO - PROCESS | 1667 | Values: 82.0 58.0 58.0 82.0 59.0 63.0 72.0 85.0 73.0 52.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:77.00 stddev:16.89 (21.9%) stddev-sans-first:17.91 06:07:54 INFO - PROCESS | 1667 | Values: 84.0 56.0 85.0 86.0 100.0 104.0 111.0 70.0 70.0 89.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:137.50 stddev:22.35 (16.3%) stddev-sans-first:23.61 06:07:54 INFO - PROCESS | 1667 | Values: 108.0 132.0 96.0 110.0 137.0 75.0 87.0 123.0 138.0 133.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:128.00 stddev:24.31 (19.0%) stddev-sans-first:25.64 06:07:54 INFO - PROCESS | 1667 | Values: 107.0 166.0 142.0 95.0 96.0 116.0 90.0 93.0 122.0 118.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:115.80 Median:145.50 stddev:25.04 (17.2%) stddev-sans-first:23.76 06:07:54 INFO - PROCESS | 1667 | Values: 84.0 141.0 109.0 90.0 111.0 136.0 83.0 147.0 144.0 113.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:59.00 stddev:14.29 (24.2%) stddev-sans-first:14.85 06:07:54 INFO - PROCESS | 1667 | Values: 58.0 56.0 56.0 56.0 57.0 58.0 60.0 88.0 88.0 84.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:70.50 stddev:2.60 (3.7%) stddev-sans-first:2.54 06:07:54 INFO - PROCESS | 1667 | Values: 68.0 68.0 73.0 75.0 75.0 69.0 70.0 71.0 70.0 70.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:90.50 stddev:11.52 (12.7%) stddev-sans-first:12.21 06:07:54 INFO - PROCESS | 1667 | Values: 95.0 85.0 90.0 77.0 96.0 91.0 94.0 111.0 111.0 110.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:168.90 Median:166.00 stddev:24.08 (14.5%) stddev-sans-first:24.44 06:07:54 INFO - PROCESS | 1667 | Values: 149.0 152.0 161.0 165.0 167.0 142.0 160.0 179.0 225.0 189.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:177.00 stddev:18.35 (10.4%) stddev-sans-first:19.43 06:07:54 INFO - PROCESS | 1667 | Values: 179.0 178.0 176.0 175.0 177.0 175.0 173.0 176.0 177.0 234.0 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:89.50 stddev:12.89 (14.4%) stddev-sans-first:10.86 06:07:54 INFO - PROCESS | 1667 | Values: 60.0 97.0 89.0 62.0 79.0 93.0 90.0 92.0 85.0 76.0 06:07:54 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:07:54 INFO - PROCESS | 1667 | 06:07:54 INFO - TEST-INFO | 1667: exit 0 06:07:54 INFO - TEST-OK | kraken | took 62616ms 06:07:54 INFO - SUITE-END | took 1179s 06:07:55 INFO - Completed test suite (00:19:39) 06:07:55 INFO - javascript benchmark 06:07:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7134.254406554578, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2968.688287729787, 3039.8480075996204, 3426.5888093428784, 3430.953559164454, 3431.6739909708567, 5659.886802263957, 5663.150527420884, 5684.772609095637, 5735.053716136843, 5736.368999410061, 5488.313960754906, 5621.4659607337235, 5647.802326918549, 5672.262605861232, 5673.943260567393, 4444.400005999198, 5103.770330335125, 5116.820911268106, 5183.896322073556, 5343.0, 5253.8949221015555, 5307.495787900143, 5333.706646134461, 5335.5198032177095, 5347.786088556453, 5224.21636754488, 5322.2282768998475, 5327.973360133214, 5332.520073193412, 5337.332833395825, 5231.738413079369, 5251.76367063483, 5308.6549374290935, 5336.4930331618625, 5359.115745901921, 5003.274525193827, 5023.447420783711, 5119.923201151985, 5168.198929165986, 5204.869878253036, 5037.042961837239, 5610.0, 5665.603407761459, 5667.971660141714, 5753.913691294634, 6214.130021796952, 6228.408301211378, 6280.1835761351185, 6283.905741413882, 6306.180196574462, 6227.875442491125, 6232.158658581079, 6237.064440333941, 6312.179416675849, 6336.081268216083, 5860.853478663067, 5878.118282257696, 5884.32330282023, 5884.794032208895, 5902.32123305821, 6278.905816412757, 6279.780207692709, 6295.842603934847, 6305.495560355161, 6307.432331090224, 6081.118237855486, 6111.135969295249, 6115.057807494094, 6119.929102025404, 6145.217886812864, 6144.631322120687, 6260.561760676709, 6278.560500764994, 6296.150019747367, 6308.053791931247, 6141.539384546177, 6222.848772977014, 6233.1273621693, 6261.499080073583, 6270.028145637433, 6106.612350340322, 6145.770845830852, 6160.383961603893, 6192.504599632019, 6235.064740288903, 4213.536510983789, 4904.509549045139, 4949.802007919643, 4972.7513624318635, 4982.825601103944, 4418.226810308183, 4436.3567282743825, 4460.0, 4463.37512748209, 4471.6646251531265, 4889.926651100236, 4975.0547395994645, 5778.133280008033, 5802.100674395476, 5933.2286802716235, 4726.929096063562, 5749.741261643236, 6091.843511185564, 6181.474574661114, 6253.96873015632, 5980.102984552352, 5981.970090149522, 5982.910256346158, 5995.370486098896, 6042.879142417215, 5363.865903352447, 5433.864153396196, 5439.401665816757, 5450.91823622646, 5507.311586051744, 6186.566940314135, 6272.372762723691, 6290.528210384148, 6299.716512756937, 6371.203599550056, 5443.237946687546, 6138.324784273816, 6283.2774230962195, 6289.591176573508, 6300.495960323255, 6313.463355614824, 6349.0, 6383.0, 6392.20097487814, 6418.614883107029, 6053.213082299273, 6092.969535152296, 6253.624782513064, 6272.843178920563, 6281.057841323838, 6137.570370074052, 6138.235132557229, 6198.535109866688, 6243.750249989949, 6282.654454004891, 6027.246594175728, 6050.122732203894, 6120.877582448237, 6124.601900876429, 6143.109249158936, 6110.984061328523, 6132.478739307209, 6133.73253493014, 6145.187169784835, 6155.938440615537, 5979.970100149471, 6011.939880601138, 6069.939300607114, 6079.483243924316, 6092.390760923872, 6014.548908831943, 6046.365131661289, 6093.268807743099, 6132.17215675878, 6180.7527698891545, 5972.790952316648, 6007.939920600913, 6012.759489620366, 6062.060380641008, 6104.603200791934], "value": 5687.789801842203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.3133425199209, 482.4138671514112, 496.58783209935757, 513.6840842881628, 530.8991291654586, 35103.2979340413, 39258.99999999996, 39353.016174595614, 40994.795026024825, 41004.179916401656, 39764.0, 40073.19853602926, 40119.197616047735, 40141.799291003575, 40327.395089073616, 9190.586423610954, 9298.72103836886, 9342.486163261017, 9354.719358419225, 9367.484788336673, 9140.680076197334, 9270.860937085916, 9354.345195836295, 9359.859602105973, 9366.20387267083, 9202.907970920305, 9334.0, 9339.06609339064, 9348.205402540758, 9369.67206147785, 9274.304427167956, 9316.8602470963, 9335.393199442082, 9355.48544830034, 9412.058794120601, 7758.806029849243, 9191.172794448532, 9198.356115071947, 9200.953995230047, 9206.309526785519, 38248.61751382506, 38580.649677261164, 38609.0, 38757.41863872044, 38795.0, 3201.2725555500137, 3327.866885324584, 3369.2082360645472, 3499.230169362736, 3896.80515974203, 25576.616350754754, 27068.323291917663, 27897.884084636793, 29736.0, 29765.404691906257, 3132.859021344045, 3140.0, 3282.425575524274, 3293.357795229931, 3324.833758312099, 493884.0, 498815.0, 500311.0, 501638.96722065355, 502036.0, 57474.5631359211, 57866.421335786945, 58294.7085264571, 58386.708066459396, 58420.70789646025, 60984.69507652522, 61198.0, 61309.69345153335, 61409.07886381708, 61564.0, 15258.542243732705, 15348.002379845275, 15606.3757449703, 15619.921900390425, 15624.76562851558, 9782.902170978341, 11591.6522504325, 11610.187286890006, 11614.70963225926, 11620.360880151504, 13844.515441959484, 17830.37593684215, 17878.195481203376, 17894.642107157782, 17914.55213619644, 6554.901676474857, 6875.346842049998, 7573.053368328959, 7592.354649854714, 7617.314441700273, 820.8399362124447, 889.1508609278123, 961.3606951377395, 1009.3388830316155, 1020.1226944827442, 26081.0, 27539.724602753715, 28539.57190642142, 28624.998125065522, 28682.282942926595, 1020.4081632653043, 1056.5351245451977, 1062.9202809789297, 1063.2769716592636, 1103.1450625765096, 14725.55823325302, 14727.631809204642, 14810.185439800915, 14868.794485427801, 14982.0, 689056.0, 690373.0, 691439.0, 697678.0, 698692.0, 53961.730191349576, 54080.0, 54336.72831635817, 54378.64053398697, 54619.45380546223, 1310.9541166059332, 1321.5044358365612, 1337.571976967361, 1341.745467987435, 1346.6431395680152, 19778.90110549438, 26005.089821856145, 26652.60021099724, 28266.85866570654, 28532.714672853006, 42133.0, 42142.0, 42442.57557424386, 42451.15097697967, 42495.15009699727, 498006.0, 499597.0, 499713.0, 500138.0, 500587.0, 25017.999280028595, 25140.74859251384, 25449.491010180063, 25557.744422555537, 25593.488130237663, 37158.07104822401, 43684.12631747284, 43836.90407739704, 44672.776636116614, 45268.094638107716, 36352.0, 36526.0, 36537.0, 37338.62661373351, 37840.243195135394, 36694.735059929546, 36702.89891303265, 37407.251854963295, 37903.62096379001, 38051.0, 36063.0, 36084.639153609176, 36136.45795313125, 36307.0, 36846.44730329101, 31304.0, 31780.0, 32940.50589241115, 33018.33963320768, 33058.669413306525, 24182.63726044146, 24607.87696061508, 24750.876245618656, 25082.498350032532, 25095.0], "value": 19056.911510573565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.99260014799705, 372.46923134533284, 377.62615011138973, 382.84303435591414, 401.0555142639085, 17902.910485447555, 18676.719849202273, 18687.439376818682, 19482.707759383622, 20342.0, 17620.11899405031, 18382.44852654419, 19445.805541944577, 19898.90050549745, 19964.600707985832, 4159.355299928501, 5138.64029517933, 5292.100342941709, 5334.399680095975, 5336.38631557372, 5303.7348132593215, 5317.627766056377, 5359.651622644536, 5359.812406565771, 5360.865978350553, 5061.468545802693, 5347.866303342409, 5358.973205133969, 5361.51746342829, 5370.0, 5170.793168273264, 5173.586113110942, 5263.263143159922, 5264.921026184591, 5281.656692314988, 4440.91197656573, 4754.548317909793, 4817.325574419584, 5113.69317840927, 6910.274421185753, 26421.47157056848, 26795.33011674704, 27142.457150856873, 27199.86400067987, 27577.44845103107, 2136.5192831612917, 2365.680633114525, 2492.9750702492925, 2506.636537702041, 2536.8604726740023, 15302.923485382502, 15850.920745396315, 15977.201139942956, 16538.421155259628, 17026.89325193871, 1844.8561891627144, 1878.0, 1879.4585014967129, 1985.0967809646577, 2021.090509270834, 123720.38139809333, 134033.0, 136133.3193334027, 136850.0, 137115.999999999, 19534.5116372089, 20708.378748637566, 20919.26782562603, 20950.790492094882, 21050.0, 32105.839470802497, 32719.50920736191, 32777.50833737496, 32790.21283190956, 32808.179795504824, 8612.956935215409, 10158.390496570082, 10199.592016319413, 10256.487175641189, 10348.896511034793, 8427.87841813688, 8506.829863402698, 8519.57402129891, 8553.700620478254, 8663.0, 7818.0, 9309.115634014757, 9437.197838183694, 9533.094356036165, 9591.42451452915, 3679.889603311905, 3809.790461524643, 3812.923741525154, 3830.731848770615, 3835.328817456934, 815.5555222403805, 826.2109685250572, 859.3168431097292, 894.7539426657592, 944.3059351376733, 19407.0, 20163.79836201619, 20189.596208075756, 20285.78285302857, 20617.690734638993, 836.5947899788109, 901.2249465459699, 920.6409500294891, 924.2467389078014, 951.2580187453797, 10109.635199248154, 10382.42896640677, 10748.54894589236, 10756.462176891124, 10794.514246858911, 493641.0, 500761.0, 502608.0, 521943.0, 559308.0, 108873.0, 117011.6597668042, 118777.0, 120331.39834300772, 123621.25598068169, 388.91638297766116, 440.50883265159115, 447.2106731618696, 448.5514485514486, 451.58679807975335, 8462.957685211535, 9802.019798020141, 10386.48067596602, 10726.517306721373, 11421.543138274375, 36950.0, 42137.41831944197, 50292.87113669974, 52736.73631631817, 53011.20483192832, 50348.74825625995, 74803.62598186974, 75111.62444187744, 76034.4793104146, 76296.61851690707, 7037.190723066913, 7683.692652293846, 7900.920990790019, 7922.286994170552, 8094.797630059295, 9208.861867072133, 10149.949250253701, 12126.27242365461, 12233.266004039786, 12277.570285039981, 10309.329893556895, 10330.586776528855, 10513.264071514921, 10585.629502967358, 10773.407462589634, 10342.172626189737, 10395.272330936761, 10463.0, 10644.84032739525, 10727.356358618508, 10674.519646615765, 10787.730306742395, 10896.346219226873, 10999.560017599206, 11051.336919784839, 7792.181820908723, 7851.685932562634, 7951.165127661512, 7969.0, 7983.32141767933, 8023.4784738991775, 9822.361546499455, 10247.231457640557, 10909.0, 10920.235583509078], "value": 9714.854351047625, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.6631274806791, 1514.644058646218, 1644.0382376309858, 1690.3069741406025, 1765.6821772081037, 7472.663730132143, 7754.883676744853, 7997.8400431991395, 8434.620442080106, 8438.704645337415, 7950.920490795091, 8273.95863020684, 8316.334693224542, 8377.036640786311, 8392.244697977181, 2253.8985745641403, 2294.3117064880553, 2294.827887908405, 2300.735415427222, 2305.804006659436, 2289.427643089228, 2321.071571371448, 2332.7084114485688, 2338.2751347082376, 2347.4366152123453, 2277.8974946127464, 2291.0721157931066, 2291.346966114658, 2319.8492098013658, 2325.5581439526436, 2275.7496675365696, 2283.075354481438, 2301.0335659023335, 2303.447172678562, 2312.90748370065, 1752.535578071812, 1801.9369322073665, 1909.4080834941074, 2328.6507023946374, 2336.0772494864605, 8349.248567628882, 8372.706955256597, 8390.664373425117, 8397.622107005138, 8417.452865563719, 4969.900601987976, 5133.204353325241, 5147.330846989905, 5155.690658560498, 5181.274621552986, 2737.630419893309, 2954.409118176352, 3317.9170520737175, 3558.87543935961, 3574.3566158091535, 937.929655275857, 941.8493041113458, 951.4053716427233, 1082.815921293382, 1084.4740300954031, 8723.651053957834, 10911.945440272748, 11009.339439633648, 11014.50434730431, 11052.392118433403, 4064.6748260139116, 4632.2125238709505, 4672.672912896064, 4678.578927896506, 4691.132140554008, 9417.152456278967, 9475.241980641533, 9514.857277140849, 9515.048495150568, 9516.524173791422, 5161.974190129025, 5176.637635365563, 5187.0922588546855, 5195.480451954774, 5200.97399513, 3532.0, 4050.1494686116243, 4665.883352916204, 4688.2030054890065, 4753.215719406328, 3502.264524449843, 3656.597774244831, 3731.9626803731617, 3811.8284677189595, 3846.6922646188236, 1146.9598564050384, 1244.4089057697522, 1252.1422825364655, 1253.9373031348396, 1266.1263728027816, 601.482724856623, 896.2650626486219, 897.6454300551246, 907.3421769217265, 908.0692290402259, 5639.3232812062815, 5812.186293918855, 5822.737976791054, 5888.911666325009, 5984.461398474071, 925.6991477769752, 931.4364809290417, 933.7898972731081, 948.2982592881218, 962.5043102802063, 3764.378877485184, 3959.208158368338, 3995.360742281221, 3995.9800200998807, 4039.474868267165, 9896.950515247378, 9939.155171810477, 10247.538860751283, 10263.9486802567, 10279.845802312972, 7949.6025198739835, 9865.654702085392, 10173.08442240202, 10199.13307368867, 10214.336068155546, 6450.612963222222, 6456.0961465394885, 7000.439964802804, 7553.584552849646, 7926.286634202834, 4763.952360476351, 5518.041095411232, 5680.346760122638, 5688.203651488878, 5732.57005724564, 9301.906980930104, 9307.836520434945, 9339.346245762732, 9482.620695172116, 9490.050994900455, 9477.952610236905, 9530.237580993642, 9555.808883822145, 9574.760630984281, 9672.468014259282, 6215.564910456405, 6477.611343319416, 6563.835904102245, 6582.0, 6836.213835408793, 7875.173106823701, 8009.91990080115, 8025.2777250047775, 8029.759107226792, 8038.075621303625, 7009.1589009319205, 7116.573005619679, 7168.390686791681, 7173.461990350849, 7244.89132663, 6946.826329341605, 6997.685104170223, 7018.894716579153, 7079.752208672672, 7092.503524753218, 6599.703013364314, 6626.801195964129, 6694.59832410057, 6728.125343705287, 6744.527883048139, 4045.7167998239843, 4774.904501910012, 4817.879553011203, 4858.271259311132, 4905.48492408292, 4809.470958194665, 4906.607471402351, 4923.950760492349, 4956.058348913695, 4970.204767237225], "value": 4353.168290805217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2989973562128, 299.63594233006893, 302.3182722959726, 310.19968481318193, 313.6377484005973, 4024.3359845625473, 4530.433695788027, 4605.332226827108, 5220.190870415087, 5534.391216966135, 4546.272596384579, 4963.975180124095, 5177.404598471167, 5340.489969714228, 5369.785208591652, 3630.4009838376637, 3647.9420967919273, 3964.5242570891533, 4127.4427952226515, 4188.602082802129, 3699.519062521882, 3851.287511810324, 4168.95776055986, 4178.56125106864, 4180.958190418102, 3994.3009973254566, 4068.904514175202, 4074.5314288856716, 4098.139390727951, 4115.48955137366, 4064.0855807443236, 4074.470318858544, 4089.2434899543678, 4089.85685501009, 4090.2637525245445, 2924.6490421149388, 3354.228527438678, 3534.7348948828685, 3547.5033495310417, 3594.0835087052897, 5153.56194723449, 5233.953209358106, 5240.95180963805, 5280.577553795687, 5413.26920865682, 3743.6069212732814, 4613.907721845578, 4619.528552224544, 4640.67515273931, 4698.577128058457, 4965.4041515018425, 4965.553100220997, 5644.971775141139, 5699.316082070137, 5704.3154821421695, 3761.6426439488478, 3810.6951443884423, 3829.6744776694013, 3889.8444062237477, 3893.06566424059, 5006.6245031622775, 5363.0, 5748.2527271454865, 5793.073108302693, 5936.465718085393, 3585.175409655794, 3717.981410092932, 3911.02224443889, 3917.2948869203815, 3941.6649584785614, 3788.734788564829, 3814.8664796731982, 3967.0, 3980.661643760313, 3991.7405368650943, 3888.319544079775, 4597.264627546671, 4621.12198682256, 4629.930551041737, 4656.138614356355, 5691.345495268097, 5697.088465845445, 5711.8000869969355, 5721.313442386857, 5754.625949313281, 1068.1881769854965, 1208.7642909632536, 1233.4387853526623, 1277.993610031944, 1281.6859869332072, 725.3834240895197, 785.1598789295399, 866.5104216117874, 878.6995247034297, 889.1286539191628, 4318.784060796947, 4624.676272660949, 4636.522608043967, 4657.278121891112, 4680.092123077201, 4981.352424184833, 5171.741412929414, 5259.8422047338645, 5275.472452754694, 5333.413324534298, 4306.870793876189, 4617.607503362252, 5048.268001139814, 5061.6962982221185, 5094.7962081516325, 2607.5658387886588, 2806.6424203669017, 2928.282570770132, 2950.4689155952133, 2965.41350377547, 5625.943740562624, 5626.578006649435, 5765.308163020464, 5831.475167234969, 5896.378495913658, 5315.6279060465395, 5466.562674985991, 5687.60186786921, 5730.796532728091, 5766.0, 4798.808047678054, 5673.74468148926, 5769.68266745333, 5795.82612521625, 5906.379830117776, 4934.8766280843265, 5137.897242055213, 5499.532539734168, 5921.319048309328, 5923.763049478145, 4750.406199225097, 4917.26241063829, 5898.439648233411, 5904.61619994699, 5907.586468947133, 4959.305697202467, 5176.456472070529, 6108.633481991094, 6214.72033758491, 6285.397223707925, 3367.4641626291805, 3866.2022159695875, 3906.7655940643654, 3929.9607003929596, 3943.408488726714, 5873.329169269206, 5914.645121292736, 5919.260092488439, 5938.376470470538, 5951.702414879325, 5123.692578445305, 5217.034848553029, 5654.604177707521, 5739.483446489836, 5745.368009519033, 4358.520562738159, 5327.539272245824, 5657.643614416794, 5756.920047774421, 5784.392638772868, 5231.215317702375, 5491.203775452617, 5619.915701264403, 5665.716714164193, 5676.801311954062, 4847.854564363075, 5111.623095260722, 5803.709814509342, 5851.502622277154, 5867.178594996789, 5362.731863406892, 5531.197976293334, 5657.3593657838765, 5729.828105156852, 5731.254936858182], "value": 4057.65493696903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.3853742600965, 704.9118860142482, 710.6091649592722, 717.9589595087125, 727.4471401734687, 14064.22646754428, 14137.363818628148, 14349.139051656895, 14512.564623061298, 14639.487617933375, 12842.614721558368, 12929.224246545215, 12969.286689232113, 12986.0, 13000.674983125404, 658.3844105761104, 832.8584140696096, 842.5660784695887, 843.2200214801314, 844.1389782421957, 645.7223393940603, 667.0, 800.3757069485781, 832.309183377795, 832.7293629570383, 881.039666763228, 881.4006475596592, 881.418263945796, 882.311796798495, 883.0815951410525, 847.3560094328354, 872.437277955715, 876.447837862146, 876.7238319929234, 877.1272583779116, 651.0169643837839, 652.5562617420153, 653.0465520340261, 654.1790053482896, 655.8721049395369, 13208.801867971988, 13720.65698357539, 13909.30453477322, 13947.58157255284, 13965.231912244823, 12829.61511154667, 13059.412326445332, 13093.345332733325, 13100.541481048118, 13341.399637016357, 10974.396408197546, 11034.337939723562, 11127.387993660346, 11259.718507037307, 11388.715282118013, 3556.3776339140545, 3623.601403845575, 3686.0600546860646, 3698.4082546792383, 3720.8883733488037, 85165.72251416233, 86532.56733716291, 90839.54580227123, 91297.54351228202, 91812.54093729555, 10135.64525241613, 10306.227032972407, 10405.115565176893, 10513.158947284352, 10769.407682577534, 19924.402267931986, 19958.401247962585, 19995.40013799559, 20016.199352026048, 20066.297679581145, 7372.1583171989305, 7553.8866916996285, 7554.848903021909, 7694.422918281151, 7705.30652241301, 4201.642860356904, 4228.851990180329, 4296.935545966813, 4399.868003959887, 4405.889852753707, 3269.2644155065395, 3331.9666803331656, 3382.9323413531592, 3388.373150967079, 3393.0, 643.4144928115393, 663.9269680335159, 663.9800805975829, 675.895236238374, 681.5978572642165, 569.3281927325795, 615.827568280882, 640.9936399852187, 649.2351476342898, 659.4987809264993, 8193.180681931759, 8289.917100829036, 8373.413861029669, 8375.874361884577, 8390.622421991025, 612.2408213814927, 630.130420020369, 634.3751404866204, 653.6894974886891, 661.2362721057186, 4093.7339072960162, 4134.627883490501, 4196.118815048813, 4248.936265956013, 4275.5724427557, 105763.4711826436, 107979.46010269898, 108320.0, 110702.89297106926, 112073.0, 71488.28511714921, 73872.89190662037, 82116.0, 92183.53908230415, 94271.0, 79836.40327193424, 80189.0, 80399.35207775104, 80468.19531804725, 83060.75408868871, 7624.580648064188, 8905.866412003696, 8996.28029757631, 9085.091490850862, 9177.495237761721, 48124.27813582729, 48631.5136848627, 49699.75150124226, 49932.25101623406, 50694.23958640549, 66893.0, 68449.63100737857, 69727.65136174287, 70238.0, 71314.57370852657, 12009.939950300193, 12080.879191208327, 12203.877961220274, 12265.325407102695, 12347.345320755721, 13460.93269533646, 13582.660433489242, 13719.45122195101, 13866.791998119834, 14416.855831441972, 12288.81566776517, 12463.688407789878, 12484.563040293546, 12703.42834572465, 12887.16233444823, 12614.750951167258, 12661.683457913627, 12798.488060477477, 12811.551595694105, 12859.871401285867, 12162.878371216175, 12276.202046866925, 12375.133740638068, 12496.187747796364, 12763.93618031941, 8189.1808836504715, 10474.0, 10565.63020294286, 10750.517236209746, 10799.40603266828, 9716.75708107303, 10101.797964040825, 10176.389416635026, 10268.281220314506, 10365.170786337225], "value": 7088.1349771618225, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1637.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 117.0, 119.0, 118.0, 117.0, 120.0, 119.0, 149.0, 116.0], "value": 119.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 104.0, 140.0, 169.0, 99.0, 133.0, 144.0, 111.0, 175.0, 140.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 236.0, 211.0, 202.0, 209.0, 277.0, 248.0, 198.0, 192.0, 199.0], "value": 217.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 82.0, 59.0, 63.0, 72.0, 85.0, 73.0, 52.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 56.0, 85.0, 86.0, 100.0, 104.0, 111.0, 70.0, 70.0, 89.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 132.0, 96.0, 110.0, 137.0, 75.0, 87.0, 123.0, 138.0, 133.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 166.0, 142.0, 95.0, 96.0, 116.0, 90.0, 93.0, 122.0, 118.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 141.0, 109.0, 90.0, 111.0, 136.0, 83.0, 147.0, 144.0, 113.0], "value": 115.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 56.0, 57.0, 58.0, 60.0, 88.0, 88.0, 84.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 73.0, 75.0, 75.0, 69.0, 70.0, 71.0, 70.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 85.0, 90.0, 77.0, 96.0, 91.0, 94.0, 111.0, 111.0, 110.0], "value": 96.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 161.0, 165.0, 167.0, 142.0, 160.0, 179.0, 225.0, 189.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 176.0, 175.0, 177.0, 175.0, 173.0, 176.0, 177.0, 234.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 97.0, 89.0, 62.0, 79.0, 93.0, 90.0, 92.0, 85.0, 76.0], "value": 82.3, "unit": "score"}]}]} 06:07:55 INFO - Return code: 0 06:07:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:55 ERROR - # TBPL SUCCESS # 06:07:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:07:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:07:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:07:55 INFO - 2016-11-14 06:07:55.317 screenresolution[1672:10533] starting screenresolution argv=screenresolution get 06:07:55 INFO - 2016-11-14 06:07:55.320 screenresolution[1672:10533] Display 0: 1600x1200x32@60 06:07:55 INFO - 2016-11-14 06:07:55.326 screenresolution[1673:10536] starting screenresolution argv=screenresolution list 06:07:55 INFO - Available Modes on Display 0 06:07:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:07:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:07:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:07:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:07:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:07:55 INFO - Intel Iris: 06:07:55 INFO - Chipset Model: Intel Iris 06:07:55 INFO - Type: GPU 06:07:55 INFO - Bus: Built-In 06:07:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:07:55 INFO - Vendor: Intel (0x8086) 06:07:55 INFO - Device ID: 0x0a2e 06:07:55 INFO - Revision ID: 0x0009 06:07:55 INFO - Displays: 06:07:55 INFO - Display: 06:07:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:07:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:07:55 INFO - Display Serial Number: 1600x1200 60 06:07:55 INFO - Main Display: Yes 06:07:55 INFO - Mirror: Off 06:07:55 INFO - Online: Yes 06:07:55 INFO - Rotation: Supported 06:07:55 INFO - Return code: 0 06:07:55 INFO - Running post-action listener: _resource_record_post_action 06:07:55 INFO - [mozharness: 2016-11-14 14:07:55.560218Z] Finished run-tests step (success) 06:07:55 INFO - Running post-run listener: _resource_record_post_run 06:07:55 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 38361088; Write bytes: 703065088; Read time: 248; Write time: 2019 06:07:55 INFO - TinderboxPrint: CPU usage
54.5% 06:07:55 INFO - TinderboxPrint: I/O read bytes / time
38,361,088 / 248 06:07:55 INFO - TinderboxPrint: I/O write bytes / time
703,065,088 / 2,019 06:07:55 INFO - TinderboxPrint: CPU idle
2,210.4 (45.5%) 06:07:55 INFO - TinderboxPrint: CPU system
982.3 (20.2%) 06:07:55 INFO - TinderboxPrint: CPU user
1,664.9 (34.3%) 06:07:55 INFO - TinderboxPrint: Swap in / out
437,243,904 / 0 06:07:55 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401349120; Write bytes: 390383104; Read time: 29726; Write time: 837 06:07:55 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31006720; Write bytes: 299122176; Read time: 180; Write time: 1135 06:07:56 INFO - Running post-run listener: _upload_blobber_files 06:07:56 INFO - Blob upload gear active. 06:07:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:56 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 06:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:07:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:57 INFO - (blobuploader) - INFO - Done attempting. 06:07:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:58 INFO - (blobuploader) - INFO - Done attempting. 06:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:00 INFO - (blobuploader) - INFO - Done attempting. 06:08:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:00 INFO - Return code: 0 06:08:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48c1d3b8771d11348198f3d618a8743341ece1ebd67b9a13e29812dce95492df6280164020513c7597eba69232ade5deb5608e01ee11ee6a2a7905fcc3f13669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9caeb911dfbbbb5f857eff1e9e9d1eb66f6b5110842c78b60c20eb49bd3e15224e57dc54e27ae456cb7c285aa880c987322b5ffac3f32bc4e2b32dbe14e247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b2736ea76c96f05a3421cdb7c5f96fe5262fcc01620cfd6c178b2933b8e701ceada3b0b081b50823d0d02bb74c02e8f99e9c590ef7b88d51b30288137c222d0"} 06:08:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:00 INFO - Contents: 06:08:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48c1d3b8771d11348198f3d618a8743341ece1ebd67b9a13e29812dce95492df6280164020513c7597eba69232ade5deb5608e01ee11ee6a2a7905fcc3f13669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9caeb911dfbbbb5f857eff1e9e9d1eb66f6b5110842c78b60c20eb49bd3e15224e57dc54e27ae456cb7c285aa880c987322b5ffac3f32bc4e2b32dbe14e247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b2736ea76c96f05a3421cdb7c5f96fe5262fcc01620cfd6c178b2933b8e701ceada3b0b081b50823d0d02bb74c02e8f99e9c590ef7b88d51b30288137c222d0"} 06:08:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:00 INFO - Copying logs to upload dir... 06:08:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.853406 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-14 06:08:01.065958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 06:08:01.069406) ========= 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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48c1d3b8771d11348198f3d618a8743341ece1ebd67b9a13e29812dce95492df6280164020513c7597eba69232ade5deb5608e01ee11ee6a2a7905fcc3f13669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9caeb911dfbbbb5f857eff1e9e9d1eb66f6b5110842c78b60c20eb49bd3e15224e57dc54e27ae456cb7c285aa880c987322b5ffac3f32bc4e2b32dbe14e247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b2736ea76c96f05a3421cdb7c5f96fe5262fcc01620cfd6c178b2933b8e701ceada3b0b081b50823d0d02bb74c02e8f99e9c590ef7b88d51b30288137c222d0"} build_url:https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010602 build_url: 'https://queue.taskcluster.net/v1/task/eakdcyz7QHOrNWxlamBbsg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48c1d3b8771d11348198f3d618a8743341ece1ebd67b9a13e29812dce95492df6280164020513c7597eba69232ade5deb5608e01ee11ee6a2a7905fcc3f13669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e9caeb911dfbbbb5f857eff1e9e9d1eb66f6b5110842c78b60c20eb49bd3e15224e57dc54e27ae456cb7c285aa880c987322b5ffac3f32bc4e2b32dbe14e247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b2736ea76c96f05a3421cdb7c5f96fe5262fcc01620cfd6c178b2933b8e701ceada3b0b081b50823d0d02bb74c02e8f99e9c590ef7b88d51b30288137c222d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 06:08:01.101771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:08:01.102104) ========= 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.Pt0fZ96Zqz/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.OXDnDUtFi0/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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.005221 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:08:01.152237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 06:08:01.152768) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 06:08:01.153641) ========= ========= Total master_lag: 0.31 =========