builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0082 starttime: 1484842535.84 results: success (0) buildid: 20170119070428 builduid: 6dbf744ce421498ca689c1c26e3d6ac0 revision: 67e96cc5f42be249b7e40cec9b2eb0105d96625f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:35.841757) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:35.842360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:35.842863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:35.871510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:35.872165) ========= 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.uyt33kza1C/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.kH4liflMO3/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 08:15:35-- 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% 157M=0s 2017-01-19 08:15:36 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.648591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:36.545685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:36.546039) ========= 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.uyt33kza1C/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.kH4liflMO3/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.020627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:36.594587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:36.594964) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 67e96cc5f42be249b7e40cec9b2eb0105d96625f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 67e96cc5f42be249b7e40cec9b2eb0105d96625f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uyt33kza1C/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.kH4liflMO3/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 08:15:36,674 truncating revision to first 12 chars 2017-01-19 08:15:36,675 Setting DEBUG logging. 2017-01-19 08:15:36,675 attempt 1/10 2017-01-19 08:15:36,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/67e96cc5f42b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 08:15:37,300 unpacking tar archive at: mozilla-aurora-67e96cc5f42b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.876246 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:37.509792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:37.510198) ========= script_repo_revision: 67e96cc5f42be249b7e40cec9b2eb0105d96625f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:37.510677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:37.511015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 08:15:37.789566) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-19 08:15:37.790406) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uyt33kza1C/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.kH4liflMO3/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:15:37 INFO - MultiFileLogger online at 20170119 08:15:37 in /builds/slave/test 08:15:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:15:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:37 INFO - {'append_to_log': False, 08:15:37 INFO - 'base_work_dir': '/builds/slave/test', 08:15:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:15:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:37 INFO - 'branch': 'Mozilla-Aurora', 08:15:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:37 INFO - 'config_files': ('talos/mac_config.py',), 08:15:37 INFO - 'default_actions': ('clobber', 08:15:37 INFO - 'read-buildbot-config', 08:15:37 INFO - 'download-and-extract', 08:15:37 INFO - 'populate-webroot', 08:15:37 INFO - 'create-virtualenv', 08:15:37 INFO - 'install', 08:15:37 INFO - 'run-tests'), 08:15:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:37 INFO - 'download_minidump_stackwalk': True, 08:15:37 INFO - 'download_symbols': 'ondemand', 08:15:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:37 INFO - 'installer_path': 'installer.exe', 08:15:37 INFO - 'log_level': 'info', 08:15:37 INFO - 'log_name': 'talos', 08:15:37 INFO - 'log_to_console': True, 08:15:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:15:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:15:37 INFO - 'opt_config_files': (), 08:15:37 INFO - 'pip_index': False, 08:15:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:37 INFO - 'cmd': ('bash', 08:15:37 INFO - '-c', 08:15:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:37 INFO - 'enabled': True, 08:15:37 INFO - 'halt_on_failure': False, 08:15:37 INFO - 'name': 'check_screen_resolution'},), 08:15:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:38 INFO - 'cmd': ('bash', 08:15:38 INFO - '-c', 08:15:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:38 INFO - 'enabled': True, 08:15:38 INFO - 'halt_on_failure': False, 08:15:38 INFO - 'name': 'check_screen_resolution'},), 08:15:38 INFO - 'run_cmd_checks_enabled': True, 08:15:38 INFO - 'sps_profile': False, 08:15:38 INFO - 'sps_profile_interval': 0, 08:15:38 INFO - 'suite': 'dromaeojs-e10s', 08:15:38 INFO - 'system_bits': '32', 08:15:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:38 INFO - 'title': 't-yosemite-r7-0082', 08:15:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:38 INFO - 'use_talos_json': True, 08:15:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:38 INFO - 'work_dir': 'build'} 08:15:38 INFO - [mozharness: 2017-01-19 16:15:38.002034Z] Running clobber step. 08:15:38 INFO - Running pre-action listener: _resource_record_pre_action 08:15:38 INFO - Running main action method: clobber 08:15:38 INFO - rmtree: /builds/slave/test/build 08:15:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:38 INFO - Running post-action listener: _resource_record_post_action 08:15:38 INFO - [mozharness: 2017-01-19 16:15:38.700024Z] Finished clobber step (success) 08:15:38 INFO - [mozharness: 2017-01-19 16:15:38.700276Z] Running read-buildbot-config step. 08:15:38 INFO - Running pre-action listener: _resource_record_pre_action 08:15:38 INFO - Running main action method: read_buildbot_config 08:15:38 INFO - Using buildbot properties: 08:15:38 INFO - { 08:15:38 INFO - "project": "", 08:15:38 INFO - "product": "firefox", 08:15:38 INFO - "script_repo_revision": "production", 08:15:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:15:38 INFO - "repository": "", 08:15:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:15:38 INFO - "buildid": "20170119070428", 08:15:38 INFO - "pgo_build": "False", 08:15:38 INFO - "basedir": "/builds/slave/test", 08:15:38 INFO - "buildnumber": 72, 08:15:38 INFO - "slavename": "t-yosemite-r7-0082", 08:15:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:15:38 INFO - "platform": "yosemite_r7", 08:15:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:15:38 INFO - "branch": "mozilla-aurora", 08:15:38 INFO - "repo_path": "releases/mozilla-aurora", 08:15:38 INFO - "revision": "67e96cc5f42be249b7e40cec9b2eb0105d96625f", 08:15:38 INFO - "stage_platform": "macosx64", 08:15:38 INFO - "builduid": "6dbf744ce421498ca689c1c26e3d6ac0", 08:15:38 INFO - "slavebuilddir": "test" 08:15:38 INFO - } 08:15:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:15:38 INFO - Running post-action listener: _resource_record_post_action 08:15:38 INFO - [mozharness: 2017-01-19 16:15:38.706129Z] Finished read-buildbot-config step (success) 08:15:38 INFO - [mozharness: 2017-01-19 16:15:38.706322Z] Running download-and-extract step. 08:15:38 INFO - Running pre-action listener: _resource_record_pre_action 08:15:38 INFO - Running main action method: download_and_extract 08:15:38 INFO - mkdir: /builds/slave/test/build/tests 08:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:38 INFO - trying https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:15:38 INFO - Downloading https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:15:40 INFO - Downloaded 1199 bytes. 08:15:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:15:40 INFO - Using the following test package requirements: 08:15:40 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:15:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:15:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:15:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'jsshell-mac.zip'], 08:15:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:15:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:15:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:15:40 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:15:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:15:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:15:40 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:15:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:15:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:15:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:40 INFO - Fetch https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:15:40 INFO - Http code: 200 08:15:40 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 08:15:40 INFO - x-amz-cf-id: XZZPXx_KBvH_Hb3UevwFQk5QHygVAnQ_wnMEjMK6HgN9bmfnjlZDLg== 08:15:40 INFO - x-amz-version-id: PbtLA_2Qr0L1e1_oWW2jKnQ8TndkASeU 08:15:41 INFO - Expected file size: 16275831 08:15:41 INFO - Obtained file size: 16275831 08:15:47 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:15:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:15:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:15:47 INFO - Fetch https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:15:48 INFO - Http code: 200 08:15:48 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 08:15:48 INFO - x-amz-cf-id: bJZCcT8Afpy2nNY1omvfP-5ThUtqNOnFnpggvArW90fmfukycxNTIQ== 08:15:48 INFO - x-amz-version-id: PbtLA_2Qr0L1e1_oWW2jKnQ8TndkASeU 08:15:49 INFO - Expected file size: 16275831 08:15:49 INFO - Obtained file size: 16275831 08:15:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:15:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:15:55 INFO - Fetch https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:15:56 INFO - Http code: 200 08:15:56 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 08:15:56 INFO - x-amz-cf-id: PS64qZTBbE5vw8TVnjGsdPM6rSL5bf7CulLlmECCRjjKepUtN35J7g== 08:15:56 INFO - x-amz-version-id: bfFLofJafs6Es0aeb7bXeFDt9LdQ8em6 08:15:56 INFO - Expected file size: 14409038 08:15:56 INFO - Obtained file size: 14409038 08:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:57 INFO - trying https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:57 INFO - Downloading https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:15:59 INFO - Downloaded 109964632 bytes. 08:15:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:15:59 INFO - mkdir: /builds/slave/test/properties 08:15:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:59 INFO - Contents: 08:15:59 INFO - build_url:https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:16:00 INFO - Running post-action listener: _resource_record_post_action 08:16:00 INFO - Running post-action listener: set_extra_try_arguments 08:16:00 INFO - [mozharness: 2017-01-19 16:16:00.638476Z] Finished download-and-extract step (success) 08:16:00 INFO - [mozharness: 2017-01-19 16:16:00.638594Z] Running populate-webroot step. 08:16:00 INFO - Running pre-action listener: _resource_record_pre_action 08:16:00 INFO - Running main action method: populate_webroot 08:16:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:00 INFO - '--tppagecycles', 08:16:00 INFO - '7'], 08:16:00 INFO - 'tests': ['tsvgm']}}, 08:16:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['damp', 'tps']}, 08:16:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'tests': ['damp', 'tps']}, 08:16:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['dromaeo_dom']}, 08:16:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['basic_compositor_video']}, 08:16:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['a11yr', 08:16:00 INFO - 'ts_paint', 08:16:00 INFO - 'tpaint', 08:16:00 INFO - 'sessionrestore', 08:16:00 INFO - 'sessionrestore_no_auto_restore', 08:16:00 INFO - 'tabpaint']}, 08:16:00 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:00 INFO - 'ts_paint', 08:16:00 INFO - 'tpaint', 08:16:00 INFO - 'sessionrestore', 08:16:00 INFO - 'sessionrestore_no_auto_restore', 08:16:00 INFO - 'tabpaint']}, 08:16:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:00 INFO - 'ts_paint', 08:16:00 INFO - 'tpaint', 08:16:00 INFO - 'sessionrestore', 08:16:00 INFO - 'sessionrestore_no_auto_restore', 08:16:00 INFO - 'tabpaint']}, 08:16:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:00 INFO - 'ts_paint', 08:16:00 INFO - 'tpaint', 08:16:00 INFO - 'sessionrestore', 08:16:00 INFO - 'sessionrestore_no_auto_restore', 08:16:00 INFO - 'tabpaint']}, 08:16:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['a11yr', 08:16:00 INFO - 'ts_paint', 08:16:00 INFO - 'tpaint', 08:16:00 INFO - 'sessionrestore', 08:16:00 INFO - 'sessionrestore_no_auto_restore', 08:16:00 INFO - 'tabpaint']}, 08:16:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['a11yr', 08:16:00 INFO - 'ts_paint', 08:16:00 INFO - 'tpaint', 08:16:00 INFO - 'sessionrestore', 08:16:00 INFO - 'sessionrestore_no_auto_restore', 08:16:00 INFO - 'tabpaint']}, 08:16:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['tsvgx', 08:16:00 INFO - 'tsvgr_opacity', 08:16:00 INFO - 'tart', 08:16:00 INFO - 'tscrollx', 08:16:00 INFO - 'cart']}, 08:16:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:00 INFO - 'tsvgr_opacity', 08:16:00 INFO - 'tart', 08:16:00 INFO - 'tscrollx', 08:16:00 INFO - 'cart']}, 08:16:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'talos_options': ['--disable-e10s'], 08:16:00 INFO - 'tests': ['tp5o']}, 08:16:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'tests': ['tp5o']}, 08:16:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'talos_options': ['--disable-e10s', 08:16:00 INFO - '--xperf_path', 08:16:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:00 INFO - 'tests': ['tp5n']}, 08:16:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:00 INFO - 'talos_options': ['--xperf_path', 08:16:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:00 INFO - 'tests': ['tp5n']}}, 08:16:00 INFO - 'talos.zip': {'path': '', 08:16:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:00 INFO - Running post-action listener: _resource_record_post_action 08:16:00 INFO - [mozharness: 2017-01-19 16:16:00.657186Z] Finished populate-webroot step (success) 08:16:00 INFO - [mozharness: 2017-01-19 16:16:00.657320Z] Running create-virtualenv step. 08:16:00 INFO - Running pre-action listener: _resource_record_pre_action 08:16:00 INFO - Running main action method: create_virtualenv 08:16:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:00 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 08:16:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:00 INFO - Using real prefix '/tools/python27' 08:16:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:04 INFO - Installing pip.................done. 08:16:04 INFO - Return code: 0 08:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:16:04 INFO - Reading from file tmpfile_stdout 08:16:04 INFO - Output received: 08:16:04 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) 08:16:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:04 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:04 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 08:16:04 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 08:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:04 INFO - 'HOME': '/Users/cltbld', 08:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:04 INFO - 'LOGNAME': 'cltbld', 08:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:04 INFO - 'MOZ_NO_REMOTE': '1', 08:16:04 INFO - 'NO_EM_RESTART': '1', 08:16:04 INFO - 'PAGER': '/bin/cat', 08:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:04 INFO - 'PWD': '/builds/slave/test', 08:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:04 INFO - 'SHELL': '/bin/bash', 08:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:04 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:04 INFO - 'USER': 'cltbld', 08:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:04 INFO - 'XPC_FLAGS': '0x0', 08:16:04 INFO - 'XPC_SERVICE_NAME': '0', 08:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:04 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 08:16:04 INFO - Cleaning up... 08:16:04 INFO - Return code: 0 08:16:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:04 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:04 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 08:16:04 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 08:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:04 INFO - 'HOME': '/Users/cltbld', 08:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:04 INFO - 'LOGNAME': 'cltbld', 08:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:04 INFO - 'MOZ_NO_REMOTE': '1', 08:16:04 INFO - 'NO_EM_RESTART': '1', 08:16:04 INFO - 'PAGER': '/bin/cat', 08:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:04 INFO - 'PWD': '/builds/slave/test', 08:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:04 INFO - 'SHELL': '/bin/bash', 08:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:04 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:04 INFO - 'USER': 'cltbld', 08:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:04 INFO - 'XPC_FLAGS': '0x0', 08:16:04 INFO - 'XPC_SERVICE_NAME': '0', 08:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:05 INFO - Downloading/unpacking psutil>=3.1.1 08:16:05 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 08:16:05 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 08:16:05 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 08:16:05 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 08:16:05 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 08:16:05 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 08:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:09 INFO - Installing collected packages: psutil 08:16:09 INFO - Running setup.py install for psutil 08:16:09 INFO - building 'psutil._psutil_osx' extension 08:16:09 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 08:16:09 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 08:16:09 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 08:16:09 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 08:16:09 INFO - building 'psutil._psutil_posix' extension 08:16:09 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 08:16:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:16:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:16:09 INFO - ^ 08:16:09 INFO - 1 warning generated. 08:16:09 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 08:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:09 INFO - Successfully installed psutil 08:16:09 INFO - Cleaning up... 08:16:09 INFO - Return code: 0 08:16:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:09 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')]} 08:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:09 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')]} 08:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:09 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:09 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 08:16:09 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 08:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:09 INFO - 'HOME': '/Users/cltbld', 08:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:09 INFO - 'LOGNAME': 'cltbld', 08:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:09 INFO - 'MOZ_NO_REMOTE': '1', 08:16:09 INFO - 'NO_EM_RESTART': '1', 08:16:09 INFO - 'PAGER': '/bin/cat', 08:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:09 INFO - 'PWD': '/builds/slave/test', 08:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:09 INFO - 'SHELL': '/bin/bash', 08:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:09 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:09 INFO - 'USER': 'cltbld', 08:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:09 INFO - 'XPC_FLAGS': '0x0', 08:16:09 INFO - 'XPC_SERVICE_NAME': '0', 08:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:10 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 08:16:10 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 08:16:10 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 08:16:10 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 08:16:10 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 08:16:10 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 08:16:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:12 INFO - Installing collected packages: mozsystemmonitor 08:16:12 INFO - Running setup.py install for mozsystemmonitor 08:16:13 INFO - Successfully installed mozsystemmonitor 08:16:13 INFO - Cleaning up... 08:16:13 INFO - Return code: 0 08:16:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16:13 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')]} 08:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:13 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')]} 08:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:13 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:13 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 08:16:13 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 08:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:13 INFO - 'HOME': '/Users/cltbld', 08:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:13 INFO - 'LOGNAME': 'cltbld', 08:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:13 INFO - 'MOZ_NO_REMOTE': '1', 08:16:13 INFO - 'NO_EM_RESTART': '1', 08:16:13 INFO - 'PAGER': '/bin/cat', 08:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:13 INFO - 'PWD': '/builds/slave/test', 08:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:13 INFO - 'SHELL': '/bin/bash', 08:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:13 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:13 INFO - 'USER': 'cltbld', 08:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:13 INFO - 'XPC_FLAGS': '0x0', 08:16:13 INFO - 'XPC_SERVICE_NAME': '0', 08:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:13 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:16 INFO - warning: no files found matching '*.txt' 08:16:16 INFO - no previously-included directories found matching 'build' 08:16:16 INFO - no previously-included directories found matching 'dist' 08:16:16 INFO - no previously-included directories found matching '.git*' 08:16:16 INFO - Installing collected packages: jsonschema, functools32 08:16:16 INFO - Running setup.py install for functools32 08:16:16 INFO - warning: no files found matching '*.txt' 08:16:16 INFO - no previously-included directories found matching 'build' 08:16:16 INFO - no previously-included directories found matching 'dist' 08:16:16 INFO - no previously-included directories found matching '.git*' 08:16:16 INFO - Successfully installed jsonschema functools32 08:16:16 INFO - Cleaning up... 08:16:16 INFO - Return code: 0 08:16:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16:16 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')]} 08:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:16 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')]} 08:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:16 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:16 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 08:16:16 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 08:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:16 INFO - 'HOME': '/Users/cltbld', 08:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:16 INFO - 'LOGNAME': 'cltbld', 08:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:16 INFO - 'MOZ_NO_REMOTE': '1', 08:16:16 INFO - 'NO_EM_RESTART': '1', 08:16:16 INFO - 'PAGER': '/bin/cat', 08:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:16 INFO - 'PWD': '/builds/slave/test', 08:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:16 INFO - 'SHELL': '/bin/bash', 08:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:16 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:16 INFO - 'USER': 'cltbld', 08:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:16 INFO - 'XPC_FLAGS': '0x0', 08:16:16 INFO - 'XPC_SERVICE_NAME': '0', 08:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:17 INFO - Cleaning up... 08:16:17 INFO - Return code: 0 08:16:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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', '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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:16: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 blobuploader==1.2.4 08:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:17 INFO - 'HOME': '/Users/cltbld', 08:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:17 INFO - 'LOGNAME': 'cltbld', 08:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:17 INFO - 'MOZ_NO_REMOTE': '1', 08:16:17 INFO - 'NO_EM_RESTART': '1', 08:16:17 INFO - 'PAGER': '/bin/cat', 08:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:17 INFO - 'PWD': '/builds/slave/test', 08:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:17 INFO - 'SHELL': '/bin/bash', 08:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:17 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:17 INFO - 'USER': 'cltbld', 08:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:17 INFO - 'XPC_FLAGS': '0x0', 08:16:17 INFO - 'XPC_SERVICE_NAME': '0', 08:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16: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 08:16:21 INFO - Downloading docopt-0.6.1.tar.gz 08:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:21 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:21 INFO - Running setup.py install for blobuploader 08:16:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:21 INFO - Running setup.py install for requests 08:16:22 INFO - Running setup.py install for docopt 08:16:22 INFO - Successfully installed blobuploader requests docopt 08:16:22 INFO - Cleaning up... 08:16:22 INFO - Return code: 0 08:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:22 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:22 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 08:16:22 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 08:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:22 INFO - 'HOME': '/Users/cltbld', 08:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:22 INFO - 'LOGNAME': 'cltbld', 08:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:22 INFO - 'MOZ_NO_REMOTE': '1', 08:16:22 INFO - 'NO_EM_RESTART': '1', 08:16:22 INFO - 'PAGER': '/bin/cat', 08:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:22 INFO - 'PWD': '/builds/slave/test', 08:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:22 INFO - 'SHELL': '/bin/bash', 08:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:22 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:22 INFO - 'USER': 'cltbld', 08:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:22 INFO - 'XPC_FLAGS': '0x0', 08:16:22 INFO - 'XPC_SERVICE_NAME': '0', 08:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-arxus5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-fw68oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-XBkgx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-GlPlvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7n7X_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-SNOXTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-GG3YOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-pinhaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6NFYOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Fj5AqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-3Asjq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-07O4_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-5tdGg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-kpJ2Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mgGSLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-tPfRNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QvjqFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:24 INFO - Running setup.py install for manifestparser 08:16:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:24 INFO - Running setup.py install for mozcrash 08:16:24 INFO - Running setup.py install for mozdebug 08:16:24 INFO - Running setup.py install for mozdevice 08:16:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:24 INFO - Running setup.py install for mozfile 08:16:25 INFO - Running setup.py install for mozhttpd 08:16:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Running setup.py install for mozinfo 08:16:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Running setup.py install for mozInstall 08:16:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Running setup.py install for mozleak 08:16:25 INFO - Running setup.py install for mozlog 08:16:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Running setup.py install for moznetwork 08:16:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:25 INFO - Running setup.py install for mozprocess 08:16:26 INFO - Running setup.py install for mozprofile 08:16:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:26 INFO - Running setup.py install for mozrunner 08:16:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:26 INFO - Running setup.py install for mozscreenshot 08:16:26 INFO - Running setup.py install for moztest 08:16:26 INFO - Running setup.py install for mozversion 08:16:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:26 INFO - Cleaning up... 08:16:26 INFO - Return code: 0 08:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:26 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:26 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 08:16:26 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 08:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:26 INFO - 'HOME': '/Users/cltbld', 08:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:26 INFO - 'LOGNAME': 'cltbld', 08:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:26 INFO - 'MOZ_NO_REMOTE': '1', 08:16:26 INFO - 'NO_EM_RESTART': '1', 08:16:26 INFO - 'PAGER': '/bin/cat', 08:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:26 INFO - 'PWD': '/builds/slave/test', 08:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:26 INFO - 'SHELL': '/bin/bash', 08:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:26 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:26 INFO - 'USER': 'cltbld', 08:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:26 INFO - 'XPC_FLAGS': '0x0', 08:16:26 INFO - 'XPC_SERVICE_NAME': '0', 08:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-KA4NYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-hcfkIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-lHUjRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TsZd2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-rBqTOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-3J_8te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OAFLqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:27 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)) 08:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-We9i_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-8Og7SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-aAr6Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-4OYUGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-R6ERnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Osd2dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Gpz_Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mEH5km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:28 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)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-DR9O5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-fh6n7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:29 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)) 08:16:29 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)) 08:16:29 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)) 08:16:29 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)) 08:16:29 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)) 08:16:29 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)) 08:16:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:29 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 08:16:29 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 08:16:29 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 08:16:29 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 08:16:29 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 08:16:29 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 08:16:31 INFO - Downloading blessings-1.6.tar.gz 08:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:31 INFO - Installing collected packages: blessings 08:16:31 INFO - Running setup.py install for blessings 08:16:32 INFO - Successfully installed blessings 08:16:32 INFO - Cleaning up... 08:16:32 INFO - Return code: 0 08:16:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:32 INFO - Reading from file tmpfile_stdout 08:16:32 INFO - Current package versions: 08:16:32 INFO - blessings == 1.6 08:16:32 INFO - blobuploader == 1.2.4 08:16:32 INFO - docopt == 0.6.1 08:16:32 INFO - functools32 == 3.2.3-2 08:16:32 INFO - jsonschema == 2.5.1 08:16:32 INFO - manifestparser == 1.1 08:16:32 INFO - mozInstall == 1.12 08:16:32 INFO - mozcrash == 1.0 08:16:32 INFO - mozdebug == 0.1 08:16:32 INFO - mozdevice == 0.48 08:16:32 INFO - mozfile == 1.2 08:16:32 INFO - mozhttpd == 0.7 08:16:32 INFO - mozinfo == 0.9 08:16:32 INFO - mozleak == 0.1 08:16:32 INFO - mozlog == 3.4 08:16:32 INFO - moznetwork == 0.27 08:16:32 INFO - mozprocess == 0.23 08:16:32 INFO - mozprofile == 0.28 08:16:32 INFO - mozrunner == 6.13 08:16:32 INFO - mozscreenshot == 0.1 08:16:32 INFO - mozsystemmonitor == 0.3 08:16:32 INFO - moztest == 0.8 08:16:32 INFO - mozversion == 1.4 08:16:32 INFO - psutil == 3.1.1 08:16:32 INFO - requests == 1.2.3 08:16:32 INFO - wsgiref == 0.1.2 08:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 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 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:32 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 08:16:32 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 08:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:32 INFO - 'HOME': '/Users/cltbld', 08:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:32 INFO - 'LOGNAME': 'cltbld', 08:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:32 INFO - 'MOZ_NO_REMOTE': '1', 08:16:32 INFO - 'NO_EM_RESTART': '1', 08:16:32 INFO - 'PAGER': '/bin/cat', 08:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:32 INFO - 'PWD': '/builds/slave/test', 08:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:32 INFO - 'SHELL': '/bin/bash', 08:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:32 INFO - 'USER': 'cltbld', 08:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:32 INFO - 'XPC_FLAGS': '0x0', 08:16:32 INFO - 'XPC_SERVICE_NAME': '0', 08:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 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)) 08:16:32 INFO - Cleaning up... 08:16:32 INFO - Return code: 0 08:16:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b96490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b0c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, '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.uyt33kza1C/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.kH4liflMO3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:32 INFO - 'HOME': '/Users/cltbld', 08:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:32 INFO - 'LOGNAME': 'cltbld', 08:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:32 INFO - 'MOZ_NO_REMOTE': '1', 08:16:32 INFO - 'NO_EM_RESTART': '1', 08:16:32 INFO - 'PAGER': '/bin/cat', 08:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:32 INFO - 'PWD': '/builds/slave/test', 08:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:32 INFO - 'SHELL': '/bin/bash', 08:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:16:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:32 INFO - 'USER': 'cltbld', 08:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:32 INFO - 'XPC_FLAGS': '0x0', 08:16:32 INFO - 'XPC_SERVICE_NAME': '0', 08:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:33 INFO - Cleaning up... 08:16:33 INFO - Return code: 0 08:16:33 INFO - Running post-action listener: _resource_record_post_action 08:16:33 INFO - Running post-action listener: _start_resource_monitoring 08:16:33 INFO - Starting resource monitoring. 08:16:33 INFO - [mozharness: 2017-01-19 16:16:33.087209Z] Finished create-virtualenv step (success) 08:16:33 INFO - [mozharness: 2017-01-19 16:16:33.088344Z] Running install step. 08:16:33 INFO - Running pre-action listener: _resource_record_pre_action 08:16:33 INFO - Running main action method: install 08:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:33 INFO - Reading from file tmpfile_stdout 08:16:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:33 INFO - Reading from file tmpfile_stdout 08:16:33 INFO - Output received: 08:16:33 INFO - Usage: mozinstall [options] installer 08:16:33 INFO - Options: 08:16:33 INFO - -h, --help show this help message and exit 08:16:33 INFO - -d DEST, --destination=DEST 08:16:33 INFO - Directory to install application into. [default: 08:16:33 INFO - "/builds/slave/test"] 08:16:33 INFO - --app=APP Application being installed. [default: firefox] 08:16:33 INFO - mkdir: /builds/slave/test/build/application 08:16:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:17:04 INFO - Reading from file tmpfile_stdout 08:17:04 INFO - Output received: 08:17:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:17:04 INFO - Running post-action listener: _resource_record_post_action 08:17:04 INFO - [mozharness: 2017-01-19 16:17:04.560764Z] Finished install step (success) 08:17:04 INFO - [mozharness: 2017-01-19 16:17:04.560918Z] Running run-tests step. 08:17:04 INFO - Running pre-action listener: _resource_record_pre_action 08:17:04 INFO - Running main action method: run_tests 08:17:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:04 INFO - 2017-01-19 08:17:04.575 screenresolution[7290:133976] starting screenresolution argv=screenresolution get 08:17:04 INFO - 2017-01-19 08:17:04.578 screenresolution[7290:133976] Display 0: 1600x1200x32@60 08:17:04 INFO - 2017-01-19 08:17:04.584 screenresolution[7291:133978] starting screenresolution argv=screenresolution list 08:17:04 INFO - Available Modes on Display 0 08:17:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:04 INFO - Intel Iris: 08:17:04 INFO - Chipset Model: Intel Iris 08:17:04 INFO - Type: GPU 08:17:04 INFO - Bus: Built-In 08:17:04 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:04 INFO - Vendor: Intel (0x8086) 08:17:04 INFO - Device ID: 0x0a2e 08:17:04 INFO - Revision ID: 0x0009 08:17:04 INFO - Displays: 08:17:04 INFO - Display: 08:17:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:04 INFO - Display Serial Number: 1600x1200 60 08:17:04 INFO - Main Display: Yes 08:17:04 INFO - Mirror: Off 08:17:04 INFO - Online: Yes 08:17:04 INFO - Rotation: Supported 08:17:04 INFO - Return code: 0 08:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:04 INFO - Python 2.7.3 08:17:04 INFO - Return code: 0 08:17:04 INFO - grabbing minidump binary from tooltool 08:17: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')]} 08:17:04 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 0x1099aad30>, '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 0x109810db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099a2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:04 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 08:17:04 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 08:17:04 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 08:17:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:04 INFO - Return code: 0 08:17:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:17:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:17:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 08:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyt33kza1C/Render', 08:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:04 INFO - 'HOME': '/Users/cltbld', 08:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:04 INFO - 'LOGNAME': 'cltbld', 08:17:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:04 INFO - 'MOZ_NO_REMOTE': '1', 08:17:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:04 INFO - 'NO_EM_RESTART': '1', 08:17:04 INFO - 'PAGER': '/bin/cat', 08:17:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:04 INFO - 'PWD': '/builds/slave/test', 08:17:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:04 INFO - 'SHELL': '/bin/bash', 08:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kH4liflMO3/Listeners', 08:17:04 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:04 INFO - 'USER': 'cltbld', 08:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:04 INFO - 'XPC_FLAGS': '0x0', 08:17:04 INFO - 'XPC_SERVICE_NAME': '0', 08:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 08:17:05 INFO - mozversion application_buildid: 20170119070428 08:17:05 INFO - mozversion application_changeset: 67e96cc5f42be249b7e40cec9b2eb0105d96625f 08:17:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:17:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:05 INFO - mozversion application_name: Firefox 08:17:05 INFO - mozversion application_remotingname: firefox-dev 08:17:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:17:05 INFO - mozversion application_vendor: Mozilla 08:17:05 INFO - mozversion application_version: 52.0a2 08:17:05 INFO - mozversion platform_buildid: 20170119070428 08:17:05 INFO - mozversion platform_changeset: 67e96cc5f42be249b7e40cec9b2eb0105d96625f 08:17:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:17:05 INFO - mozversion platform_version: 52.0a2 08:17:05 INFO - using testdate: 1484842625 08:17:05 INFO - actual date: 1484842625 08:17:05 INFO - starting webserver on 'localhost:60170' 08:17:05 INFO - SUITE-START | Running 2 tests 08:17:05 INFO - TEST-START | dromaeo_css 08:17:05 INFO - operating with platform_type : mac_ 08:17:05 INFO - Initialising browser for dromaeo_css test... 08:17:05 INFO - TEST-INFO | started process 7301 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpAUqRkZ/profile http://localhost:60170/getInfo.html) 08:17:08 INFO - PROCESS | 7301 | 2017-01-19 08:17:08.249 plugin-container[7303:134151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b37, name = 'com.apple.tsm.portname' 08:17:08 INFO - PROCESS | 7301 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:17:08 INFO - PROCESS | 7301 | 2017-01-19 08:17:08.252 plugin-container[7303:134151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a07, name = 'com.apple.CFPasteboardClient' 08:17:08 INFO - PROCESS | 7301 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:17:08 INFO - PROCESS | 7301 | 2017-01-19 08:17:08.252 plugin-container[7303:134151] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:17:08 INFO - PROCESS | 7301 | __metrics Screen width/height:1600/1200 08:17:08 INFO - PROCESS | 7301 | colorDepth:24 08:17:08 INFO - PROCESS | 7301 | Browser inner width/height: 1024/689 08:17:08 INFO - PROCESS | 7301 | __metrics 08:17:08 ERROR - PROCESS | 7301 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:17:09 INFO - TEST-INFO | 7301: exit 0 08:17:09 INFO - Browser initialized. 08:17:09 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:09 INFO - TEST-INFO | started process 7304 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpAUqRkZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:11 INFO - PROCESS | 7304 | 2017-01-19 08:17:11.959 plugin-container[7305:134278] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 08:17:11 INFO - PROCESS | 7304 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:17:11 INFO - PROCESS | 7304 | 2017-01-19 08:17:11.960 plugin-container[7305:134278] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 08:17:11 INFO - PROCESS | 7304 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:17:11 INFO - PROCESS | 7304 | 2017-01-19 08:17:11.960 plugin-container[7305:134278] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:17:21 INFO - PROCESS | 7304 | RSS: Main: 229142528 08:17:21 INFO - PROCESS | 7304 | 08:20:24 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:60170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60170/tests/dromaeo/cssquery-ext.html) 08:20:25 INFO - PROCESS | 7304 | RSS: Main: 233660416 08:20:25 INFO - PROCESS | 7304 | 08:23:28 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:60170/tests/dromaeo/cssquery-ext.html (next: http://localhost:60170/tests/dromaeo/cssquery-jquery.html) 08:23:28 INFO - PROCESS | 7304 | RSS: Main: 243412992 08:23:28 INFO - PROCESS | 7304 | 08:26:30 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:60170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60170/tests/dromaeo/cssquery-mootools.html) 08:26:31 INFO - PROCESS | 7304 | RSS: Main: 246743040 08:26:31 INFO - PROCESS | 7304 | 08:29:33 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:60170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60170/tests/dromaeo/cssquery-prototype.html) 08:29:33 INFO - PROCESS | 7304 | RSS: Main: 246026240 08:29:33 INFO - PROCESS | 7304 | 08:32:36 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:60170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60170/tests/dromaeo/cssquery-yui.html) 08:32:37 INFO - PROCESS | 7304 | RSS: Main: 249434112 08:32:37 INFO - PROCESS | 7304 | 08:35:39 INFO - PROCESS | 7304 | Cycle 1(1): loaded http://localhost:60170/tests/dromaeo/cssquery-yui.html (next: http://localhost:60170/tests/dromaeo/cssquery-dojo.html) 08:35:40 INFO - PROCESS | 7304 | RSS: Main: 251174912 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | __start_tp_report 08:35:40 INFO - PROCESS | 7304 | _x_x_mozilla_page_load 08:35:40 INFO - PROCESS | 7304 | _x_x_mozilla_page_load_details 08:35:40 INFO - PROCESS | 7304 | |i|pagename|runs| 08:35:40 INFO - PROCESS | 7304 | |0;dojo.html;2730.918072457827;3272.3782481328562;3288.4574045282516;3298.3733090712763;3340.2985373071656;5636.633618814779;5643.971780141099;5687.232223649806;5717.3139223293265;5720.79977200798;5634.295713035871;5713.114467257571;5730.111832665933;5745.253117094772;5790.478856902878;5173.249878767577;5212.504812042869;5227.86930326743;5233.607479439057;5272.762725677354;5279.973600131994;5285.207218917174;5303.761330740126;5336.839894803162;5345.064613692608;5159.200323949775;5166.896662066756;5290.814821481249;5308.9469105308835;5347.064263753847;5228.47715228476;5233.3981592116825;5310.575153987672;5336.959292937879;5341.4658534146665;5183.870403239912;5238.030964271622;5248.816291429782;5255;5265.235356719925;4437.245668236407;5503.669779813224;5584.21820945068;5672.290963629546;5695.515881150107;6078.544109191784;6135.478484328837;6139.907901381483;6145.446909778141;6152.415520525587;6115.088229002391;6180.81457556274;6181.474574661159;6193.1639228704;6193.2877719062435;5784.913226301609;5796.304443466769;5818.4763371296785;5826.912596311059;5841.47426731592;6113.780377411019;6178.289496707846;6204.945159322926;6241.78153764616;6336.17629708135;4968.677035992649;6042.244719410074;6105.664188469676;6131.754729810757;6142.600730952474;6178.165947597106;6191.566590338633;6194.628322300677;6201.596896201822;6211;5986.161937328778;6066.575339726177;6154.353792851775;6163.660998645118;6218.751249950042;4527.932081018787;4956.727379994063;5979.551533634908;6011.699415029231;6089.969550152221;4804.0872234275375;4812.590929771009;4816.759162041954;4823.782929768169;4857.975710121497;4298.871033868989;4317.057324204058;4318.654507639381;4342.41377414045;4347.478302603645;5106.46382129871;5219.634625576249;5613.073842815889;5745.770169193269;5908.822735317947;6095.634261944298;6145.846353841101;6166.414190651971;6186.226721659793;6187.597806142587;5626.24045753818;5664.348599910981;5819.098039803837;5827.79602713903;5866.882662346815;5327.493888080626;5373.623846330797;5380.757865896044;5423.322084739408;5445.863853403696;6281.59169653971;6287.748490060347;6290.2766181889665;6297.622142671455;6341;5978.97010514962;6162.969185154046;6191.226096737908;6200;6204.472619827366;6159.692015399301;6170.413810687977;6211.81364559064;6212.378762123933;6251;6160.476359509492;6166.2600487939935;6169.259688837368;6172.814815555541;6175.9073613894925;5229.215617657382;6196.721147548461;6202.069689546604;6205.782797602063;6209.937900620936;5907.409259074058;5971.373005834324;6001.129836173643;6009.489193418608;6060.212172417558;6043.7884674036195;6101.877962440815;6108.038540470994;6109.480694141048;6115.818436018264;4981.277714731416;5947.345791962967;5961;5965.403459654;5984.581079324405;5803.3616302207565;5903.940960590511;5954.970225148846;6021.096835474538;6068.575199736153;5866.5893387462465;5912.881742365214;5949.940500594938;5951.285845698544;5969.76120955157 08:35:40 INFO - PROCESS | 7304 | |1;ext.html;454.2210109661929;468.3045677169403;479.69539342517504;490.5437942713275;524.2398522142894;38752.80623596882;40445.79777101114;40687.79656101715;40690.59309406909;40720.77837664875;41610;42140.57859421405;42241.310347586135;42260.78869605648;42275.36586951198;9310.720678379643;9487.193588544982;9502.572384242725;9502.619895204218;9521.666741664043;8247.134050924626;9395.295352848529;9461;9477.857832132524;9495.477748723852;8123.796905077391;9059.320550958704;9538.189253913426;9570.808583828319;9588.52057397131;7908.44640875139;8344.749657510285;9342;9399.812003759887;9548;9345.299102567267;9406.529673516297;9419.24646028323;9441.575129119137;9448.244140468814;39236;39516.80241598802;39994.80015599537;40016.399754003716;40028.39957400641;3159.952600710991;3275.3449310138067;3310.4372256716415;3331.816750078745;3343.2477692518987;28790.136295911158;28886;28943.71056289452;29039.274018149503;29198.85400573005;3148.3231105312466;3160.715535601807;3329.500574913758;3354.412977728912;3361.5461912641726;492960;497884;499515;500660.4966975142;503063;60165.69917150386;60516.69741651264;60600;60610;60778.696106519186;64046.35953640497;64262.67868660627;64385.35614643794;64943.70112597722;65081;16191.433299834449;16409.097499637395;16469.176541172892;16495.422660206834;16568.585785355463;12507.3746312684;12647.683807904876;12729.427175777113;12736.872631273754;12774.361281935866;17246.482605521855;18097.104034466898;18815.247390104516;18890.62218755617;19094.904525477283;3197.5683282756995;7626.771196863992;7902.328302094272;7920.207979202034;7960.721374751972;848.8811566380712;937.6202637931649;940.6331530703031;1068.4657671164418;1077.7413420778958;29525;29691.85154074216;29739.553906691417;29891.40217195644;30249.697503024687;973.9123478886793;1080.6109800471825;1095.7863216672672;1105.4086063955906;1154.572808061023;14972.925135374253;15047.924760376129;15220.391184352724;15330.923345383202;15342.463013794464;689565;691182;697165;698490;699809;57053.71473142691;57655;57702;57763.71118144466;57797;1154.8152295632826;1202.386782740791;1304.7716649586284;1334.4395353951363;1359.136948038003;28351.149465516068;29108.27229319284;29298.560521591768;29464.705352946195;29727.25681857971;47597.52402475931;49236.2614560789;49429.50570494249;49623.00753984972;49623.751881240365;515485;518095;518258;519563;519804;21750.564988700455;26225.688715564527;26304.73695263023;26596.867015664797;26668.866655667374;45251.7737411324;45287.77356113198;45834;46677.76661116673;47334.81662958454;37740.05649858776;37929.81035094807;38006;38073.80963095167;39102.82691519259;37664.62335376611;37778;37853;38577.6142238574;38969.80515097406;31326.843365783025;31960.36079278448;36810.8159459201;37298.6270137306;37668.62331376761;30854.382912342076;34011.4898276531;34130;34236.82881585576;34356.656433435346;20874.895625521774;25126.623100653138;25185.748142519074;25657.358566035997;25716.48041232034 08:35:40 INFO - PROCESS | 7304 | |2;jquery.html;329.9241174529858;372.6962525541683;379.9373103437933;382.0601320750952;400.4733775085762;17762.111894405276;18901;19135.904320478414;19554.217831286733;19581.706274405897;16067.91966040171;19192.904035479838;19489.610207795835;19684.311049113247;20106.59786804263;5593.2449119368775;5818.156367326735;5841.591088623798;5845.415458454163;5847.5614328925285;5512.145617429305;5733.741981610838;5734.942650573504;5799.623024503394;5817.418258174191;5505.504504594585;5704.458076482728;5762.711864406784;5774.133879918025;5785.190073389707;5585.8603534911745;5709.714514274269;5710.657360558359;5716.685582292972;5725.971370143144;4850;4899.363082799213;5042.319286896259;5060.316857224265;5068.619853511002;23961.640575391382;24122.879385603133;24139.63790543143;24344.39139021521;24398.634020489706;2382.1662418153683;2431.756824317572;2503.7996960243136;2689.784817214618;2843.502387082273;14475.71048579033;14915.701685966329;15084.622884427978;15578.376864925389;15605.765913511306;1714.6484970581;1803.332766876251;1839.3562253211403;1846.4922146409845;1902.1915685833465;104035;106514.46742766314;111618;111674;112806;11396.886031139748;11640.825387619192;11682.299062056303;11728.237664551776;11797.587084452174;14451.566453006426;14536.927315363355;14542.563723088324;14574.41702331916;14590.343434545472;8231.6417791065;8336.62485188156;8488.320934325238;8532.957335213285;8540.615672294762;6785.762498312634;7199.280071992864;8200.466969646954;8210.178982101743;8226.42415030954;3895.240428116547;4504.301833215857;4564.748938808398;4564.908701825945;4582.075528278065;1934.429343343717;1966;1998.7401637786995;2012.2554654777825;2023.2311721546014;848.8811566380712;883.1433509495779;935.158357478275;937.315759495572;1005.4319309590059;19456.416307510797;20364.18543258253;20370.898145509473;20415.387538373874;20466.897665511577;951.9048095190426;954.9761255968517;962.5860879821604;964.9228061755043;1007.8337074382645;10913.727156820984;11182.440877956233;11190.552377904793;11264.324140551429;11264.94367528157;585018;593689;605920;608146;609465;114533.85466145232;114870;124898.75101249052;128181.3590932058;131061;904.1591320072264;929.4284015330658;963.4123184857232;981.2787601113176;1006.5269323418128;13605;17908.83592566479;18094.638107238046;18657.440276791716;18830.623387531898;36876.26247475089;48040.75979620079;50970.49029509806;54361.72819135879;55035;81126;82358;84397.57801210954;85678;87164.69252961084;7711.730089446843;7875.173106823701;7940.205979402013;8122.959385203036;8233;9036.05121462237;12145.271283723005;12301.630951071482;12313.44589493457;12556.937215313865;10178.389296642225;10380.532876020447;10547.57809687604;10907.78184436291;11031.338119712844;9984.400935943866;10344.793104138025;10647.094996925349;10802.567897284021;10960.835587466036;10075.798484030132;10949.671509854717;11023.559057637605;11138.27601205919;11437.942810285895;6703.765368212089;7498.362639175732;8030;8084.231997960184;8198.508089514648;9860.753481162741;10728.89271107279;10845.837312440477;10846.29499082557;11126.332420054823 08:35:40 INFO - PROCESS | 7304 | |3;mootools.html;1269.1243042300812;1337.2912356451081;1458.8687018168362;1771.220662908321;1775.3253763569849;7542.962285188566;7720.498167619101;7989.440739148255;8459.661613535467;8486.575671216438;8004.319632831216;8273.007239131297;8298.045724741642;8406.327493800496;8427.91572084279;2275.590393729128;2310.2838120182714;2321.025169428844;2325.104834638659;2329.3827135809024;2321.7330007049236;2352.0591763294733;2355.8704271265074;2356.528694261146;2373.774491423312;2302.194232018797;2310.780475854791;2330.9650355244685;2337.567550003246;2337.777911098443;2296.942576435594;2297.127091705158;2313.64138558522;2319.3621754017695;2323.2565579014636;2325.302409277227;2337.4506990857135;2346.4720437901506;2346.6597343385115;2357.328161473989;6837.692303846339;8323.12607176244;8325.458845175044;8367.079621241719;8424.283935865458;5022.924656130161;5169.870753231162;5194.792208311663;5201.869953251199;5210.557102646279;3251.5122731590213;3304.3060957198777;3376.9831150844334;3567.23304489536;3569.6430356964356;1030.319988807391;1065.350136416785;1087.5323610847333;1097.5664612478026;1112.7718817642365;10701.571937122584;10909.127269818475;10915.290506117157;10984.505697243643;11005.889941100566;4476.686631935733;4616.399868017136;4700.764961751899;4701.576858082789;4726.220173671374;9357.298202634693;9434.90565094354;9436.528173591292;9440.763980900532;9450.33847630673;5080.644354895196;5197.792088316425;5198.16829307309;5204.271402003723;5204.8178313758835;4264.0832221072615;4264.509581398117;4691.7184968901975;4767.261074533453;4770.904581908342;3164.351307981858;3783.848646054127;3882.165334453106;3899.5515515716056;3945.309570825094;1259.5843371687322;1265.0891358222066;1269.5683467621054;1273.9681507962189;1280.961571152867;870.9825803483894;891.4072142025481;894.5169608411516;907.8547432410783;909.3407279722148;5372.167314066326;5540.113581826889;5554;5624.156376543469;5723.399043100498;936.8875734911718;953.2936044480302;991.5438898106808;1003.5484032185545;1014.1075853249093;3691.9077023074638;3742.36379815432;3757.4739536464917;3765.6799172070682;3780.9432858507143;7891.842163156704;9865.408075515492;10344.431056291825;10355.275130740927;10378.844317335246;10304.278700490893;10311.22665800068;10311.278210525341;10318.793624127626;10321.380717156844;7773.106092799288;7904.762857114296;7914.327282180964;7935.801604959922;7940.563269020259;4953.72754498506;5513.365962914316;5618.89170015376;5713.628614140068;5773.220615216892;7637.5035622684345;9314.301427393108;9320;9433.52832358393;9523.714288571355;8324.334053275845;8947.19475247231;9430.62277508892;9441.386309889835;9446.85829712541;6592.637404942774;6830.556013859282;7038.718451261892;7179.210286868336;7365.8158546036775;7714.691412343668;7719.996400468128;7782.649780759766;7872.84254314922;7882.842343153219;5779.682117483579;6952.930470695228;7058.294170582901;7088.929110709033;7210;6904.723811047502;6951.895721564079;6959;6983.720651173896;6991.825204369931;5469.234307197075;6622.1722284714415;6749.797506074826;6774.187097548129;6782.152230971129;4447.977760111179;4825.5174482551465;4842.4189097308545;4861.465238823797;4878.536539028786;4732.47942726293;4780.545848144421;4802.687825291345;4960.032793605213;5028.145215313332 08:35:40 INFO - PROCESS | 7304 | |4;prototype.html;273.6360640348337;300.7879444991281;305.05585213763396;306.952422374532;311.81758671177363;4829.913269514357;5146.588272938166;5365;5484.122540393538;5540.254819731782;4411.757353345564;4888.364512613364;5050.545450909417;5290.497402746733;5359.330083739533;4142.834286628531;4145.958540414603;4157.6695457453625;4180.686448516358;4185.623293903555;3948.802559871995;4147.274227010276;4147.398627199054;4154.584541545852;4159.688023398257;4081.9183616327655;4093.5087789465306;4104.526066587419;4112.239235741383;4117.949922769704;4095.85664501744;4097.508299004109;4100.815463304159;4110.177964407116;4131.814068366931;3573.0352804742834;3580.534530511043;3582.7133829293593;3582.802945837978;3591.892243232707;4354.063876266618;4565.931511027337;5057.468965758616;5161.74191290434;5211.42674305826;4102.2821006324075;4371.4972778130605;4607.7004994675235;4629.606483448911;4631.734627087895;5473.467429119853;5629.380768115504;5640.323161220639;5670.886582268332;5673.914891276634;3432.129489428268;3501.3872572299747;3572.821358932069;3781.735278530504;3829.5596006459336;4982.701037937735;5948.464638182584;5984.521238300969;5997.100434934795;6008.519318454513;3262.918427039343;3414.163529935132;3900.7659540427667;3916.980415097906;3931.8820435386983;3002.774791890617;3634.47300141478;3968.900777480586;3970.920581588352;3976.602339766;3849.8845034649007;4622.260438329851;4646.3495110684535;4659.277811939155;4661.114388266218;5335.519803217651;5629.678489691102;5703.74333155009;5735.910177066344;5873.471387575053;1024.5707238402388;1224.4184012594126;1243.5574733309318;1256.8428946381703;1269.549309994957;735.9116905971317;804.9937578027466;869.4218344800637;869.5999840073637;879.2614204068485;4452.287633978548;4833.9033219335415;4941.555260026543;5073.34046573943;5111.463296353903;5355.785768569213;5631.605787594911;5632.662040277596;5633.8309850704545;5707.514861236758;4156.43888075112;4705.717656940595;4777.713337199779;5082.1196157421255;5123.180291153472;2597.8830952607177;2857.6856545779947;2904.533210728611;2946.42544703785;2975.642922849229;4995.825146119869;5035.823746168867;5535.944640553543;5674.716264186856;5881.470667639847;5229.921551176735;5275.525202731696;5314.7608357624;5595.244641973363;5770.855728606818;5578.442155784389;5663.915041274384;5674.319081710139;5680.796210804058;5810.651360918274;4428.844990425319;5171.776136261444;5566.6381685191955;5580.916286255629;5652.710652185871;4604.677672562889;5408.945910540844;5507;5596.636218645938;5896.852578685395;5087.3386459759995;6204.317525072329;6214.658193799384;6216.751329946932;6239.75040998355;3636.254567813539;3932.5477570079806;3939.881803545898;3956.169204467094;3971.2057588481844;5505.532029777513;5856.297244330537;5899.528037756883;5925.525957923442;5950.256217972754;4813.181759100891;5530.451473587402;5595.209532949417;5699.8860022800145;5819.592628516132;5744.310682717934;5752.28096487939;5760.539156867524;5782.681952492485;5792.914550761807;4643.2802915548145;5375.731213439391;5584.804531841366;5673.893590749764;5740.483356497935;4810.807567697393;5745.787871669521;5764.308283006066;5803.970980145241;5812.622179558315;4830.7826147824135;5159.652358176945;5739.62692424991;5747.051736463437;5750.511206547323 08:35:40 INFO - PROCESS | 7304 | |5;yui.html;668.3316683316683;680.897865320202;713.1442269276869;743.9696021010898;755.2183490087758;13312.668733126695;13720.245386503739;13924.443022279096;14789.186594737284;14855.851441485582;13109.934450327735;13118.081734278581;13119.737605247888;13253.933730331359;13261.933690331534;631.0439683878927;652.9118568993197;655.6361219523163;784.9293563579276;813.8128230506987;817.8486979908736;818.1327792539927;820.9466384684977;821.4455242711146;822.4366309078271;850.5747126436781;858.8582883824162;860.27736701171;864.9264812490945;864.9524276164808;836.7489753074115;847.1063028504925;855.9871601925976;857.7341024282492;858.3347905373323;635.1933045032782;644.2591020326615;645.1548471502347;645.2321737132797;645.635216102905;13759.243241621707;14074.648133796634;14114.153150810984;14145.434182632682;14382.712345753027;12029.81955270663;12194.939025304906;12986.090973631755;13152.539661111816;13212.141210821266;10897.945510272477;11253.887461125365;11329.09367250618;11368;11647.41762911851;3018.9547156792664;3579.946300805464;3670.853165873362;3672.485851980725;3674.577423596294;81957.59021204915;82333.58833205856;83189.3362132754;83409.16590834074;84978;6801.761938332134;7871.921280787119;7873.094594121635;7907.881381779278;7917.722879699183;20664.48338791542;20957.476063098544;20969;21058.47353816167;21284.255051073138;7383.040204773452;7405.333519983227;7415.925840741632;7490.85018299631;7516.361109305661;4038.919221615551;4132.152908653718;4141.811482348218;4181.51912530063;4188.958110418856;3355.1612096975755;3480.4257297545623;3484.1463841358523;3485.35520928629;3490.5636795400574;566.8662674650699;603.8943184942617;636.7325723196176;649.8960166373357;656.7734131724548;512.8256392826457;606.375433303698;632.2349956552531;639.4596565901899;650.1710319342781;8568.742937711879;8582.65669373218;8672.132786721277;8868.512231827182;8973.147550982647;552.7899398228727;625.7578706268055;626.4111734969115;626.8432891777056;629.6442509981846;3468.497067925137;4339.652827773771;4355.7822108894425;4372.497162826252;4458.175237581057;76862;95946.52026739821;124595.3770231143;124901;125120;99801.5029774554;103182;105916;106087;108253;68936;70089.64955175192;71466.28533714596;74980.62509687417;83173.58413207895;8874.29005679557;9302.581383837609;9391.530423478662;9451.338406311492;9523.857142143012;52489.68775780636;54750.45249547613;54809.72595136999;54892.45107548873;54962.72518637541;62491.12526624209;64262.85897128312;71953;77890;80245.59877200576;11795.174337796272;11906;12200.87799122033;12218.38908054576;12384.75230495403;13429.992750543553;13554.661133471742;13643.931780341034;13660.453581857011;13793.724125517232;12380.876191238332;12510.679727393908;12715.173513721578;12733.29966851832;12951.805722913976;12309.44607492647;12553.246805191719;12649.494020239088;12698.761157317687;12998.350082495648;12088.274703517816;12447;12557.560485382968;12594.622161334808;12965.481380744664;8679.652813887626;9304;9309.348345615741;9318.48748318849;9614.615415383307;10534.42060686639;10634.787304254027;10740.248182627141;10860.348379097279;10960.342379457257 08:35:40 INFO - PROCESS | 7304 | __end_tp_report 08:35:40 INFO - PROCESS | 7304 | __start_cc_report 08:35:40 INFO - PROCESS | 7304 | _x_x_mozilla_cycle_collect,366 08:35:40 INFO - PROCESS | 7304 | __end_cc_report 08:35:40 INFO - PROCESS | 7304 | __startTimestamp1484843740054__endTimestamp 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | ------- Summary: start ------- 08:35:40 INFO - PROCESS | 7304 | Number of tests: 6 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | [#0] dojo.html Cycles:165 Average:5662.31 Median:5907.41 stddev:661.76 (11.2%) stddev-sans-first:622.55 08:35:40 INFO - PROCESS | 7304 | Values: 2730.9 3272.4 3288.5 3298.4 3340.3 5636.6 5644.0 5687.2 5717.3 5720.8 5634.3 5713.1 5730.1 5745.3 5790.5 5173.2 5212.5 5227.9 5233.6 5272.8 5280.0 5285.2 5303.8 5336.8 5345.1 5159.2 5166.9 5290.8 5308.9 5347.1 5228.5 5233.4 5310.6 5337.0 5341.5 5183.9 5238.0 5248.8 5255.0 5265.2 4437.2 5503.7 5584.2 5672.3 5695.5 6078.5 6135.5 6139.9 6145.4 6152.4 6115.1 6180.8 6181.5 6193.2 6193.3 5784.9 5796.3 5818.5 5826.9 5841.5 6113.8 6178.3 6204.9 6241.8 6336.2 4968.7 6042.2 6105.7 6131.8 6142.6 6178.2 6191.6 6194.6 6201.6 6211.0 5986.2 6066.6 6154.4 6163.7 6218.8 4527.9 4956.7 5979.6 6011.7 6090.0 4804.1 4812.6 4816.8 4823.8 4858.0 4298.9 4317.1 4318.7 4342.4 4347.5 5106.5 5219.6 5613.1 5745.8 5908.8 6095.6 6145.8 6166.4 6186.2 6187.6 5626.2 5664.3 5819.1 5827.8 5866.9 5327.5 5373.6 5380.8 5423.3 5445.9 6281.6 6287.7 6290.3 6297.6 6341.0 5979.0 6163.0 6191.2 6200.0 6204.5 6159.7 6170.4 6211.8 6212.4 6251.0 6160.5 6166.3 6169.3 6172.8 6175.9 5229.2 6196.7 6202.1 6205.8 6209.9 5907.4 5971.4 6001.1 6009.5 6060.2 6043.8 6101.9 6108.0 6109.5 6115.8 4981.3 5947.3 5961.0 5965.4 5984.6 5803.4 5903.9 5955.0 6021.1 6068.6 5866.6 5912.9 5949.9 5951.3 5969.8 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | [#1] ext.html Cycles:180 Average:70036.95 Median:40005.60 stddev:154583.07 (386.4%) stddev-sans-first:154928.44 08:35:40 INFO - PROCESS | 7304 | Values: 454.2 468.3 479.7 490.5 524.2 38752.8 40445.8 40687.8 40690.6 40720.8 41610.0 42140.6 42241.3 42260.8 42275.4 9310.7 9487.2 9502.6 9502.6 9521.7 8247.1 9395.3 9461.0 9477.9 9495.5 8123.8 9059.3 9538.2 9570.8 9588.5 7908.4 8344.7 9342.0 9399.8 9548.0 9345.3 9406.5 9419.2 9441.6 9448.2 39236.0 39516.8 39994.8 40016.4 40028.4 3160.0 3275.3 3310.4 3331.8 3343.2 28790.1 28886.0 28943.7 29039.3 29198.9 3148.3 3160.7 3329.5 3354.4 3361.5 492960.0 497884.0 499515.0 500660.5 503063.0 60165.7 60516.7 60600.0 60610.0 60778.7 64046.4 64262.7 64385.4 64943.7 65081.0 16191.4 16409.1 16469.2 16495.4 16568.6 12507.4 12647.7 12729.4 12736.9 12774.4 17246.5 18097.1 18815.2 18890.6 19094.9 3197.6 7626.8 7902.3 7920.2 7960.7 848.9 937.6 940.6 1068.5 1077.7 29525.0 29691.9 29739.6 29891.4 30249.7 973.9 1080.6 1095.8 1105.4 1154.6 14972.9 15047.9 15220.4 15330.9 15342.5 689565.0 691182.0 697165.0 698490.0 699809.0 57053.7 57655.0 57702.0 57763.7 57797.0 1154.8 1202.4 1304.8 1334.4 1359.1 28351.1 29108.3 29298.6 29464.7 29727.3 47597.5 49236.3 49429.5 49623.0 49623.8 515485.0 518095.0 518258.0 519563.0 519804.0 21750.6 26225.7 26304.7 26596.9 26668.9 45251.8 45287.8 45834.0 46677.8 47334.8 37740.1 37929.8 38006.0 38073.8 39102.8 37664.6 37778.0 37853.0 38577.6 38969.8 31326.8 31960.4 36810.8 37298.6 37668.6 30854.4 34011.5 34130.0 34236.8 34356.7 20874.9 25126.6 25185.7 25657.4 25716.5 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | [#2] jquery.html Cycles:180 Average:34613.02 Median:24371.51 stddev:99981.46 (410.2%) stddev-sans-first:100228.79 08:35:40 INFO - PROCESS | 7304 | Values: 329.9 372.7 379.9 382.1 400.5 17762.1 18901.0 19135.9 19554.2 19581.7 16067.9 19192.9 19489.6 19684.3 20106.6 5593.2 5818.2 5841.6 5845.4 5847.6 5512.1 5733.7 5734.9 5799.6 5817.4 5505.5 5704.5 5762.7 5774.1 5785.2 5585.9 5709.7 5710.7 5716.7 5726.0 4850.0 4899.4 5042.3 5060.3 5068.6 23961.6 24122.9 24139.6 24344.4 24398.6 2382.2 2431.8 2503.8 2689.8 2843.5 14475.7 14915.7 15084.6 15578.4 15605.8 1714.6 1803.3 1839.4 1846.5 1902.2 104035.0 106514.5 111618.0 111674.0 112806.0 11396.9 11640.8 11682.3 11728.2 11797.6 14451.6 14536.9 14542.6 14574.4 14590.3 8231.6 8336.6 8488.3 8533.0 8540.6 6785.8 7199.3 8200.5 8210.2 8226.4 3895.2 4504.3 4564.7 4564.9 4582.1 1934.4 1966.0 1998.7 2012.3 2023.2 848.9 883.1 935.2 937.3 1005.4 19456.4 20364.2 20370.9 20415.4 20466.9 951.9 955.0 962.6 964.9 1007.8 10913.7 11182.4 11190.6 11264.3 11264.9 585018.0 593689.0 605920.0 608146.0 609465.0 114533.9 114870.0 124898.8 128181.4 131061.0 904.2 929.4 963.4 981.3 1006.5 13605.0 17908.8 18094.6 18657.4 18830.6 36876.3 48040.8 50970.5 54361.7 55035.0 81126.0 82358.0 84397.6 85678.0 87164.7 7711.7 7875.2 7940.2 8123.0 8233.0 9036.1 12145.3 12301.6 12313.4 12556.9 10178.4 10380.5 10547.6 10907.8 11031.3 9984.4 10344.8 10647.1 10802.6 10960.8 10075.8 10949.7 11023.6 11138.3 11437.9 6703.8 7498.4 8030.0 8084.2 8198.5 9860.8 10728.9 10845.8 10846.3 11126.3 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | [#3] mootools.html Cycles:180 Average:5400.55 Median:5025.53 stddev:2950.97 (58.7%) stddev-sans-first:2942.91 08:35:40 INFO - PROCESS | 7304 | Values: 1269.1 1337.3 1458.9 1771.2 1775.3 7543.0 7720.5 7989.4 8459.7 8486.6 8004.3 8273.0 8298.0 8406.3 8427.9 2275.6 2310.3 2321.0 2325.1 2329.4 2321.7 2352.1 2355.9 2356.5 2373.8 2302.2 2310.8 2331.0 2337.6 2337.8 2296.9 2297.1 2313.6 2319.4 2323.3 2325.3 2337.5 2346.5 2346.7 2357.3 6837.7 8323.1 8325.5 8367.1 8424.3 5022.9 5169.9 5194.8 5201.9 5210.6 3251.5 3304.3 3377.0 3567.2 3569.6 1030.3 1065.4 1087.5 1097.6 1112.8 10701.6 10909.1 10915.3 10984.5 11005.9 4476.7 4616.4 4700.8 4701.6 4726.2 9357.3 9434.9 9436.5 9440.8 9450.3 5080.6 5197.8 5198.2 5204.3 5204.8 4264.1 4264.5 4691.7 4767.3 4770.9 3164.4 3783.8 3882.2 3899.6 3945.3 1259.6 1265.1 1269.6 1274.0 1281.0 871.0 891.4 894.5 907.9 909.3 5372.2 5540.1 5554.0 5624.2 5723.4 936.9 953.3 991.5 1003.5 1014.1 3691.9 3742.4 3757.5 3765.7 3780.9 7891.8 9865.4 10344.4 10355.3 10378.8 10304.3 10311.2 10311.3 10318.8 10321.4 7773.1 7904.8 7914.3 7935.8 7940.6 4953.7 5513.4 5618.9 5713.6 5773.2 7637.5 9314.3 9320.0 9433.5 9523.7 8324.3 8947.2 9430.6 9441.4 9446.9 6592.6 6830.6 7038.7 7179.2 7365.8 7714.7 7720.0 7782.6 7872.8 7882.8 5779.7 6952.9 7058.3 7088.9 7210.0 6904.7 6951.9 6959.0 6983.7 6991.8 5469.2 6622.2 6749.8 6774.2 6782.2 4448.0 4825.5 4842.4 4861.5 4878.5 4732.5 4780.5 4802.7 4960.0 5028.1 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | [#4] prototype.html Cycles:180 Average:4536.30 Median:5054.01 stddev:1414.65 (28.0%) stddev-sans-first:1381.97 08:35:40 INFO - PROCESS | 7304 | Values: 273.6 300.8 305.1 307.0 311.8 4829.9 5146.6 5365.0 5484.1 5540.3 4411.8 4888.4 5050.5 5290.5 5359.3 4142.8 4146.0 4157.7 4180.7 4185.6 3948.8 4147.3 4147.4 4154.6 4159.7 4081.9 4093.5 4104.5 4112.2 4117.9 4095.9 4097.5 4100.8 4110.2 4131.8 3573.0 3580.5 3582.7 3582.8 3591.9 4354.1 4565.9 5057.5 5161.7 5211.4 4102.3 4371.5 4607.7 4629.6 4631.7 5473.5 5629.4 5640.3 5670.9 5673.9 3432.1 3501.4 3572.8 3781.7 3829.6 4982.7 5948.5 5984.5 5997.1 6008.5 3262.9 3414.2 3900.8 3917.0 3931.9 3002.8 3634.5 3968.9 3970.9 3976.6 3849.9 4622.3 4646.3 4659.3 4661.1 5335.5 5629.7 5703.7 5735.9 5873.5 1024.6 1224.4 1243.6 1256.8 1269.5 735.9 805.0 869.4 869.6 879.3 4452.3 4833.9 4941.6 5073.3 5111.5 5355.8 5631.6 5632.7 5633.8 5707.5 4156.4 4705.7 4777.7 5082.1 5123.2 2597.9 2857.7 2904.5 2946.4 2975.6 4995.8 5035.8 5535.9 5674.7 5881.5 5229.9 5275.5 5314.8 5595.2 5770.9 5578.4 5663.9 5674.3 5680.8 5810.7 4428.8 5171.8 5566.6 5580.9 5652.7 4604.7 5408.9 5507.0 5596.6 5896.9 5087.3 6204.3 6214.7 6216.8 6239.8 3636.3 3932.5 3939.9 3956.2 3971.2 5505.5 5856.3 5899.5 5925.5 5950.3 4813.2 5530.5 5595.2 5699.9 5819.6 5744.3 5752.3 5760.5 5782.7 5792.9 4643.3 5375.7 5584.8 5673.9 5740.5 4810.8 5745.8 5764.3 5804.0 5812.6 4830.8 5159.7 5739.6 5747.1 5750.5 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - PROCESS | 7304 | [#5] yui.html Cycles:180 Average:20045.24 Median:54851.09 stddev:29902.09 (54.5%) stddev-sans-first:29950.58 08:35:40 INFO - PROCESS | 7304 | Values: 668.3 680.9 713.1 744.0 755.2 13312.7 13720.2 13924.4 14789.2 14855.9 13109.9 13118.1 13119.7 13253.9 13261.9 631.0 652.9 655.6 784.9 813.8 817.8 818.1 820.9 821.4 822.4 850.6 858.9 860.3 864.9 865.0 836.7 847.1 856.0 857.7 858.3 635.2 644.3 645.2 645.2 645.6 13759.2 14074.6 14114.2 14145.4 14382.7 12029.8 12194.9 12986.1 13152.5 13212.1 10897.9 11253.9 11329.1 11368.0 11647.4 3019.0 3579.9 3670.9 3672.5 3674.6 81957.6 82333.6 83189.3 83409.2 84978.0 6801.8 7871.9 7873.1 7907.9 7917.7 20664.5 20957.5 20969.0 21058.5 21284.3 7383.0 7405.3 7415.9 7490.9 7516.4 4038.9 4132.2 4141.8 4181.5 4189.0 3355.2 3480.4 3484.1 3485.4 3490.6 566.9 603.9 636.7 649.9 656.8 512.8 606.4 632.2 639.5 650.2 8568.7 8582.7 8672.1 8868.5 8973.1 552.8 625.8 626.4 626.8 629.6 3468.5 4339.7 4355.8 4372.5 4458.2 76862.0 95946.5 124595.4 124901.0 125120.0 99801.5 103182.0 105916.0 106087.0 108253.0 68936.0 70089.6 71466.3 74980.6 83173.6 8874.3 9302.6 9391.5 9451.3 9523.9 52489.7 54750.5 54809.7 54892.5 54962.7 62491.1 64262.9 71953.0 77890.0 80245.6 11795.2 11906.0 12200.9 12218.4 12384.8 13430.0 13554.7 13643.9 13660.5 13793.7 12380.9 12510.7 12715.2 12733.3 12951.8 12309.4 12553.2 12649.5 12698.8 12998.4 12088.3 12447.0 12557.6 12594.6 12965.5 8679.7 9304.0 9309.3 9318.5 9614.6 10534.4 10634.8 10740.2 10860.3 10960.3 08:35:40 INFO - PROCESS | 7304 | -------- Summary: end -------- 08:35:40 INFO - PROCESS | 7304 | 08:35:40 INFO - TEST-INFO | 7304: exit 0 08:35:40 INFO - TEST-OK | dromaeo_css | took 1115540ms 08:35:40 INFO - TEST-START | kraken 08:35:40 INFO - operating with platform_type : mac_ 08:35:40 INFO - Initialising browser for kraken test... 08:35:40 INFO - TEST-INFO | started process 7313 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpcyfftx/profile http://localhost:60170/getInfo.html) 08:35:43 INFO - PROCESS | 7313 | 2017-01-19 08:35:43.882 plugin-container[7314:136694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8637, name = 'com.apple.tsm.portname' 08:35:43 INFO - PROCESS | 7313 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:35:43 INFO - PROCESS | 7313 | 2017-01-19 08:35:43.885 plugin-container[7314:136694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880b, name = 'com.apple.CFPasteboardClient' 08:35:43 INFO - PROCESS | 7313 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:35:43 INFO - PROCESS | 7313 | 2017-01-19 08:35:43.885 plugin-container[7314:136694] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:35:43 INFO - PROCESS | 7313 | __metrics Screen width/height:1600/1200 08:35:43 INFO - PROCESS | 7313 | colorDepth:24 08:35:43 INFO - PROCESS | 7313 | Browser inner width/height: 1024/689 08:35:43 INFO - PROCESS | 7313 | __metrics 08:35:44 ERROR - PROCESS | 7313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:35:44 INFO - TEST-INFO | 7313: exit 0 08:35:44 INFO - Browser initialized. 08:35:44 INFO - Running cycle 1/1 for kraken test... 08:35:44 INFO - TEST-INFO | started process 7315 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpcyfftx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:47 INFO - PROCESS | 7315 | 2017-01-19 08:35:47.534 plugin-container[7316:136813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 08:35:47 INFO - PROCESS | 7315 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:35:47 INFO - PROCESS | 7315 | 2017-01-19 08:35:47.535 plugin-container[7316:136813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 08:35:47 INFO - PROCESS | 7315 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:35:47 INFO - PROCESS | 7315 | 2017-01-19 08:35:47.535 plugin-container[7316:136813] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:35:57 INFO - PROCESS | 7315 | RSS: Main: 232132608 08:35:57 INFO - PROCESS | 7315 | 08:36:00 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60170/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:01 INFO - PROCESS | 7315 | RSS: Main: 244666368 08:36:01 INFO - PROCESS | 7315 | 08:36:03 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60170/tests/kraken/driver.html?testName=audio-dft) 08:36:04 INFO - PROCESS | 7315 | RSS: Main: 252817408 08:36:04 INFO - PROCESS | 7315 | 08:36:07 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60170/tests/kraken/driver.html?testName=audio-fft) 08:36:08 INFO - PROCESS | 7315 | RSS: Main: 256516096 08:36:08 INFO - PROCESS | 7315 | 08:36:10 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60170/tests/kraken/driver.html?testName=audio-oscillator) 08:36:11 INFO - PROCESS | 7315 | RSS: Main: 257916928 08:36:11 INFO - PROCESS | 7315 | 08:36:13 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:13 INFO - PROCESS | 7315 | RSS: Main: 257957888 08:36:13 INFO - PROCESS | 7315 | 08:36:16 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60170/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:17 INFO - PROCESS | 7315 | RSS: Main: 261984256 08:36:17 INFO - PROCESS | 7315 | 08:36:20 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60170/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:20 INFO - PROCESS | 7315 | RSS: Main: 261644288 08:36:20 INFO - PROCESS | 7315 | 08:36:23 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60170/tests/kraken/driver.html?testName=json-parse-financial) 08:36:24 INFO - PROCESS | 7315 | RSS: Main: 261664768 08:36:24 INFO - PROCESS | 7315 | 08:36:25 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:26 INFO - PROCESS | 7315 | RSS: Main: 260919296 08:36:26 INFO - PROCESS | 7315 | 08:36:28 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:29 INFO - PROCESS | 7315 | RSS: Main: 261042176 08:36:29 INFO - PROCESS | 7315 | 08:36:31 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:32 INFO - PROCESS | 7315 | RSS: Main: 260775936 08:36:32 INFO - PROCESS | 7315 | 08:36:35 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:35 INFO - PROCESS | 7315 | RSS: Main: 260743168 08:36:35 INFO - PROCESS | 7315 | 08:36:38 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:39 INFO - PROCESS | 7315 | RSS: Main: 260898816 08:36:39 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | Cycle 1(1): loaded http://localhost:60170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60170/tests/kraken/driver.html?testName=ai-astar) 08:36:41 INFO - PROCESS | 7315 | RSS: Main: 262918144 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | __start_tp_report 08:36:41 INFO - PROCESS | 7315 | _x_x_mozilla_page_load 08:36:41 INFO - PROCESS | 7315 | _x_x_mozilla_page_load_details 08:36:41 INFO - PROCESS | 7315 | |i|pagename|runs| 08:36:41 INFO - PROCESS | 7315 | |0;ai-astar;102;104;171;187;161;120;123;174;173;120 08:36:41 INFO - PROCESS | 7315 | |1;audio-beat-detection;147;112;112;145;113;113;117;112;138;112 08:36:41 INFO - PROCESS | 7315 | |2;audio-dft;197;203;232;287;201;198;200;199;199;201 08:36:41 INFO - PROCESS | 7315 | |3;audio-fft;85;58;60;89;60;68;85;86;107;82 08:36:41 INFO - PROCESS | 7315 | |4;audio-oscillator;87;72;91;73;69;67;88;70;71;89 08:36:41 INFO - PROCESS | 7315 | |5;imaging-gaussian-blur;90;76;137;131;89;87;91;87;89;86 08:36:41 INFO - PROCESS | 7315 | |6;imaging-darkroom;99;95;95;96;96;95;96;96;96;95 08:36:41 INFO - PROCESS | 7315 | |7;imaging-desaturate;88;82;133;136;89;85;89;93;89;93 08:36:41 INFO - PROCESS | 7315 | |8;json-parse-financial;58;57;56;58;62;63;60;61;60;60 08:36:41 INFO - PROCESS | 7315 | |9;json-stringify-tinderbox;68;73;79;83;77;75;75;74;65;90 08:36:41 INFO - PROCESS | 7315 | |10;stanford-crypto-aes;85;101;110;108;85;86;86;85;82;92 08:36:41 INFO - PROCESS | 7315 | |11;stanford-crypto-ccm;134;162;142;147;161;157;159;159;191;152 08:36:41 INFO - PROCESS | 7315 | |12;stanford-crypto-pbkdf2;167;170;171;167;171;167;170;170;166;170 08:36:41 INFO - PROCESS | 7315 | |13;stanford-crypto-sha256-iterative;58;83;92;68;64;85;93;90;61;79 08:36:41 INFO - PROCESS | 7315 | __end_tp_report 08:36:41 INFO - PROCESS | 7315 | __start_cc_report 08:36:41 INFO - PROCESS | 7315 | _x_x_mozilla_cycle_collect,962 08:36:41 INFO - PROCESS | 7315 | __end_cc_report 08:36:41 INFO - PROCESS | 7315 | __startTimestamp1484843801489__endTimestamp 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | ------- Summary: start ------- 08:36:41 INFO - PROCESS | 7315 | Number of tests: 14 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#0] ai-astar Cycles:10 Average:143.50 Median:166.00 stddev:32.60 (19.6%) stddev-sans-first:30.92 08:36:41 INFO - PROCESS | 7315 | Values: 102.0 104.0 171.0 187.0 161.0 120.0 123.0 174.0 173.0 120.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:115.00 stddev:14.90 (13.0%) stddev-sans-first:12.79 08:36:41 INFO - PROCESS | 7315 | Values: 147.0 112.0 112.0 145.0 113.0 113.0 117.0 112.0 138.0 112.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#2] audio-dft Cycles:10 Average:211.70 Median:201.00 stddev:28.38 (14.1%) stddev-sans-first:29.60 08:36:41 INFO - PROCESS | 7315 | Values: 197.0 203.0 232.0 287.0 201.0 198.0 200.0 199.0 199.0 201.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#3] audio-fft Cycles:10 Average:78.00 Median:83.50 stddev:15.94 (19.1%) stddev-sans-first:16.71 08:36:41 INFO - PROCESS | 7315 | Values: 85.0 58.0 60.0 89.0 60.0 68.0 85.0 86.0 107.0 82.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:80.00 stddev:9.70 (12.1%) stddev-sans-first:9.68 08:36:41 INFO - PROCESS | 7315 | Values: 87.0 72.0 91.0 73.0 69.0 67.0 88.0 70.0 71.0 89.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.00 stddev:20.35 (23.1%) stddev-sans-first:21.45 08:36:41 INFO - PROCESS | 7315 | Values: 90.0 76.0 137.0 131.0 89.0 87.0 91.0 87.0 89.0 86.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:0.53 08:36:41 INFO - PROCESS | 7315 | Values: 99.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:89.00 stddev:19.68 (22.1%) stddev-sans-first:20.56 08:36:41 INFO - PROCESS | 7315 | Values: 88.0 82.0 133.0 136.0 89.0 85.0 89.0 93.0 89.0 93.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.00 stddev:2.22 (3.7%) stddev-sans-first:2.29 08:36:41 INFO - PROCESS | 7315 | Values: 58.0 57.0 56.0 58.0 62.0 63.0 60.0 61.0 60.0 60.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:76.00 stddev:7.11 (9.4%) stddev-sans-first:6.94 08:36:41 INFO - PROCESS | 7315 | Values: 68.0 73.0 79.0 83.0 77.0 75.0 75.0 74.0 65.0 90.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:85.00 stddev:10.43 (12.3%) stddev-sans-first:10.76 08:36:41 INFO - PROCESS | 7315 | Values: 85.0 101.0 110.0 108.0 85.0 86.0 86.0 85.0 82.0 92.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:159.00 stddev:15.20 (9.6%) stddev-sans-first:13.80 08:36:41 INFO - PROCESS | 7315 | Values: 134.0 162.0 142.0 147.0 161.0 157.0 159.0 159.0 191.0 152.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:170.00 stddev:1.91 (1.1%) stddev-sans-first:1.90 08:36:41 INFO - PROCESS | 7315 | Values: 167.0 170.0 171.0 167.0 171.0 167.0 170.0 170.0 166.0 170.0 08:36:41 INFO - PROCESS | 7315 | 08:36:41 INFO - PROCESS | 7315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:84.00 stddev:13.42 (16.0%) stddev-sans-first:12.28 08:36:41 INFO - PROCESS | 7315 | Values: 58.0 83.0 92.0 68.0 64.0 85.0 93.0 90.0 61.0 79.0 08:36:41 INFO - PROCESS | 7315 | -------- Summary: end -------- 08:36:41 INFO - PROCESS | 7315 | 08:36:42 INFO - TEST-INFO | 7315: exit 0 08:36:42 INFO - TEST-OK | kraken | took 61889ms 08:36:42 INFO - SUITE-END | took 1177s 08:36:42 INFO - Completed test suite (00:19:37) 08:36:42 INFO - javascript benchmark 08:36:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7126.059831985946, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2730.918072457827, 3272.3782481328562, 3288.4574045282516, 3298.3733090712763, 3340.2985373071656, 5636.633618814779, 5643.971780141099, 5687.232223649806, 5717.3139223293265, 5720.79977200798, 5634.295713035871, 5713.114467257571, 5730.111832665933, 5745.253117094772, 5790.478856902878, 5173.249878767577, 5212.504812042869, 5227.86930326743, 5233.607479439057, 5272.762725677354, 5279.973600131994, 5285.207218917174, 5303.761330740126, 5336.839894803162, 5345.064613692608, 5159.200323949775, 5166.896662066756, 5290.814821481249, 5308.9469105308835, 5347.064263753847, 5228.47715228476, 5233.3981592116825, 5310.575153987672, 5336.959292937879, 5341.4658534146665, 5183.870403239912, 5238.030964271622, 5248.816291429782, 5255.0, 5265.235356719925, 4437.245668236407, 5503.669779813224, 5584.21820945068, 5672.290963629546, 5695.515881150107, 6078.544109191784, 6135.478484328837, 6139.907901381483, 6145.446909778141, 6152.415520525587, 6115.088229002391, 6180.81457556274, 6181.474574661159, 6193.1639228704, 6193.2877719062435, 5784.913226301609, 5796.304443466769, 5818.4763371296785, 5826.912596311059, 5841.47426731592, 6113.780377411019, 6178.289496707846, 6204.945159322926, 6241.78153764616, 6336.17629708135, 4968.677035992649, 6042.244719410074, 6105.664188469676, 6131.754729810757, 6142.600730952474, 6178.165947597106, 6191.566590338633, 6194.628322300677, 6201.596896201822, 6211.0, 5986.161937328778, 6066.575339726177, 6154.353792851775, 6163.660998645118, 6218.751249950042, 4527.932081018787, 4956.727379994063, 5979.551533634908, 6011.699415029231, 6089.969550152221, 4804.0872234275375, 4812.590929771009, 4816.759162041954, 4823.782929768169, 4857.975710121497, 4298.871033868989, 4317.057324204058, 4318.654507639381, 4342.41377414045, 4347.478302603645, 5106.46382129871, 5219.634625576249, 5613.073842815889, 5745.770169193269, 5908.822735317947, 6095.634261944298, 6145.846353841101, 6166.414190651971, 6186.226721659793, 6187.597806142587, 5626.24045753818, 5664.348599910981, 5819.098039803837, 5827.79602713903, 5866.882662346815, 5327.493888080626, 5373.623846330797, 5380.757865896044, 5423.322084739408, 5445.863853403696, 6281.59169653971, 6287.748490060347, 6290.2766181889665, 6297.622142671455, 6341.0, 5978.97010514962, 6162.969185154046, 6191.226096737908, 6200.0, 6204.472619827366, 6159.692015399301, 6170.413810687977, 6211.81364559064, 6212.378762123933, 6251.0, 6160.476359509492, 6166.2600487939935, 6169.259688837368, 6172.814815555541, 6175.9073613894925, 5229.215617657382, 6196.721147548461, 6202.069689546604, 6205.782797602063, 6209.937900620936, 5907.409259074058, 5971.373005834324, 6001.129836173643, 6009.489193418608, 6060.212172417558, 6043.7884674036195, 6101.877962440815, 6108.038540470994, 6109.480694141048, 6115.818436018264, 4981.277714731416, 5947.345791962967, 5961.0, 5965.403459654, 5984.581079324405, 5803.3616302207565, 5903.940960590511, 5954.970225148846, 6021.096835474538, 6068.575199736153, 5866.5893387462465, 5912.881742365214, 5949.940500594938, 5951.285845698544, 5969.76120955157], "value": 5619.713163106443, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.2210109661929, 468.3045677169403, 479.69539342517504, 490.5437942713275, 524.2398522142894, 38752.80623596882, 40445.79777101114, 40687.79656101715, 40690.59309406909, 40720.77837664875, 41610.0, 42140.57859421405, 42241.310347586135, 42260.78869605648, 42275.36586951198, 9310.720678379643, 9487.193588544982, 9502.572384242725, 9502.619895204218, 9521.666741664043, 8247.134050924626, 9395.295352848529, 9461.0, 9477.857832132524, 9495.477748723852, 8123.796905077391, 9059.320550958704, 9538.189253913426, 9570.808583828319, 9588.52057397131, 7908.44640875139, 8344.749657510285, 9342.0, 9399.812003759887, 9548.0, 9345.299102567267, 9406.529673516297, 9419.24646028323, 9441.575129119137, 9448.244140468814, 39236.0, 39516.80241598802, 39994.80015599537, 40016.399754003716, 40028.39957400641, 3159.952600710991, 3275.3449310138067, 3310.4372256716415, 3331.816750078745, 3343.2477692518987, 28790.136295911158, 28886.0, 28943.71056289452, 29039.274018149503, 29198.85400573005, 3148.3231105312466, 3160.715535601807, 3329.500574913758, 3354.412977728912, 3361.5461912641726, 492960.0, 497884.0, 499515.0, 500660.4966975142, 503063.0, 60165.69917150386, 60516.69741651264, 60600.0, 60610.0, 60778.696106519186, 64046.35953640497, 64262.67868660627, 64385.35614643794, 64943.70112597722, 65081.0, 16191.433299834449, 16409.097499637395, 16469.176541172892, 16495.422660206834, 16568.585785355463, 12507.3746312684, 12647.683807904876, 12729.427175777113, 12736.872631273754, 12774.361281935866, 17246.482605521855, 18097.104034466898, 18815.247390104516, 18890.62218755617, 19094.904525477283, 3197.5683282756995, 7626.771196863992, 7902.328302094272, 7920.207979202034, 7960.721374751972, 848.8811566380712, 937.6202637931649, 940.6331530703031, 1068.4657671164418, 1077.7413420778958, 29525.0, 29691.85154074216, 29739.553906691417, 29891.40217195644, 30249.697503024687, 973.9123478886793, 1080.6109800471825, 1095.7863216672672, 1105.4086063955906, 1154.572808061023, 14972.925135374253, 15047.924760376129, 15220.391184352724, 15330.923345383202, 15342.463013794464, 689565.0, 691182.0, 697165.0, 698490.0, 699809.0, 57053.71473142691, 57655.0, 57702.0, 57763.71118144466, 57797.0, 1154.8152295632826, 1202.386782740791, 1304.7716649586284, 1334.4395353951363, 1359.136948038003, 28351.149465516068, 29108.27229319284, 29298.560521591768, 29464.705352946195, 29727.25681857971, 47597.52402475931, 49236.2614560789, 49429.50570494249, 49623.00753984972, 49623.751881240365, 515485.0, 518095.0, 518258.0, 519563.0, 519804.0, 21750.564988700455, 26225.688715564527, 26304.73695263023, 26596.867015664797, 26668.866655667374, 45251.7737411324, 45287.77356113198, 45834.0, 46677.76661116673, 47334.81662958454, 37740.05649858776, 37929.81035094807, 38006.0, 38073.80963095167, 39102.82691519259, 37664.62335376611, 37778.0, 37853.0, 38577.6142238574, 38969.80515097406, 31326.843365783025, 31960.36079278448, 36810.8159459201, 37298.6270137306, 37668.62331376761, 30854.382912342076, 34011.4898276531, 34130.0, 34236.82881585576, 34356.656433435346, 20874.895625521774, 25126.623100653138, 25185.748142519074, 25657.358566035997, 25716.48041232034], "value": 19571.086181093186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.9241174529858, 372.6962525541683, 379.9373103437933, 382.0601320750952, 400.4733775085762, 17762.111894405276, 18901.0, 19135.904320478414, 19554.217831286733, 19581.706274405897, 16067.91966040171, 19192.904035479838, 19489.610207795835, 19684.311049113247, 20106.59786804263, 5593.2449119368775, 5818.156367326735, 5841.591088623798, 5845.415458454163, 5847.5614328925285, 5512.145617429305, 5733.741981610838, 5734.942650573504, 5799.623024503394, 5817.418258174191, 5505.504504594585, 5704.458076482728, 5762.711864406784, 5774.133879918025, 5785.190073389707, 5585.8603534911745, 5709.714514274269, 5710.657360558359, 5716.685582292972, 5725.971370143144, 4850.0, 4899.363082799213, 5042.319286896259, 5060.316857224265, 5068.619853511002, 23961.640575391382, 24122.879385603133, 24139.63790543143, 24344.39139021521, 24398.634020489706, 2382.1662418153683, 2431.756824317572, 2503.7996960243136, 2689.784817214618, 2843.502387082273, 14475.71048579033, 14915.701685966329, 15084.622884427978, 15578.376864925389, 15605.765913511306, 1714.6484970581, 1803.332766876251, 1839.3562253211403, 1846.4922146409845, 1902.1915685833465, 104035.0, 106514.46742766314, 111618.0, 111674.0, 112806.0, 11396.886031139748, 11640.825387619192, 11682.299062056303, 11728.237664551776, 11797.587084452174, 14451.566453006426, 14536.927315363355, 14542.563723088324, 14574.41702331916, 14590.343434545472, 8231.6417791065, 8336.62485188156, 8488.320934325238, 8532.957335213285, 8540.615672294762, 6785.762498312634, 7199.280071992864, 8200.466969646954, 8210.178982101743, 8226.42415030954, 3895.240428116547, 4504.301833215857, 4564.748938808398, 4564.908701825945, 4582.075528278065, 1934.429343343717, 1966.0, 1998.7401637786995, 2012.2554654777825, 2023.2311721546014, 848.8811566380712, 883.1433509495779, 935.158357478275, 937.315759495572, 1005.4319309590059, 19456.416307510797, 20364.18543258253, 20370.898145509473, 20415.387538373874, 20466.897665511577, 951.9048095190426, 954.9761255968517, 962.5860879821604, 964.9228061755043, 1007.8337074382645, 10913.727156820984, 11182.440877956233, 11190.552377904793, 11264.324140551429, 11264.94367528157, 585018.0, 593689.0, 605920.0, 608146.0, 609465.0, 114533.85466145232, 114870.0, 124898.75101249052, 128181.3590932058, 131061.0, 904.1591320072264, 929.4284015330658, 963.4123184857232, 981.2787601113176, 1006.5269323418128, 13605.0, 17908.83592566479, 18094.638107238046, 18657.440276791716, 18830.623387531898, 36876.26247475089, 48040.75979620079, 50970.49029509806, 54361.72819135879, 55035.0, 81126.0, 82358.0, 84397.57801210954, 85678.0, 87164.69252961084, 7711.730089446843, 7875.173106823701, 7940.205979402013, 8122.959385203036, 8233.0, 9036.05121462237, 12145.271283723005, 12301.630951071482, 12313.44589493457, 12556.937215313865, 10178.389296642225, 10380.532876020447, 10547.57809687604, 10907.78184436291, 11031.338119712844, 9984.400935943866, 10344.793104138025, 10647.094996925349, 10802.567897284021, 10960.835587466036, 10075.798484030132, 10949.671509854717, 11023.559057637605, 11138.27601205919, 11437.942810285895, 6703.765368212089, 7498.362639175732, 8030.0, 8084.231997960184, 8198.508089514648, 9860.753481162741, 10728.89271107279, 10845.837312440477, 10846.29499082557, 11126.332420054823], "value": 9439.457947609384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.1243042300812, 1337.2912356451081, 1458.8687018168362, 1771.220662908321, 1775.3253763569849, 7542.962285188566, 7720.498167619101, 7989.440739148255, 8459.661613535467, 8486.575671216438, 8004.319632831216, 8273.007239131297, 8298.045724741642, 8406.327493800496, 8427.91572084279, 2275.590393729128, 2310.2838120182714, 2321.025169428844, 2325.104834638659, 2329.3827135809024, 2321.7330007049236, 2352.0591763294733, 2355.8704271265074, 2356.528694261146, 2373.774491423312, 2302.194232018797, 2310.780475854791, 2330.9650355244685, 2337.567550003246, 2337.777911098443, 2296.942576435594, 2297.127091705158, 2313.64138558522, 2319.3621754017695, 2323.2565579014636, 2325.302409277227, 2337.4506990857135, 2346.4720437901506, 2346.6597343385115, 2357.328161473989, 6837.692303846339, 8323.12607176244, 8325.458845175044, 8367.079621241719, 8424.283935865458, 5022.924656130161, 5169.870753231162, 5194.792208311663, 5201.869953251199, 5210.557102646279, 3251.5122731590213, 3304.3060957198777, 3376.9831150844334, 3567.23304489536, 3569.6430356964356, 1030.319988807391, 1065.350136416785, 1087.5323610847333, 1097.5664612478026, 1112.7718817642365, 10701.571937122584, 10909.127269818475, 10915.290506117157, 10984.505697243643, 11005.889941100566, 4476.686631935733, 4616.399868017136, 4700.764961751899, 4701.576858082789, 4726.220173671374, 9357.298202634693, 9434.90565094354, 9436.528173591292, 9440.763980900532, 9450.33847630673, 5080.644354895196, 5197.792088316425, 5198.16829307309, 5204.271402003723, 5204.8178313758835, 4264.0832221072615, 4264.509581398117, 4691.7184968901975, 4767.261074533453, 4770.904581908342, 3164.351307981858, 3783.848646054127, 3882.165334453106, 3899.5515515716056, 3945.309570825094, 1259.5843371687322, 1265.0891358222066, 1269.5683467621054, 1273.9681507962189, 1280.961571152867, 870.9825803483894, 891.4072142025481, 894.5169608411516, 907.8547432410783, 909.3407279722148, 5372.167314066326, 5540.113581826889, 5554.0, 5624.156376543469, 5723.399043100498, 936.8875734911718, 953.2936044480302, 991.5438898106808, 1003.5484032185545, 1014.1075853249093, 3691.9077023074638, 3742.36379815432, 3757.4739536464917, 3765.6799172070682, 3780.9432858507143, 7891.842163156704, 9865.408075515492, 10344.431056291825, 10355.275130740927, 10378.844317335246, 10304.278700490893, 10311.22665800068, 10311.278210525341, 10318.793624127626, 10321.380717156844, 7773.106092799288, 7904.762857114296, 7914.327282180964, 7935.801604959922, 7940.563269020259, 4953.72754498506, 5513.365962914316, 5618.89170015376, 5713.628614140068, 5773.220615216892, 7637.5035622684345, 9314.301427393108, 9320.0, 9433.52832358393, 9523.714288571355, 8324.334053275845, 8947.19475247231, 9430.62277508892, 9441.386309889835, 9446.85829712541, 6592.637404942774, 6830.556013859282, 7038.718451261892, 7179.210286868336, 7365.8158546036775, 7714.691412343668, 7719.996400468128, 7782.649780759766, 7872.84254314922, 7882.842343153219, 5779.682117483579, 6952.930470695228, 7058.294170582901, 7088.929110709033, 7210.0, 6904.723811047502, 6951.895721564079, 6959.0, 6983.720651173896, 6991.825204369931, 5469.234307197075, 6622.1722284714415, 6749.797506074826, 6774.187097548129, 6782.152230971129, 4447.977760111179, 4825.5174482551465, 4842.4189097308545, 4861.465238823797, 4878.536539028786, 4732.47942726293, 4780.545848144421, 4802.687825291345, 4960.032793605213, 5028.145215313332], "value": 4400.001012804371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.6360640348337, 300.7879444991281, 305.05585213763396, 306.952422374532, 311.81758671177363, 4829.913269514357, 5146.588272938166, 5365.0, 5484.122540393538, 5540.254819731782, 4411.757353345564, 4888.364512613364, 5050.545450909417, 5290.497402746733, 5359.330083739533, 4142.834286628531, 4145.958540414603, 4157.6695457453625, 4180.686448516358, 4185.623293903555, 3948.802559871995, 4147.274227010276, 4147.398627199054, 4154.584541545852, 4159.688023398257, 4081.9183616327655, 4093.5087789465306, 4104.526066587419, 4112.239235741383, 4117.949922769704, 4095.85664501744, 4097.508299004109, 4100.815463304159, 4110.177964407116, 4131.814068366931, 3573.0352804742834, 3580.534530511043, 3582.7133829293593, 3582.802945837978, 3591.892243232707, 4354.063876266618, 4565.931511027337, 5057.468965758616, 5161.74191290434, 5211.42674305826, 4102.2821006324075, 4371.4972778130605, 4607.7004994675235, 4629.606483448911, 4631.734627087895, 5473.467429119853, 5629.380768115504, 5640.323161220639, 5670.886582268332, 5673.914891276634, 3432.129489428268, 3501.3872572299747, 3572.821358932069, 3781.735278530504, 3829.5596006459336, 4982.701037937735, 5948.464638182584, 5984.521238300969, 5997.100434934795, 6008.519318454513, 3262.918427039343, 3414.163529935132, 3900.7659540427667, 3916.980415097906, 3931.8820435386983, 3002.774791890617, 3634.47300141478, 3968.900777480586, 3970.920581588352, 3976.602339766, 3849.8845034649007, 4622.260438329851, 4646.3495110684535, 4659.277811939155, 4661.114388266218, 5335.519803217651, 5629.678489691102, 5703.74333155009, 5735.910177066344, 5873.471387575053, 1024.5707238402388, 1224.4184012594126, 1243.5574733309318, 1256.8428946381703, 1269.549309994957, 735.9116905971317, 804.9937578027466, 869.4218344800637, 869.5999840073637, 879.2614204068485, 4452.287633978548, 4833.9033219335415, 4941.555260026543, 5073.34046573943, 5111.463296353903, 5355.785768569213, 5631.605787594911, 5632.662040277596, 5633.8309850704545, 5707.514861236758, 4156.43888075112, 4705.717656940595, 4777.713337199779, 5082.1196157421255, 5123.180291153472, 2597.8830952607177, 2857.6856545779947, 2904.533210728611, 2946.42544703785, 2975.642922849229, 4995.825146119869, 5035.823746168867, 5535.944640553543, 5674.716264186856, 5881.470667639847, 5229.921551176735, 5275.525202731696, 5314.7608357624, 5595.244641973363, 5770.855728606818, 5578.442155784389, 5663.915041274384, 5674.319081710139, 5680.796210804058, 5810.651360918274, 4428.844990425319, 5171.776136261444, 5566.6381685191955, 5580.916286255629, 5652.710652185871, 4604.677672562889, 5408.945910540844, 5507.0, 5596.636218645938, 5896.852578685395, 5087.3386459759995, 6204.317525072329, 6214.658193799384, 6216.751329946932, 6239.75040998355, 3636.254567813539, 3932.5477570079806, 3939.881803545898, 3956.169204467094, 3971.2057588481844, 5505.532029777513, 5856.297244330537, 5899.528037756883, 5925.525957923442, 5950.256217972754, 4813.181759100891, 5530.451473587402, 5595.209532949417, 5699.8860022800145, 5819.592628516132, 5744.310682717934, 5752.28096487939, 5760.539156867524, 5782.681952492485, 5792.914550761807, 4643.2802915548145, 5375.731213439391, 5584.804531841366, 5673.893590749764, 5740.483356497935, 4810.807567697393, 5745.787871669521, 5764.308283006066, 5803.970980145241, 5812.622179558315, 4830.7826147824135, 5159.652358176945, 5739.62692424991, 5747.051736463437, 5750.511206547323], "value": 4074.3807336755567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.3316683316683, 680.897865320202, 713.1442269276869, 743.9696021010898, 755.2183490087758, 13312.668733126695, 13720.245386503739, 13924.443022279096, 14789.186594737284, 14855.851441485582, 13109.934450327735, 13118.081734278581, 13119.737605247888, 13253.933730331359, 13261.933690331534, 631.0439683878927, 652.9118568993197, 655.6361219523163, 784.9293563579276, 813.8128230506987, 817.8486979908736, 818.1327792539927, 820.9466384684977, 821.4455242711146, 822.4366309078271, 850.5747126436781, 858.8582883824162, 860.27736701171, 864.9264812490945, 864.9524276164808, 836.7489753074115, 847.1063028504925, 855.9871601925976, 857.7341024282492, 858.3347905373323, 635.1933045032782, 644.2591020326615, 645.1548471502347, 645.2321737132797, 645.635216102905, 13759.243241621707, 14074.648133796634, 14114.153150810984, 14145.434182632682, 14382.712345753027, 12029.81955270663, 12194.939025304906, 12986.090973631755, 13152.539661111816, 13212.141210821266, 10897.945510272477, 11253.887461125365, 11329.09367250618, 11368.0, 11647.41762911851, 3018.9547156792664, 3579.946300805464, 3670.853165873362, 3672.485851980725, 3674.577423596294, 81957.59021204915, 82333.58833205856, 83189.3362132754, 83409.16590834074, 84978.0, 6801.761938332134, 7871.921280787119, 7873.094594121635, 7907.881381779278, 7917.722879699183, 20664.48338791542, 20957.476063098544, 20969.0, 21058.47353816167, 21284.255051073138, 7383.040204773452, 7405.333519983227, 7415.925840741632, 7490.85018299631, 7516.361109305661, 4038.919221615551, 4132.152908653718, 4141.811482348218, 4181.51912530063, 4188.958110418856, 3355.1612096975755, 3480.4257297545623, 3484.1463841358523, 3485.35520928629, 3490.5636795400574, 566.8662674650699, 603.8943184942617, 636.7325723196176, 649.8960166373357, 656.7734131724548, 512.8256392826457, 606.375433303698, 632.2349956552531, 639.4596565901899, 650.1710319342781, 8568.742937711879, 8582.65669373218, 8672.132786721277, 8868.512231827182, 8973.147550982647, 552.7899398228727, 625.7578706268055, 626.4111734969115, 626.8432891777056, 629.6442509981846, 3468.497067925137, 4339.652827773771, 4355.7822108894425, 4372.497162826252, 4458.175237581057, 76862.0, 95946.52026739821, 124595.3770231143, 124901.0, 125120.0, 99801.5029774554, 103182.0, 105916.0, 106087.0, 108253.0, 68936.0, 70089.64955175192, 71466.28533714596, 74980.62509687417, 83173.58413207895, 8874.29005679557, 9302.581383837609, 9391.530423478662, 9451.338406311492, 9523.857142143012, 52489.68775780636, 54750.45249547613, 54809.72595136999, 54892.45107548873, 54962.72518637541, 62491.12526624209, 64262.85897128312, 71953.0, 77890.0, 80245.59877200576, 11795.174337796272, 11906.0, 12200.87799122033, 12218.38908054576, 12384.75230495403, 13429.992750543553, 13554.661133471742, 13643.931780341034, 13660.453581857011, 13793.724125517232, 12380.876191238332, 12510.679727393908, 12715.173513721578, 12733.29966851832, 12951.805722913976, 12309.44607492647, 12553.246805191719, 12649.494020239088, 12698.761157317687, 12998.350082495648, 12088.274703517816, 12447.0, 12557.560485382968, 12594.622161334808, 12965.481380744664, 8679.652813887626, 9304.0, 9309.348345615741, 9318.48748318849, 9614.615415383307, 10534.42060686639, 10634.787304254027, 10740.248182627141, 10860.348379097279, 10960.342379457257], "value": 7034.924451856877, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 104.0, 171.0, 187.0, 161.0, 120.0, 123.0, 174.0, 173.0, 120.0], "value": 143.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 112.0, 145.0, 113.0, 113.0, 117.0, 112.0, 138.0, 112.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 232.0, 287.0, 201.0, 198.0, 200.0, 199.0, 199.0, 201.0], "value": 211.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 58.0, 60.0, 89.0, 60.0, 68.0, 85.0, 86.0, 107.0, 82.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 91.0, 73.0, 69.0, 67.0, 88.0, 70.0, 71.0, 89.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 76.0, 137.0, 131.0, 89.0, 87.0, 91.0, 87.0, 89.0, 86.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 133.0, 136.0, 89.0, 85.0, 89.0, 93.0, 89.0, 93.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 58.0, 62.0, 63.0, 60.0, 61.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 79.0, 83.0, 77.0, 75.0, 75.0, 74.0, 65.0, 90.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 101.0, 110.0, 108.0, 85.0, 86.0, 86.0, 85.0, 82.0, 92.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 162.0, 142.0, 147.0, 161.0, 157.0, 159.0, 159.0, 191.0, 152.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 171.0, 167.0, 171.0, 167.0, 170.0, 170.0, 166.0, 170.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 83.0, 92.0, 68.0, 64.0, 85.0, 93.0, 90.0, 61.0, 79.0], "value": 77.3, "unit": "score"}]}]} 08:36:42 INFO - Return code: 0 08:36:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:42 ERROR - # TBPL SUCCESS # 08:36:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:42 INFO - 2017-01-19 08:36:42.808 screenresolution[7320:137210] starting screenresolution argv=screenresolution get 08:36:42 INFO - 2017-01-19 08:36:42.811 screenresolution[7320:137210] Display 0: 1600x1200x32@60 08:36:42 INFO - 2017-01-19 08:36:42.818 screenresolution[7321:137213] starting screenresolution argv=screenresolution list 08:36:42 INFO - Available Modes on Display 0 08:36:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:43 INFO - Intel Iris: 08:36:43 INFO - Chipset Model: Intel Iris 08:36:43 INFO - Type: GPU 08:36:43 INFO - Bus: Built-In 08:36:43 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:43 INFO - Vendor: Intel (0x8086) 08:36:43 INFO - Device ID: 0x0a2e 08:36:43 INFO - Revision ID: 0x0009 08:36:43 INFO - Displays: 08:36:43 INFO - Display: 08:36:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:43 INFO - Display Serial Number: 1600x1200 60 08:36:43 INFO - Main Display: Yes 08:36:43 INFO - Mirror: Off 08:36:43 INFO - Online: Yes 08:36:43 INFO - Rotation: Supported 08:36:43 INFO - Return code: 0 08:36:43 INFO - Running post-action listener: _resource_record_post_action 08:36:43 INFO - [mozharness: 2017-01-19 16:36:43.070170Z] Finished run-tests step (success) 08:36:43 INFO - Running post-run listener: _resource_record_post_run 08:36:43 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 3948544; Write bytes: 663935488; Read time: 44; Write time: 2139 08:36:43 INFO - TinderboxPrint: CPU usage
54.2% 08:36:43 INFO - TinderboxPrint: I/O read bytes / time
3,948,544 / 44 08:36:43 INFO - TinderboxPrint: I/O write bytes / time
663,935,488 / 2,139 08:36:43 INFO - TinderboxPrint: CPU idle
2,213.4 (45.8%) 08:36:43 INFO - TinderboxPrint: CPU system
979.3 (20.2%) 08:36:43 INFO - TinderboxPrint: CPU user
1,644.9 (34.0%) 08:36:43 INFO - TinderboxPrint: Swap in / out
358,682,624 / 0 08:36:43 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345223680; Write bytes: 346347008; Read time: 26759; Write time: 777 08:36:43 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 3948544; Write bytes: 310625280; Read time: 44; Write time: 1333 08:36:43 INFO - Running post-run listener: _upload_blobber_files 08:36:43 INFO - Blob upload gear active. 08:36:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:45 INFO - (blobuploader) - INFO - Done attempting. 08:36:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:36:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:46 INFO - (blobuploader) - INFO - Done attempting. 08:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:48 INFO - (blobuploader) - INFO - Done attempting. 08:36:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:48 INFO - Return code: 0 08:36:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50e17b38036e6573c5d5128eb716e22b84f56330cc319be896633445cb634f4b1f5f26657f683c801ab88240789995ff54c8ab7e0d08c0f3233fb85a20b0a491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89061a99090c11f052d3d6a60f63f0859dd3be7c78e0b7eb26c93ef1048bb0039f2f213fd1b702ce8809d299c89080a87b2ac7da0c0ca89881ab6b69696c6472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06a4b5fa405b2883a3387fce4e41bb16facd75013de439bd58dac72146d5b6b78a4c63b22fe00f2124f67aaed2613a17f9a8aba6af4b9fc55e5b6ba38aa95e"} 08:36:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:48 INFO - Contents: 08:36:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50e17b38036e6573c5d5128eb716e22b84f56330cc319be896633445cb634f4b1f5f26657f683c801ab88240789995ff54c8ab7e0d08c0f3233fb85a20b0a491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89061a99090c11f052d3d6a60f63f0859dd3be7c78e0b7eb26c93ef1048bb0039f2f213fd1b702ce8809d299c89080a87b2ac7da0c0ca89881ab6b69696c6472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06a4b5fa405b2883a3387fce4e41bb16facd75013de439bd58dac72146d5b6b78a4c63b22fe00f2124f67aaed2613a17f9a8aba6af4b9fc55e5b6ba38aa95e"} 08:36:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:48 INFO - Copying logs to upload dir... 08:36:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.562136 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-19 08:36:48.392477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 08:36:48.396094) ========= 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.uyt33kza1C/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.kH4liflMO3/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50e17b38036e6573c5d5128eb716e22b84f56330cc319be896633445cb634f4b1f5f26657f683c801ab88240789995ff54c8ab7e0d08c0f3233fb85a20b0a491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89061a99090c11f052d3d6a60f63f0859dd3be7c78e0b7eb26c93ef1048bb0039f2f213fd1b702ce8809d299c89080a87b2ac7da0c0ca89881ab6b69696c6472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06a4b5fa405b2883a3387fce4e41bb16facd75013de439bd58dac72146d5b6b78a4c63b22fe00f2124f67aaed2613a17f9a8aba6af4b9fc55e5b6ba38aa95e"} build_url:https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011700 build_url: 'https://queue.taskcluster.net/v1/task/V_J9WC2sSE2N8aey6Bwwnw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50e17b38036e6573c5d5128eb716e22b84f56330cc319be896633445cb634f4b1f5f26657f683c801ab88240789995ff54c8ab7e0d08c0f3233fb85a20b0a491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89061a99090c11f052d3d6a60f63f0859dd3be7c78e0b7eb26c93ef1048bb0039f2f213fd1b702ce8809d299c89080a87b2ac7da0c0ca89881ab6b69696c6472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06a4b5fa405b2883a3387fce4e41bb16facd75013de439bd58dac72146d5b6b78a4c63b22fe00f2124f67aaed2613a17f9a8aba6af4b9fc55e5b6ba38aa95e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 08:36:48.430123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:36:48.430432) ========= 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.uyt33kza1C/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.kH4liflMO3/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005632 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:36:48.483597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 08:36:48.483921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 08:36:48.484232) ========= ========= Total master_lag: 0.20 =========