builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0141 starttime: 1484494821.02 results: success (0) buildid: 20170115064323 builduid: 560ea1002ac544e6925e555e5a7fa2d6 revision: 3828f20e9bfab38345ff4da40bdb8222f5dcc842 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.022339) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.022841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.023124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.049022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.049315) ========= 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.1u90pwlYhn/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.oO2FqB18Gr/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-15 07:40:21-- 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% 8.43M=0.001s 2017-01-15 07:40:21 (8.43 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.250361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.250690) ========= 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.1u90pwlYhn/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.oO2FqB18Gr/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.019121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:21.298942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 07:40:21.299388) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3828f20e9bfab38345ff4da40bdb8222f5dcc842 --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 3828f20e9bfab38345ff4da40bdb8222f5dcc842 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1u90pwlYhn/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.oO2FqB18Gr/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-15 07:40:21,375 truncating revision to first 12 chars 2017-01-15 07:40:21,375 Setting DEBUG logging. 2017-01-15 07:40:21,375 attempt 1/10 2017-01-15 07:40:21,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3828f20e9bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 07:40:22,488 unpacking tar archive at: mozilla-aurora-3828f20e9bfa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 07:40:22.689341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:22.689696) ========= script_repo_revision: 3828f20e9bfab38345ff4da40bdb8222f5dcc842 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:22.690167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:22.690438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 07:40:22.710074) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-15 07:40:22.710384) ========= /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.1u90pwlYhn/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.oO2FqB18Gr/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:40:22 INFO - MultiFileLogger online at 20170115 07:40:22 in /builds/slave/test 07:40:22 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 07:40:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:40:22 INFO - {'append_to_log': False, 07:40:22 INFO - 'base_work_dir': '/builds/slave/test', 07:40:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:40:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:40:22 INFO - 'branch': 'Mozilla-Aurora', 07:40:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:40:22 INFO - 'config_files': ('talos/mac_config.py',), 07:40:22 INFO - 'default_actions': ('clobber', 07:40:22 INFO - 'read-buildbot-config', 07:40:22 INFO - 'download-and-extract', 07:40:22 INFO - 'populate-webroot', 07:40:22 INFO - 'create-virtualenv', 07:40:22 INFO - 'install', 07:40:22 INFO - 'run-tests'), 07:40:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:40:22 INFO - 'download_minidump_stackwalk': True, 07:40:22 INFO - 'download_symbols': 'ondemand', 07:40:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:40:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:40:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:40:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:40:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:40:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:40:22 INFO - 'installer_path': 'installer.exe', 07:40:22 INFO - 'log_level': 'info', 07:40:22 INFO - 'log_name': 'talos', 07:40:22 INFO - 'log_to_console': True, 07:40:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:40:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:40:22 INFO - 'opt_config_files': (), 07:40:22 INFO - 'pip_index': False, 07:40:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:40:22 INFO - 'cmd': ('bash', 07:40:22 INFO - '-c', 07:40:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:40:22 INFO - 'enabled': True, 07:40:22 INFO - 'halt_on_failure': False, 07:40:22 INFO - 'name': 'check_screen_resolution'},), 07:40:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:40:22 INFO - 'cmd': ('bash', 07:40:22 INFO - '-c', 07:40:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:40:22 INFO - 'enabled': True, 07:40:22 INFO - 'halt_on_failure': False, 07:40:22 INFO - 'name': 'check_screen_resolution'},), 07:40:22 INFO - 'run_cmd_checks_enabled': True, 07:40:22 INFO - 'sps_profile': False, 07:40:22 INFO - 'sps_profile_interval': 0, 07:40:22 INFO - 'suite': 'dromaeojs-e10s', 07:40:22 INFO - 'system_bits': '32', 07:40:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:40:22 INFO - 'title': 't-yosemite-r7-0141', 07:40:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:40:22 INFO - 'use_talos_json': True, 07:40:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:40:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:40:22 INFO - 'work_dir': 'build'} 07:40:22 INFO - [mozharness: 2017-01-15 15:40:22.912951Z] Running clobber step. 07:40:22 INFO - Running pre-action listener: _resource_record_pre_action 07:40:22 INFO - Running main action method: clobber 07:40:22 INFO - rmtree: /builds/slave/test/build 07:40:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:40:24 INFO - Running post-action listener: _resource_record_post_action 07:40:24 INFO - [mozharness: 2017-01-15 15:40:24.941312Z] Finished clobber step (success) 07:40:24 INFO - [mozharness: 2017-01-15 15:40:24.941462Z] Running read-buildbot-config step. 07:40:24 INFO - Running pre-action listener: _resource_record_pre_action 07:40:24 INFO - Running main action method: read_buildbot_config 07:40:24 INFO - Using buildbot properties: 07:40:24 INFO - { 07:40:24 INFO - "project": "", 07:40:24 INFO - "product": "firefox", 07:40:24 INFO - "script_repo_revision": "production", 07:40:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:40:24 INFO - "repository": "", 07:40:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:40:24 INFO - "buildid": "20170115064323", 07:40:24 INFO - "pgo_build": "False", 07:40:24 INFO - "basedir": "/builds/slave/test", 07:40:24 INFO - "buildnumber": 38, 07:40:24 INFO - "slavename": "t-yosemite-r7-0141", 07:40:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:40:24 INFO - "platform": "yosemite_r7", 07:40:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:40:24 INFO - "branch": "mozilla-aurora", 07:40:24 INFO - "repo_path": "releases/mozilla-aurora", 07:40:24 INFO - "revision": "3828f20e9bfab38345ff4da40bdb8222f5dcc842", 07:40:24 INFO - "stage_platform": "macosx64", 07:40:24 INFO - "builduid": "560ea1002ac544e6925e555e5a7fa2d6", 07:40:24 INFO - "slavebuilddir": "test" 07:40:24 INFO - } 07:40:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:40:24 INFO - Running post-action listener: _resource_record_post_action 07:40:24 INFO - [mozharness: 2017-01-15 15:40:24.944874Z] Finished read-buildbot-config step (success) 07:40:24 INFO - [mozharness: 2017-01-15 15:40:24.945007Z] Running download-and-extract step. 07:40:24 INFO - Running pre-action listener: _resource_record_pre_action 07:40:24 INFO - Running main action method: download_and_extract 07:40:24 INFO - mkdir: /builds/slave/test/build/tests 07:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:24 INFO - trying https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:40:24 INFO - Downloading https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/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 07:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/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 07:40:25 INFO - Downloaded 1199 bytes. 07:40:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:40:25 INFO - Using the following test package requirements: 07:40:25 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:40:25 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:40:25 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:40:25 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'jsshell-mac.zip'], 07:40:25 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:40:25 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:40:25 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:40:25 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:40:25 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:40:25 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:40:25 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:40:25 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:40:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:40:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:40:25 INFO - Fetch https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:40:26 INFO - Http code: 200 07:40:26 INFO - via: 1.1 4a55d86b7263f73c6817c7c25d4b3643.cloudfront.net (CloudFront) 07:40:26 INFO - x-amz-cf-id: vlSuDPpKKYuenNbRn8Dejs8Dmn_XZLX8jsh1HvUgOU7IENSXc_KNgw== 07:40:26 INFO - x-amz-version-id: l2_jmp.djDaAer4OfNXPHyKyNLktLh3P 07:40:26 INFO - Expected file size: 16275667 07:40:26 INFO - Obtained file size: 16275667 07:40:32 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 07:40:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:40:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:40:32 INFO - Fetch https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:40:33 INFO - Http code: 200 07:40:33 INFO - via: 1.1 296faebadd40feee8b2eb0e10d5786d2.cloudfront.net (CloudFront) 07:40:33 INFO - x-amz-cf-id: QVVTo7AIEKXCS6vjMQORMWnn21auvxikb8gVlz6ZtacbT5kQaIvBfw== 07:40:33 INFO - x-amz-version-id: l2_jmp.djDaAer4OfNXPHyKyNLktLh3P 07:40:33 INFO - Expected file size: 16275667 07:40:33 INFO - Obtained file size: 16275667 07:40:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:40:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:40:40 INFO - Fetch https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:40:41 INFO - Http code: 200 07:40:41 INFO - via: 1.1 3344ddc09ccf1d185bb41add18940cc4.cloudfront.net (CloudFront) 07:40:41 INFO - x-amz-cf-id: Z97AZeVexxOin6-3_8OZnJdo4H6ZhYNi7AxmMF6mgFj_e9OrPraD0Q== 07:40:41 INFO - x-amz-version-id: 90j0p1dxrNTyZ9mZaChw5dWubTuCoc3a 07:40:41 INFO - Expected file size: 14409038 07:40:41 INFO - Obtained file size: 14409038 07:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:41 INFO - trying https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:40:41 INFO - Downloading https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/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 07:40:44 INFO - Downloaded 109991083 bytes. 07:40:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:40:44 INFO - mkdir: /builds/slave/test/properties 07:40:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:40:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:40:44 INFO - Contents: 07:40:44 INFO - build_url:https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:40:45 INFO - Running post-action listener: _resource_record_post_action 07:40:45 INFO - Running post-action listener: set_extra_try_arguments 07:40:45 INFO - [mozharness: 2017-01-15 15:40:45.116900Z] Finished download-and-extract step (success) 07:40:45 INFO - [mozharness: 2017-01-15 15:40:45.117034Z] Running populate-webroot step. 07:40:45 INFO - Running pre-action listener: _resource_record_pre_action 07:40:45 INFO - Running main action method: populate_webroot 07:40:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:40:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:40:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:40:45 INFO - '--tppagecycles', 07:40:45 INFO - '7'], 07:40:45 INFO - 'tests': ['tsvgm']}}, 07:40:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:40:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:40:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:40:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:40:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['damp', 'tps']}, 07:40:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'tests': ['damp', 'tps']}, 07:40:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['dromaeo_dom']}, 07:40:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:40:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['basic_compositor_video']}, 07:40:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:40:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['a11yr', 07:40:45 INFO - 'ts_paint', 07:40:45 INFO - 'tpaint', 07:40:45 INFO - 'sessionrestore', 07:40:45 INFO - 'sessionrestore_no_auto_restore', 07:40:45 INFO - 'tabpaint']}, 07:40:45 INFO - 'other-e10s': {'tests': ['a11yr', 07:40:45 INFO - 'ts_paint', 07:40:45 INFO - 'tpaint', 07:40:45 INFO - 'sessionrestore', 07:40:45 INFO - 'sessionrestore_no_auto_restore', 07:40:45 INFO - 'tabpaint']}, 07:40:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:40:45 INFO - 'ts_paint', 07:40:45 INFO - 'tpaint', 07:40:45 INFO - 'sessionrestore', 07:40:45 INFO - 'sessionrestore_no_auto_restore', 07:40:45 INFO - 'tabpaint']}, 07:40:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:40:45 INFO - 'ts_paint', 07:40:45 INFO - 'tpaint', 07:40:45 INFO - 'sessionrestore', 07:40:45 INFO - 'sessionrestore_no_auto_restore', 07:40:45 INFO - 'tabpaint']}, 07:40:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['a11yr', 07:40:45 INFO - 'ts_paint', 07:40:45 INFO - 'tpaint', 07:40:45 INFO - 'sessionrestore', 07:40:45 INFO - 'sessionrestore_no_auto_restore', 07:40:45 INFO - 'tabpaint']}, 07:40:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['a11yr', 07:40:45 INFO - 'ts_paint', 07:40:45 INFO - 'tpaint', 07:40:45 INFO - 'sessionrestore', 07:40:45 INFO - 'sessionrestore_no_auto_restore', 07:40:45 INFO - 'tabpaint']}, 07:40:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['tsvgx', 07:40:45 INFO - 'tsvgr_opacity', 07:40:45 INFO - 'tart', 07:40:45 INFO - 'tscrollx', 07:40:45 INFO - 'cart']}, 07:40:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:40:45 INFO - 'tsvgr_opacity', 07:40:45 INFO - 'tart', 07:40:45 INFO - 'tscrollx', 07:40:45 INFO - 'cart']}, 07:40:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'talos_options': ['--disable-e10s'], 07:40:45 INFO - 'tests': ['tp5o']}, 07:40:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'tests': ['tp5o']}, 07:40:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'talos_options': ['--disable-e10s', 07:40:45 INFO - '--xperf_path', 07:40:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:45 INFO - 'tests': ['tp5n']}, 07:40:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:45 INFO - 'talos_options': ['--xperf_path', 07:40:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:45 INFO - 'tests': ['tp5n']}}, 07:40:45 INFO - 'talos.zip': {'path': '', 07:40:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:40:45 INFO - Running post-action listener: _resource_record_post_action 07:40:45 INFO - [mozharness: 2017-01-15 15:40:45.136005Z] Finished populate-webroot step (success) 07:40:45 INFO - [mozharness: 2017-01-15 15:40:45.136147Z] Running create-virtualenv step. 07:40:45 INFO - Running pre-action listener: _resource_record_pre_action 07:40:45 INFO - Running main action method: create_virtualenv 07:40:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:40:45 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 07:40:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:40:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:40:45 INFO - Using real prefix '/tools/python27' 07:40:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:40:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:40:48 INFO - Installing pip.................done. 07:40:48 INFO - Return code: 0 07:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:40:49 INFO - Reading from file tmpfile_stdout 07:40:49 INFO - Output received: 07:40:49 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) 07:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:40:49 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 07:40:49 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 07:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:49 INFO - 'HOME': '/Users/cltbld', 07:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:49 INFO - 'LOGNAME': 'cltbld', 07:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:49 INFO - 'MOZ_NO_REMOTE': '1', 07:40:49 INFO - 'NO_EM_RESTART': '1', 07:40:49 INFO - 'PAGER': '/bin/cat', 07:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:49 INFO - 'PWD': '/builds/slave/test', 07:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:49 INFO - 'SHELL': '/bin/bash', 07:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:40:49 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:49 INFO - 'USER': 'cltbld', 07:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:49 INFO - 'XPC_FLAGS': '0x0', 07:40:49 INFO - 'XPC_SERVICE_NAME': '0', 07:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:49 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 07:40:49 INFO - Cleaning up... 07:40:49 INFO - Return code: 0 07:40:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:40:49 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 07:40:49 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 07:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:49 INFO - 'HOME': '/Users/cltbld', 07:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:49 INFO - 'LOGNAME': 'cltbld', 07:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:49 INFO - 'MOZ_NO_REMOTE': '1', 07:40:49 INFO - 'NO_EM_RESTART': '1', 07:40:49 INFO - 'PAGER': '/bin/cat', 07:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:49 INFO - 'PWD': '/builds/slave/test', 07:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:49 INFO - 'SHELL': '/bin/bash', 07:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:40:49 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:49 INFO - 'USER': 'cltbld', 07:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:49 INFO - 'XPC_FLAGS': '0x0', 07:40:49 INFO - 'XPC_SERVICE_NAME': '0', 07:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:49 INFO - Downloading/unpacking psutil>=3.1.1 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:53 INFO - Installing collected packages: psutil 07:40:53 INFO - Running setup.py install for psutil 07:40:53 INFO - building 'psutil._psutil_osx' extension 07:40:53 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 07:40:53 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 07:40:53 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 07:40:54 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 07:40:54 INFO - building 'psutil._psutil_posix' extension 07:40:54 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 07:40:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:40:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:40:54 INFO - ^ 07:40:54 INFO - 1 warning generated. 07:40:54 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 07:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:54 INFO - Successfully installed psutil 07:40:54 INFO - Cleaning up... 07:40:54 INFO - Return code: 0 07:40:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:54 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:40:54 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 07:40:54 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 07:40:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:40:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:54 INFO - 'HOME': '/Users/cltbld', 07:40:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:54 INFO - 'LOGNAME': 'cltbld', 07:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:54 INFO - 'MOZ_NO_REMOTE': '1', 07:40:54 INFO - 'NO_EM_RESTART': '1', 07:40:54 INFO - 'PAGER': '/bin/cat', 07:40:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:54 INFO - 'PWD': '/builds/slave/test', 07:40:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:54 INFO - 'SHELL': '/bin/bash', 07:40:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:40:54 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:40:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:54 INFO - 'USER': 'cltbld', 07:40:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:54 INFO - 'XPC_FLAGS': '0x0', 07:40:54 INFO - 'XPC_SERVICE_NAME': '0', 07:40:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:40:54 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 07:40:54 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 07:40:54 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 07:40:54 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 07:40:54 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 07:40:54 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 07:40:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:40:57 INFO - Installing collected packages: mozsystemmonitor 07:40:57 INFO - Running setup.py install for mozsystemmonitor 07:40:57 INFO - Successfully installed mozsystemmonitor 07:40:57 INFO - Cleaning up... 07:40:57 INFO - Return code: 0 07:40:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:40: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')]} 07:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40: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')]} 07:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:57 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:40:57 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 07:40:57 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 07:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:40:57 INFO - 'HOME': '/Users/cltbld', 07:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:40:57 INFO - 'LOGNAME': 'cltbld', 07:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:57 INFO - 'MOZ_NO_REMOTE': '1', 07:40:57 INFO - 'NO_EM_RESTART': '1', 07:40:57 INFO - 'PAGER': '/bin/cat', 07:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:57 INFO - 'PWD': '/builds/slave/test', 07:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:40:57 INFO - 'SHELL': '/bin/bash', 07:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:40:57 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:40:57 INFO - 'USER': 'cltbld', 07:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:57 INFO - 'XPC_FLAGS': '0x0', 07:40:57 INFO - 'XPC_SERVICE_NAME': '0', 07:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:57 INFO - Downloading/unpacking jsonschema==2.5.1 07:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:41:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:41:00 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 07:41:00 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 07:41:00 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 07:41:00 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 07:41:00 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 07:41:00 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 07:41:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:41:00 INFO - warning: no files found matching '*.txt' 07:41:00 INFO - no previously-included directories found matching 'build' 07:41:00 INFO - no previously-included directories found matching 'dist' 07:41:00 INFO - no previously-included directories found matching '.git*' 07:41:00 INFO - Installing collected packages: jsonschema, functools32 07:41:00 INFO - Running setup.py install for functools32 07:41:01 INFO - warning: no files found matching '*.txt' 07:41:01 INFO - no previously-included directories found matching 'build' 07:41:01 INFO - no previously-included directories found matching 'dist' 07:41:01 INFO - no previously-included directories found matching '.git*' 07:41:01 INFO - Successfully installed jsonschema functools32 07:41:01 INFO - Cleaning up... 07:41:01 INFO - Return code: 0 07:41:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:01 INFO - 'HOME': '/Users/cltbld', 07:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:01 INFO - 'LOGNAME': 'cltbld', 07:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:01 INFO - 'MOZ_NO_REMOTE': '1', 07:41:01 INFO - 'NO_EM_RESTART': '1', 07:41:01 INFO - 'PAGER': '/bin/cat', 07:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:01 INFO - 'PWD': '/builds/slave/test', 07:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:01 INFO - 'SHELL': '/bin/bash', 07:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:01 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:01 INFO - 'USER': 'cltbld', 07:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:01 INFO - 'XPC_FLAGS': '0x0', 07:41:01 INFO - 'XPC_SERVICE_NAME': '0', 07:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:41:01 INFO - Cleaning up... 07:41:01 INFO - Return code: 0 07:41:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:01 INFO - 'HOME': '/Users/cltbld', 07:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:01 INFO - 'LOGNAME': 'cltbld', 07:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:01 INFO - 'MOZ_NO_REMOTE': '1', 07:41:01 INFO - 'NO_EM_RESTART': '1', 07:41:01 INFO - 'PAGER': '/bin/cat', 07:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:01 INFO - 'PWD': '/builds/slave/test', 07:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:01 INFO - 'SHELL': '/bin/bash', 07:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:01 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:01 INFO - 'USER': 'cltbld', 07:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:01 INFO - 'XPC_FLAGS': '0x0', 07:41:01 INFO - 'XPC_SERVICE_NAME': '0', 07:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:01 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:01 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 07:41:01 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 07:41:01 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 07:41:01 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 07:41:01 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 07:41:01 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 07:41:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41:04 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 07:41:04 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 07:41:04 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 07:41:04 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 07:41:04 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 07:41:04 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 07:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:05 INFO - Downloading docopt-0.6.1.tar.gz 07:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:05 INFO - Running setup.py install for blobuploader 07:41:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:05 INFO - Running setup.py install for requests 07:41:06 INFO - Running setup.py install for docopt 07:41:06 INFO - Successfully installed blobuploader requests docopt 07:41:06 INFO - Cleaning up... 07:41:06 INFO - Return code: 0 07:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:06 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')]} 07:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:06 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')]} 07:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:06 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:41:06 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 07:41:06 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 07:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:06 INFO - 'HOME': '/Users/cltbld', 07:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:06 INFO - 'LOGNAME': 'cltbld', 07:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:06 INFO - 'MOZ_NO_REMOTE': '1', 07:41:06 INFO - 'NO_EM_RESTART': '1', 07:41:06 INFO - 'PAGER': '/bin/cat', 07:41:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:06 INFO - 'PWD': '/builds/slave/test', 07:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:06 INFO - 'SHELL': '/bin/bash', 07:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:06 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:06 INFO - 'USER': 'cltbld', 07:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:06 INFO - 'XPC_FLAGS': '0x0', 07:41:06 INFO - 'XPC_SERVICE_NAME': '0', 07:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:06 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-UPwch3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:06 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-pyjeUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:06 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-JdFbxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-0JHFln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-fHSJmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-kc_alD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-OBHIJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-N37Ma3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-qG6aJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-6jVLM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-HQ3C9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:07 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-WCkwuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:08 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Qx99JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:08 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-l1SVtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:08 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Cq9hjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:08 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-2lcB04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:08 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-BYH487-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:08 INFO - Running setup.py install for manifestparser 07:41:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:41:08 INFO - Running setup.py install for mozcrash 07:41:08 INFO - Running setup.py install for mozdebug 07:41:08 INFO - Running setup.py install for mozdevice 07:41:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Running setup.py install for mozfile 07:41:09 INFO - Running setup.py install for mozhttpd 07:41:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Running setup.py install for mozinfo 07:41:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Running setup.py install for mozInstall 07:41:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:41:09 INFO - Running setup.py install for mozleak 07:41:09 INFO - Running setup.py install for mozlog 07:41:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for moznetwork 07:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozprocess 07:41:10 INFO - Running setup.py install for mozprofile 07:41:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozrunner 07:41:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozscreenshot 07:41:10 INFO - Running setup.py install for moztest 07:41:10 INFO - Running setup.py install for mozversion 07:41:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:11 INFO - Cleaning up... 07:41:11 INFO - Return code: 0 07:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:11 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')]} 07:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:11 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')]} 07:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:11 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:41:11 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 07:41:11 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 07:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:11 INFO - 'HOME': '/Users/cltbld', 07:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:11 INFO - 'LOGNAME': 'cltbld', 07:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:11 INFO - 'MOZ_NO_REMOTE': '1', 07:41:11 INFO - 'NO_EM_RESTART': '1', 07:41:11 INFO - 'PAGER': '/bin/cat', 07:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:11 INFO - 'PWD': '/builds/slave/test', 07:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:11 INFO - 'SHELL': '/bin/bash', 07:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:11 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:11 INFO - 'USER': 'cltbld', 07:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:11 INFO - 'XPC_FLAGS': '0x0', 07:41:11 INFO - 'XPC_SERVICE_NAME': '0', 07:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:11 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-32XKkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:11 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)) 07:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:11 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-cWBTIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:11 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)) 07:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:11 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-62cPhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:11 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)) 07:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:11 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-cDtRZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:11 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)) 07:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:11 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-3zsUQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:11 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)) 07:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:11 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-FVuydK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-94Ok48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-bNU5ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ypl61I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-cKGWkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-QKZ0Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-xG0SBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-QG73pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-xB4lXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-A4E306-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:12 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Uv8w60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:13 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)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:13 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-WMU2Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:13 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)) 07:41:13 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)) 07:41:13 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)) 07:41:13 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)) 07:41:13 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)) 07:41:13 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)) 07:41:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:15 INFO - Downloading blessings-1.6.tar.gz 07:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:15 INFO - Installing collected packages: blessings 07:41:15 INFO - Running setup.py install for blessings 07:41:16 INFO - Successfully installed blessings 07:41:16 INFO - Cleaning up... 07:41:16 INFO - Return code: 0 07:41:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:16 INFO - Reading from file tmpfile_stdout 07:41:16 INFO - Current package versions: 07:41:16 INFO - blessings == 1.6 07:41:16 INFO - blobuploader == 1.2.4 07:41:16 INFO - docopt == 0.6.1 07:41:16 INFO - functools32 == 3.2.3-2 07:41:16 INFO - jsonschema == 2.5.1 07:41:16 INFO - manifestparser == 1.1 07:41:16 INFO - mozInstall == 1.12 07:41:16 INFO - mozcrash == 1.0 07:41:16 INFO - mozdebug == 0.1 07:41:16 INFO - mozdevice == 0.48 07:41:16 INFO - mozfile == 1.2 07:41:16 INFO - mozhttpd == 0.7 07:41:16 INFO - mozinfo == 0.9 07:41:16 INFO - mozleak == 0.1 07:41:16 INFO - mozlog == 3.4 07:41:16 INFO - moznetwork == 0.27 07:41:16 INFO - mozprocess == 0.23 07:41:16 INFO - mozprofile == 0.28 07:41:16 INFO - mozrunner == 6.13 07:41:16 INFO - mozscreenshot == 0.1 07:41:16 INFO - mozsystemmonitor == 0.3 07:41:16 INFO - moztest == 0.8 07:41:16 INFO - mozversion == 1.4 07:41:16 INFO - psutil == 3.1.1 07:41:16 INFO - requests == 1.2.3 07:41:16 INFO - wsgiref == 0.1.2 07:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:16 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 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:41:16 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 07:41:16 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 07:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:16 INFO - 'HOME': '/Users/cltbld', 07:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:16 INFO - 'LOGNAME': 'cltbld', 07:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:16 INFO - 'MOZ_NO_REMOTE': '1', 07:41:16 INFO - 'NO_EM_RESTART': '1', 07:41:16 INFO - 'PAGER': '/bin/cat', 07:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:16 INFO - 'PWD': '/builds/slave/test', 07:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:16 INFO - 'SHELL': '/bin/bash', 07:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:16 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:16 INFO - 'USER': 'cltbld', 07:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:16 INFO - 'XPC_FLAGS': '0x0', 07:41:16 INFO - 'XPC_SERVICE_NAME': '0', 07:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 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)) 07:41:16 INFO - Cleaning up... 07:41:16 INFO - Return code: 0 07:41:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10123c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9bc74d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, '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.1u90pwlYhn/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.oO2FqB18Gr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 07:41: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', 'jsonschema'] in /builds/slave/test/build 07:41: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 jsonschema 07:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:16 INFO - 'HOME': '/Users/cltbld', 07:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:16 INFO - 'LOGNAME': 'cltbld', 07:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:16 INFO - 'MOZ_NO_REMOTE': '1', 07:41:16 INFO - 'NO_EM_RESTART': '1', 07:41:16 INFO - 'PAGER': '/bin/cat', 07:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:16 INFO - 'PWD': '/builds/slave/test', 07:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:16 INFO - 'SHELL': '/bin/bash', 07:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:16 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:16 INFO - 'USER': 'cltbld', 07:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:16 INFO - 'XPC_FLAGS': '0x0', 07:41:16 INFO - 'XPC_SERVICE_NAME': '0', 07:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:41:16 INFO - Cleaning up... 07:41:16 INFO - Return code: 0 07:41:16 INFO - Running post-action listener: _resource_record_post_action 07:41:17 INFO - Running post-action listener: _start_resource_monitoring 07:41:17 INFO - Starting resource monitoring. 07:41:17 INFO - [mozharness: 2017-01-15 15:41:17.024528Z] Finished create-virtualenv step (success) 07:41:17 INFO - [mozharness: 2017-01-15 15:41:17.025552Z] Running install step. 07:41:17 INFO - Running pre-action listener: _resource_record_pre_action 07:41:17 INFO - Running main action method: install 07:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:17 INFO - Reading from file tmpfile_stdout 07:41:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:41:17 INFO - Reading from file tmpfile_stdout 07:41:17 INFO - Output received: 07:41:17 INFO - Usage: mozinstall [options] installer 07:41:17 INFO - Options: 07:41:17 INFO - -h, --help show this help message and exit 07:41:17 INFO - -d DEST, --destination=DEST 07:41:17 INFO - Directory to install application into. [default: 07:41:17 INFO - "/builds/slave/test"] 07:41:17 INFO - --app=APP Application being installed. [default: firefox] 07:41:17 INFO - mkdir: /builds/slave/test/build/application 07:41:17 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'] 07:41:17 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 07:41:48 INFO - Reading from file tmpfile_stdout 07:41:48 INFO - Output received: 07:41:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:41:48 INFO - Running post-action listener: _resource_record_post_action 07:41:48 INFO - [mozharness: 2017-01-15 15:41:48.236517Z] Finished install step (success) 07:41:48 INFO - [mozharness: 2017-01-15 15:41:48.236650Z] Running run-tests step. 07:41:48 INFO - Running pre-action listener: _resource_record_pre_action 07:41:48 INFO - Running main action method: run_tests 07:41:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:41:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:41:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:41:48 INFO - 2017-01-15 07:41:48.251 screenresolution[1974:13143] starting screenresolution argv=screenresolution get 07:41:48 INFO - 2017-01-15 07:41:48.253 screenresolution[1974:13143] Display 0: 1600x1200x32@60 07:41:48 INFO - 2017-01-15 07:41:48.259 screenresolution[1975:13145] starting screenresolution argv=screenresolution list 07:41:48 INFO - Available Modes on Display 0 07:41:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:41:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:41:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:41:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:41:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:41:48 INFO - Intel Iris: 07:41:48 INFO - Chipset Model: Intel Iris 07:41:48 INFO - Type: GPU 07:41:48 INFO - Bus: Built-In 07:41:48 INFO - VRAM (Dynamic, Max): 1536 MB 07:41:48 INFO - Vendor: Intel (0x8086) 07:41:48 INFO - Device ID: 0x0a2e 07:41:48 INFO - Revision ID: 0x0009 07:41:48 INFO - Displays: 07:41:48 INFO - Display: 07:41:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:41:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:41:48 INFO - Display Serial Number: 1600x1200 60 07:41:48 INFO - Main Display: Yes 07:41:48 INFO - Mirror: Off 07:41:48 INFO - Online: Yes 07:41:48 INFO - Rotation: Supported 07:41:48 INFO - Return code: 0 07:41:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:41:48 INFO - Python 2.7.3 07:41:48 INFO - Return code: 0 07:41:48 INFO - grabbing minidump binary from tooltool 07:41:48 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')]} 07:41:48 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 0x1010dad30>, '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 0x100f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010d2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:41:48 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 07:41:48 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 07:41:48 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 07:41:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:48 INFO - Return code: 0 07:41:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:41:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:41:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:41:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:41:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:41:48 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/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 07:41:48 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/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --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 07:41:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1u90pwlYhn/Render', 07:41:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:48 INFO - 'HOME': '/Users/cltbld', 07:41:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:48 INFO - 'LOGNAME': 'cltbld', 07:41:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:41:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:48 INFO - 'MOZ_NO_REMOTE': '1', 07:41:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:41:48 INFO - 'NO_EM_RESTART': '1', 07:41:48 INFO - 'PAGER': '/bin/cat', 07:41:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:48 INFO - 'PWD': '/builds/slave/test', 07:41:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:41:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:48 INFO - 'SHELL': '/bin/bash', 07:41:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oO2FqB18Gr/Listeners', 07:41:48 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 07:41:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:48 INFO - 'USER': 'cltbld', 07:41:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:48 INFO - 'XPC_FLAGS': '0x0', 07:41:48 INFO - 'XPC_SERVICE_NAME': '0', 07:41:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:48 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/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 07:41:48 INFO - mozversion application_buildid: 20170115064323 07:41:48 INFO - mozversion application_changeset: 3828f20e9bfab38345ff4da40bdb8222f5dcc842 07:41:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:41:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:41:48 INFO - mozversion application_name: Firefox 07:41:48 INFO - mozversion application_remotingname: firefox-dev 07:41:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:41:48 INFO - mozversion application_vendor: Mozilla 07:41:48 INFO - mozversion application_version: 52.0a2 07:41:48 INFO - mozversion platform_buildid: 20170115064323 07:41:48 INFO - mozversion platform_changeset: 3828f20e9bfab38345ff4da40bdb8222f5dcc842 07:41:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:41:48 INFO - mozversion platform_version: 52.0a2 07:41:48 INFO - using testdate: 1484494908 07:41:48 INFO - actual date: 1484494908 07:41:48 INFO - starting webserver on 'localhost:49349' 07:41:48 INFO - SUITE-START | Running 2 tests 07:41:48 INFO - TEST-START | dromaeo_css 07:41:48 INFO - operating with platform_type : mac_ 07:41:48 INFO - Initialising browser for dromaeo_css test... 07:41:48 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpj54R2v/profile http://localhost:49349/getInfo.html) 07:41:51 INFO - PROCESS | 1985 | 2017-01-15 07:41:51.799 plugin-container[1987:13319] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 07:41:51 INFO - PROCESS | 1985 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:51 INFO - PROCESS | 1985 | 2017-01-15 07:41:51.802 plugin-container[1987:13319] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:41:51 INFO - PROCESS | 1985 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:51 INFO - PROCESS | 1985 | 2017-01-15 07:41:51.803 plugin-container[1987:13319] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:41:51 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 07:41:51 INFO - PROCESS | 1985 | colorDepth:24 07:41:51 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 07:41:51 INFO - PROCESS | 1985 | __metrics 07:41:51 ERROR - PROCESS | 1985 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:41:52 INFO - TEST-INFO | 1985: exit 0 07:41:52 INFO - Browser initialized. 07:41:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:41:52 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpj54R2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:55 INFO - PROCESS | 1988 | 2017-01-15 07:41:55.657 plugin-container[1989:13444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 07:41:55 INFO - PROCESS | 1988 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:55 INFO - PROCESS | 1988 | 2017-01-15 07:41:55.658 plugin-container[1989:13444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 07:41:55 INFO - PROCESS | 1988 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:55 INFO - PROCESS | 1988 | 2017-01-15 07:41:55.658 plugin-container[1989:13444] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:05 INFO - PROCESS | 1988 | RSS: Main: 228843520 07:42:05 INFO - PROCESS | 1988 | 07:45:08 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49349/tests/dromaeo/cssquery-ext.html) 07:45:09 INFO - PROCESS | 1988 | RSS: Main: 233574400 07:45:09 INFO - PROCESS | 1988 | 07:48:11 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49349/tests/dromaeo/cssquery-ext.html (next: http://localhost:49349/tests/dromaeo/cssquery-jquery.html) 07:48:12 INFO - PROCESS | 1988 | RSS: Main: 248258560 07:48:12 INFO - PROCESS | 1988 | 07:51:14 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49349/tests/dromaeo/cssquery-mootools.html) 07:51:15 INFO - PROCESS | 1988 | RSS: Main: 250974208 07:51:15 INFO - PROCESS | 1988 | 07:54:16 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49349/tests/dromaeo/cssquery-prototype.html) 07:54:17 INFO - PROCESS | 1988 | RSS: Main: 251236352 07:54:17 INFO - PROCESS | 1988 | 07:57:20 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49349/tests/dromaeo/cssquery-yui.html) 07:57:20 INFO - PROCESS | 1988 | RSS: Main: 254775296 07:57:20 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:49349/tests/dromaeo/cssquery-yui.html (next: http://localhost:49349/tests/dromaeo/cssquery-dojo.html) 08:00:23 INFO - PROCESS | 1988 | RSS: Main: 256172032 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | __start_tp_report 08:00:23 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 08:00:23 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 08:00:23 INFO - PROCESS | 1988 | |i|pagename|runs| 08:00:23 INFO - PROCESS | 1988 | |0;dojo.html;3229.241128334841;3319.7510186736;3325.0357396355057;3353.3796247694163;3381.0871064812495;5593.244911936888;5627.43725627437;5628.099504079348;5631.8028868989595;5679.290088738908;4264.23243816113;5661.886762264752;5718.027935251007;5729.255196824407;5757.42425757424;4982.651214414992;5208.114620514502;5228.92156617651;5248.370195576536;5278.340207474066;5218.295530103444;5243.239730239113;5262.394824595163;5291.206319052135;5296.311479507678;5151.227315902607;5287;5290.920636190441;5300.443453437391;5314;5112.284280200774;5153.123968925292;5176.197689358137;5248;5257.842264732064;5074.670146440507;5131.307273518065;5191.636585439021;5283.735813209324;5292.867678308035;5731.684757338345;5824.359320474744;5832.154337621064;5854.356020837705;5868.471837534642;6136.27400570097;6142.416470435302;6180.412860778219;6261.405166509175;6305.779297724604;6225.657588832612;6262.12330273762;6263.686815659199;6273.090401891745;6305.054241863757;4845.951540484621;5837.357890632027;5843.824685259449;5846.824595262149;5852.531797456236;6204.503639708812;6215.782447614311;6233.75064997395;6249.9062514062325;6255.280642726054;6132.233136608343;6153.723082461211;6157;6164.951958167033;6166.722497487534;6247.156633854372;6260.311365749764;6266.655333956676;6276.340984196685;6313.873722525524;5759.136129580513;5768.740406681625;5846.912296315559;5878.382769809194;6232.906506402408;6151.169592105098;6151.323354431009;6208.037754148114;6217.253929528486;6290.370962903765;4926.4088309403105;4927.43334516528;4935;4938.160512712776;4938.259261110862;4293.484781826139;4392.099619577979;4402.603765661106;4445.177642136216;4465.26323156682;5505.917411238835;5627.803026894121;5683.8010669626365;5758;5822.475977161991;6227.657478838617;6239.188905442264;6240.812775616739;6244.718987645567;6267.310595834455;5587.106063029895;5646.096624540054;5680.573956953245;5739.741711622987;5818.738156782955;4463.754493502888;5365.356157261153;5427.674339539641;5432.239486471897;5497.120460726264;6167;6167.506599471942;6190.41191086846;6235.438810507076;6285.685715714196;6247.781327653511;6263.342349053466;6269.68651567429;6278.591891527036;6303.338149494237;6263.968680156752;6289.528285378707;6291.937080629135;6309.085182648582;6336.1446204763615;6049.969750151221;6109.84725381869;6120.508083830795;6230.532710046674;6282.246130464374;6149.739303442873;6219.657918814509;6278.937210627835;6284.183056202664;6295.968520157553;5111.769970351269;6161.845953851011;6163.291221509405;6166.136740856194;6200.534959877937;5856.9121463178935;5945.732442040032;6005.219321488178;6153.107799369156;6162.9522981094215;5755.482006619424;5882.7352119294555;5934.1988831508925;5956.5532585055425;6005.39946005396;6114.021756518936;6156.107364432221;6161.075838624242;6175.9382406177165;6178.289496707756;5662.292213473316;5952.464278214981;5969.253843269591;5976.342602313655;5987.13186587951 08:00:23 INFO - PROCESS | 1988 | |1;ext.html;451.90961807638473;517.6686920370963;528.6642981706617;541.7128921671514;545.6044367833324;37948.62051379486;39300;39335;39457.60542394575;41463.792681036626;40193.79903100488;40259.59740402595;40590.7970460148;40646.18707625846;40790.184196316055;9264.768380790483;9303.62785488583;9400.905990940106;9449.149576538144;9497.52512374382;9199.862002069975;9338;9388.202002829768;9413.670521531747;9437.433753974748;9265.351425400224;9376;9438.952805235998;9461.290403219751;9484.62061517542;9361.719148425558;9418.905810941871;9427.811443771156;9429.764255893624;9437.386569872937;9159.862602060974;9246.491442970633;9349.719508414759;9357.064293570656;9363.391379560375;38799.61200387988;38938;39270.018249543704;39282.803585982176;39291.41062884059;3196.6323872754697;3451.8446669899663;3504.1414853360834;3847.7883716395586;3947.980260098681;27397.17808465729;28273;29088.563671544944;29613.259668508243;29700.257493562618;3159.3523327717994;3203.6315823680343;3220.1949512621845;3220.72623826975;3270.689284517967;382935;384438;386849;387423.9999999972;388027;42067.36898946518;55319.17021244684;55461.1680824788;55533.44466555283;55727.164092538645;58273.708631456575;58854;59060.409395906354;59105;59204.70397647984;15739.842601574066;15839.52481425559;15981.920090399473;16001.759973600405;16077.437289694804;12476.875231247754;12560.937195313965;12698.555550555686;12703.745925081446;12715.809262861065;12564.874351256552;14267.143971361544;14713.190774507291;14820.147481564805;14820.407183712747;2772.542530482488;5402.324709411324;5745.454181852718;6400.839979000469;6558.737650494022;866.9263112635371;948.4214629076258;948.5446985447024;1008.9557308186139;1038.127972503101;23973.52052958966;28729.712702872705;29092.709072909423;29212.85393573061;29560;873.6767396063498;929.5352323838081;1040.9271351005357;1051.6109039655375;1064.5794911010107;14787.852121478647;15233.933624646168;15292.923535382475;15484.690306194037;15503.302351394213;663502;671299;671853;672567;674867;55220.89558208894;55258.723706382014;55688.443115569135;55735.16397253963;55737;1321.729045545661;1339.8995075369191;1361.0404664711355;1367.070392133339;1371.190997311571;28822;29460;29477.705222948352;29676.10971670853;29991.85004075053;44582.777086114365;44814;44885.877853053935;44886.55113448954;44893.55106448894;611885;615058;616260;616414;617602;25221.495570088864;25461.618075728507;25489.872550637127;25552;25928.740712592633;37552;43253.56746432495;44953.77523112363;45127.77436112799;45780;36529.45205821968;36859;37488.625113748516;38464.80767596144;38920.80539597284;37270.06824829401;37307.626923730415;37756;38008.80995595004;38553.843384698506;36769;36899.26201475902;36931;37581.4362784553;37718.057048574;32241;32860.34279314352;33731.494027590095;34451.96644100681;34494.82752586221;25070.874645626656;25720.614190787528;25828.96684132689;25854.965801368486;25855.871489129477 08:00:23 INFO - PROCESS | 1988 | |2;jquery.html;337.32534930139724;351.21853875127846;365.43722667092663;375.41435360837096;383.1092709450528;17539;18833.529161770963;19214;19292.807071929277;19447;19562.510937226576;19963.800361996375;20059.398218053444;20361.796382036177;20454.07956641951;4581.954180458203;5859.32617748959;6105.6947152642415;6117.816465506042;6127.89697854386;5884.4703976642095;5995;6066.726997285111;6085.695715214244;6088.1476593276975;5869.50109240715;5967.6121052131475;6028.939710602904;6158.137860699506;6509.576877502971;6536.705848236841;6552.574082684634;6570.310117437648;6594.6372949487995;6605.174353205849;5652.123920792284;5831.883362332772;5880.529557635422;5888.97055514724;5890.440408161217;17776.91111544434;23789;24447.51104977908;24558.50882982348;24712.13507527228;2213.236433430464;2226;2319.489712263299;2337.9298621041394;2859.4995875721875;9717.757056073584;9825.164860986824;9950.800983980353;10197.290230568098;10396.116330111874;1614.3381213702326;1790.3196785221533;1809.0864113622536;1822.0980614595728;1864.7855496617926;112888.43555782251;114550.42724786323;115207;116636;118591;11347.602833900939;11516.424178791027;11717.414129293502;11719.941400292944;11776.646700598996;12144.939275303566;14309;14684.853151468562;14737.778933316009;14745.705085898222;6954.617496037767;8456.492610443393;8556.871646925301;8686;8724.127587241224;8492.320614350838;8504.192101750448;8538.530380829114;8650.307975361957;8664.95667521671;4400.75795831226;4454.732716037048;4496.7077139985795;4559.931601025987;4561.566651168134;1579.431404694309;1877.2209533043633;1920.817522335376;1993.481694759344;1993.9501512462305;837.3970741066422;864.8702694595735;871.8430682477215;898.6315610599622;982.8967958364411;20112.497187570134;20225.089870955842;20428.285010024578;20483.59032819365;20754.688679669816;802.6829402386142;862.1895418306772;875.9737207883774;908.5321059654283;934.4019827310527;8889.777755556162;10337;10828.97124773161;10945.83581246282;10957.986888391435;593682;600119;605059;612599;614687;120162.79837201517;121711;124382;124463;126203;853.8121613245077;877.5349064995562;1013.3514550687565;1017.6743442098606;1018.2464975917768;18704.719429208846;18949.810501894804;19147.04264786783;19190.13644385978;19272.22911083541;39970;50336;54376;55216.723916381765;56103.71948140233;69836.30163698501;69979;78085.21914780779;80345;81597.59201203956;7772.300492955661;8141;8184.181581841768;8259.710910118118;8286.171382861665;10689.57241710354;12416.006719462603;12676.176048556814;12801.487940482277;12840.678983025498;10958.01377875995;11073.83389249178;11210.43947802623;11398.259113157617;11461.942690286494;10389.37663740178;10585.153187745116;10614.575416983234;10637.521311540844;10677;9212.861807073034;11007.559697612327;11192.664220073411;11226.831597525881;11608.12939029593;7973.880391794011;8067.757967260992;8205.58972051407;8307.044689860744;8344.457610255315;10018.64934727281;10810.67567972962;10909.454527273763;11219.270747401393;11328 08:00:23 INFO - PROCESS | 1988 | |3;mootools.html;1474;1493.0519120358572;1652.454689952316;1779.0837718574928;1829.9817001829986;7481.6259187040705;7724.536527808322;8004.919950800498;8451.788705282372;8476.491410515366;7871.488353257034;8202.097769245378;8202.548859812709;8309.127541608135;8317.875231871527;2307.6884620576175;2342.5666251743396;2356.9528609427803;2357.434215788207;2360.8819559022068;2347.319277409558;2365.8107351411845;2388.7850093491584;2395.6646069550275;2397.2328854766483;2336.0538981712434;2341.180586794617;2360.976390236093;2362.0905951208824;2362.8227882908764;2322.3149170994598;2323.337848713117;2328.5692146952697;2352.6706261123454;2354.682117914085;2343.8359314847967;2348.131191459154;2352.2472808701223;2369.2655276864057;2379.5003049359657;8329.208725171098;8367.748967530923;8391.454555453876;8436.662533498653;8453.873191902127;4998.12532806761;5110.386753589593;5120.846374608767;5145.459726728677;5154.613403994678;3021.169178475937;3414.487826825996;3453.913652158691;3475.8088305143206;3527.153483164048;1045.5451878432907;1061.3578784835217;1077.7144056824948;1091.6615849086809;1097.462243500687;9655.90344096557;10133.746656333651;10880;10951.945240273828;10979.945100274528;4269.765162916007;4425.601695847389;4482.663800214997;4502.392177056121;4502.617277531381;8559.058503564604;8614.741557753277;8651.6106775194;8671.4363566368;8678.86981695275;5077.568406685473;5095.286659867622;5098.439171691111;5101.566366858784;5105.2342148678;4268.274393353137;4430.335449682509;4628.514006029386;4705.529447055335;4752.714837109785;2953.9808765975704;3420.6237313895454;3465.1683595937297;3497.7026952709307;3541.982290088533;1115.7489564847845;1131.6491887514896;1133.1218305812897;1133.880942501042;1142.6400683784582;799.152897928198;862.508370228976;863.1411745313453;880.5245167609547;900.7522931193843;5565.6920623653405;5598.440155984369;5765.740541675635;5860.824175274749;5981.611195272293;820.4420993724325;928.3269629518545;932.147085416836;941.3598752847992;946.786972931085;3618.7105031597407;3833.3483307837732;3847.3074846527893;3915.960840391617;3967.0875698589484;9789.461579613047;10056.84914726265;10099.747506312255;10180.981901809908;10181.54183061764;9622.615095396106;10152.39085654863;10173.54219060144;10179.287449878437;10186.185105191715;7652.885206721904;7761.650725717356;7805.609719514116;7813.687452501837;7835.608219588998;4904.386951631046;5299.761510731949;5628.549716022791;5662.207290979349;5868.972929737193;8946.060663630486;9186.724398268063;9268.907310927074;9384.249260059316;9401.623935042522;9171.77070573241;9382.87405511343;9441;9499.62001519959;9510.762230944005;7202.423806095395;7244.927550724426;7261.636918153966;7326.4138868889295;7376.114866216089;6622;7894.842103158019;7921.089074756477;7922.643481043482;7943.602819858868;7135.785926422215;7210.1708303545765;7219.0976127984;7262.891056634049;7335.669894854851;6960.443164546926;7089.82275443118;7104.715811367694;7126.5011449198055;7221.711131554679;6603.636799976048;6738.157730283715;6741.1236539249585;6754.18949726036;6758.898616520658;4833.226683730586;4857.562819346276;4910.263460480814;4914.533119353656;5009.423916249678;4831.589314908131;4893.510648935078;4925.778339974638;4950.975245123751;5021.6735912165595 08:00:23 INFO - PROCESS | 1988 | |4;prototype.html;260.69759079467815;297.32507208636395;313.25445439853155;314.7670723664489;316.7893350921637;5306.389765176996;5324.387695415028;5444.782208711652;5474;5568.443155684429;5139;5289.56679927233;5524.005678977783;5529.599296432695;5609.943900560993;3709.4250391189275;3870.20660764544;3942.9156981829938;4203.894902627429;4244.299690551055;3499.860005599786;4113.588641135892;4243.596858298457;4262.637675797561;4322.222000039991;3652.817359132046;4167.937480937789;4194.517630472505;4212.283911735012;4247.065645557972;4213.873583792491;4237.258479766044;4245.448091748084;4262.552431994627;4271.9572804271875;3620.294042661682;3708.2200543738886;3711.498947642088;3724.75220801032;3728.2170744143764;4388.385626012361;4537.523560026216;5184.403793563751;5306.893862122774;5413.861524697722;4038.576853887673;4172.895677608054;4229.386738922839;4642.326862604903;4800.279958006292;5091.257925424809;5785.855353616151;5802.622829516068;5804.419558044204;5819.592628516006;3847.711421643388;4009.4186342980106;4072.2873497137884;4086.979565102185;4119.773412462313;6074.848128796772;6089.756409743605;6101.389861013908;6123.8162855114415;6126.632402055891;4113.773742444194;4116.464859568297;4132.586741325904;4138.806432590732;4142.875713728593;3404.5744281964753;4024.3158663027357;4124.484439445069;4163.687723420695;4164.916701665949;4429.003474218275;4639.724075879093;4724.976375118103;4830.516948305141;4870.780814863339;4897.3878265216845;4929.531694489017;5581;5727.284089488814;5816.5928385013485;1238.9442475088642;1253.8181963615225;1290.4322098276728;1329.936051159069;1342.3221273257138;823.259066839849;866.2290561400358;887.9156480134377;915.3272344826547;925.3383830561181;5222.190560463135;5234.450382709761;5235.764390602432;5254.737263136828;5260.9736951315;4961.801527938915;5432;5540.944590554042;5587.7485513152005;5722.08173831349;4337.544557821383;4802.327674125625;4823.324734537167;5203.895922081537;5238.371395432497;2511.9246422606984;2701.419194873112;2996.9100926972224;3011.969880301213;3012.3071693510615;5415.918761218585;5796.913046304308;5885.793997210163;5931.436513531207;5975.952264345216;4646.372739680168;4996.650234483552;5793.942060579425;5813.563982701315;5879.412058794172;5756.136579513023;5804.401271211876;5836.620619659709;5858.56060795442;5866.50134738552;4946.664400611887;5421.430749771375;5658.971705141613;5716.742746576498;5717.912327343188;4837;5131.332316997065;5172.060477321004;5575.0522411191005;5632.479230607795;5566.693831839126;5787.826365209051;5848.239728835224;5852.882942341044;5862;3694.9552893537107;3928.2339943710704;3929.936783188849;3937.4684417604403;3967.4247234150307;4628;4817.1810792164715;4841.419029716316;5691.174779656843;5812.73842677089;5680.346760122474;5695.943040569541;5890;5898.286788077532;5900.43945825146;5388.811391601275;5876.529877609695;5882.235309409921;5887.852803679943;5893.410658934244;5525.751341189576;5571.220029195997;5649.915251271316;5703.942960570507;5746.9712651436475;5351.491608297206;5571.749271282721;5858.209141765807;5886.997631208029;5917.792877249276;4445.488768791501;5097.337346144977;5661.66030038199;5723.796338409659;5834.708264586839 08:00:23 INFO - PROCESS | 1988 | |5;yui.html;645.7610684046901;693.4764252988992;705.5237714542683;762.291069305546;808.6320724070548;13697.452101915924;14077.366518506666;14345.426182952682;14422.783658245135;14512.854871451296;13048.73902521949;13284.667883302922;13292.800607990888;13301.201927884309;13336.33318334082;810.3395732478026;811.0956283743612;822.2065706593137;823.0041649603986;823.6170180865896;641.2881701311541;663.4161937494997;809.1706001348635;825.4964471672275;838.0990435282066;869.0353707384797;869.4261787220436;872.0363997782454;873.3013589128672;874.9737507874773;862.0302160069921;864.5936409887343;864.9524276164808;866.23338345564;866.5147517390282;630.9905351419733;647.6049609738056;648.1250312078703;648.7761722205831;650.4113777031794;13405.798913016313;13484.730305393936;13506;13522.918166546653;13590.32048397586;12897.09720319578;13062.27943734782;13364.131331463424;13398.732025359535;13456.93271533646;10422.478876056166;10799.190060745475;10809.135269178447;10893.727656808564;11180.720481987933;3549.804760738158;3600.747947643666;3627.7097832173363;3636.272745450894;3642;66451;78469.60765196195;78824;82581;82728;8711.869321960176;9698.042295952457;9919.851202231972;10106;10211.387316760869;20096.69854952177;20153.294634687714;20159.596808063758;20368.185272589228;20546.383608491768;5705.914411283834;7257.201707812136;7263.89104163438;7452.515586486969;7589.43079269057;3332.7000569948823;4100.856470023535;4198.412222288882;4351.694491652492;4363.52001279859;3313.5858017747782;3383.695467407945;3411.403004474207;3422.8117453540294;3459.3254315408253;626.6490765171518;639.338284875152;643.8132941447021;648.2771709543824;660.8876490996543;584.6316820403118;617.9227596550431;626.9373062693785;642.7493277621732;672.3881268046055;7154.964225178841;8641.351898607629;8674.349423793241;8816.911830881609;8963.596638151299;637.3930623748889;642.1267076775581;667.3226674924955;668.759246671198;673.0879658063254;3768.812823960444;4043.0274444245333;4238.173556156582;4339.218940590661;4353.172897149531;67579.32420675829;102180.97819021864;106779;120013;120944.39527802305;98588.50705746569;100867;101761;102592;104986;65569.67215163894;70277.2972270281;89191;91153.54423227841;91809;8109.878351824609;8357.498550087013;8533.957330213558;8569.442986205877;8601.612927418157;56405;58214;58606;59060.40939590549;59826.40173598209;37232;52354.47645523496;74413.62793186;77540.22459775556;80513.59743201247;8777.868331974898;9114.589843457194;10600.4699765013;10744.731381715206;11005.669829905115;10192.235582331206;12029.398530073637;12090.576829810914;12098.395080245777;12111.45498452554;9026.18764311215;10940.835887461535;11403.315801051964;11532.481038353462;11656.18406711522;11552.884471155518;11648.301101933912;11788.29270243788;11792.882071179522;11849.170558060852;9984;11443.485043173243;11634.825477618011;11879.643610691694;11984.64046078619;8527.360447966552;10117.494125293853;10277.845832312372;10509.78980420372;10518.421486818299;10512.526936287732;10517;10626.787464250518;10813.783724325313;10961.232713709964 08:00:23 INFO - PROCESS | 1988 | __end_tp_report 08:00:23 INFO - PROCESS | 1988 | __start_cc_report 08:00:23 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,356 08:00:23 INFO - PROCESS | 1988 | __end_cc_report 08:00:23 INFO - PROCESS | 1988 | __startTimestamp1484496023582__endTimestamp 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | ------- Summary: start ------- 08:00:23 INFO - PROCESS | 1988 | Number of tests: 6 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:5712.57 Median:5878.38 stddev:659.67 (11.2%) stddev-sans-first:632.27 08:00:23 INFO - PROCESS | 1988 | Values: 3229.2 3319.8 3325.0 3353.4 3381.1 5593.2 5627.4 5628.1 5631.8 5679.3 4264.2 5661.9 5718.0 5729.3 5757.4 4982.7 5208.1 5228.9 5248.4 5278.3 5218.3 5243.2 5262.4 5291.2 5296.3 5151.2 5287.0 5290.9 5300.4 5314.0 5112.3 5153.1 5176.2 5248.0 5257.8 5074.7 5131.3 5191.6 5283.7 5292.9 5731.7 5824.4 5832.2 5854.4 5868.5 6136.3 6142.4 6180.4 6261.4 6305.8 6225.7 6262.1 6263.7 6273.1 6305.1 4846.0 5837.4 5843.8 5846.8 5852.5 6204.5 6215.8 6233.8 6249.9 6255.3 6132.2 6153.7 6157.0 6165.0 6166.7 6247.2 6260.3 6266.7 6276.3 6313.9 5759.1 5768.7 5846.9 5878.4 6232.9 6151.2 6151.3 6208.0 6217.3 6290.4 4926.4 4927.4 4935.0 4938.2 4938.3 4293.5 4392.1 4402.6 4445.2 4465.3 5505.9 5627.8 5683.8 5758.0 5822.5 6227.7 6239.2 6240.8 6244.7 6267.3 5587.1 5646.1 5680.6 5739.7 5818.7 4463.8 5365.4 5427.7 5432.2 5497.1 6167.0 6167.5 6190.4 6235.4 6285.7 6247.8 6263.3 6269.7 6278.6 6303.3 6264.0 6289.5 6291.9 6309.1 6336.1 6050.0 6109.8 6120.5 6230.5 6282.2 6149.7 6219.7 6278.9 6284.2 6296.0 5111.8 6161.8 6163.3 6166.1 6200.5 5856.9 5945.7 6005.2 6153.1 6163.0 5755.5 5882.7 5934.2 5956.6 6005.4 6114.0 6156.1 6161.1 6175.9 6178.3 5662.3 5952.5 5969.3 5976.3 5987.1 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:68094.40 Median:213413.31 stddev:153116.18 (71.7%) stddev-sans-first:153461.49 08:00:23 INFO - PROCESS | 1988 | Values: 451.9 517.7 528.7 541.7 545.6 37948.6 39300.0 39335.0 39457.6 41463.8 40193.8 40259.6 40590.8 40646.2 40790.2 9264.8 9303.6 9400.9 9449.1 9497.5 9199.9 9338.0 9388.2 9413.7 9437.4 9265.4 9376.0 9439.0 9461.3 9484.6 9361.7 9418.9 9427.8 9429.8 9437.4 9159.9 9246.5 9349.7 9357.1 9363.4 38799.6 38938.0 39270.0 39282.8 39291.4 3196.6 3451.8 3504.1 3847.8 3948.0 27397.2 28273.0 29088.6 29613.3 29700.3 3159.4 3203.6 3220.2 3220.7 3270.7 382935.0 384438.0 386849.0 387424.0 388027.0 42067.4 55319.2 55461.2 55533.4 55727.2 58273.7 58854.0 59060.4 59105.0 59204.7 15739.8 15839.5 15981.9 16001.8 16077.4 12476.9 12560.9 12698.6 12703.7 12715.8 12564.9 14267.1 14713.2 14820.1 14820.4 2772.5 5402.3 5745.5 6400.8 6558.7 866.9 948.4 948.5 1009.0 1038.1 23973.5 28729.7 29092.7 29212.9 29560.0 873.7 929.5 1040.9 1051.6 1064.6 14787.9 15233.9 15292.9 15484.7 15503.3 663502.0 671299.0 671853.0 672567.0 674867.0 55220.9 55258.7 55688.4 55735.2 55737.0 1321.7 1339.9 1361.0 1367.1 1371.2 28822.0 29460.0 29477.7 29676.1 29991.9 44582.8 44814.0 44885.9 44886.6 44893.6 611885.0 615058.0 616260.0 616414.0 617602.0 25221.5 25461.6 25489.9 25552.0 25928.7 37552.0 43253.6 44953.8 45127.8 45780.0 36529.5 36859.0 37488.6 38464.8 38920.8 37270.1 37307.6 37756.0 38008.8 38553.8 36769.0 36899.3 36931.0 37581.4 37718.1 32241.0 32860.3 33731.5 34452.0 34494.8 25070.9 25720.6 25829.0 25855.0 25855.9 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:34772.92 Median:24635.32 stddev:100781.87 (409.1%) stddev-sans-first:101031.42 08:00:23 INFO - PROCESS | 1988 | Values: 337.3 351.2 365.4 375.4 383.1 17539.0 18833.5 19214.0 19292.8 19447.0 19562.5 19963.8 20059.4 20361.8 20454.1 4582.0 5859.3 6105.7 6117.8 6127.9 5884.5 5995.0 6066.7 6085.7 6088.1 5869.5 5967.6 6028.9 6158.1 6509.6 6536.7 6552.6 6570.3 6594.6 6605.2 5652.1 5831.9 5880.5 5889.0 5890.4 17776.9 23789.0 24447.5 24558.5 24712.1 2213.2 2226.0 2319.5 2337.9 2859.5 9717.8 9825.2 9950.8 10197.3 10396.1 1614.3 1790.3 1809.1 1822.1 1864.8 112888.4 114550.4 115207.0 116636.0 118591.0 11347.6 11516.4 11717.4 11719.9 11776.6 12144.9 14309.0 14684.9 14737.8 14745.7 6954.6 8456.5 8556.9 8686.0 8724.1 8492.3 8504.2 8538.5 8650.3 8665.0 4400.8 4454.7 4496.7 4559.9 4561.6 1579.4 1877.2 1920.8 1993.5 1994.0 837.4 864.9 871.8 898.6 982.9 20112.5 20225.1 20428.3 20483.6 20754.7 802.7 862.2 876.0 908.5 934.4 8889.8 10337.0 10829.0 10945.8 10958.0 593682.0 600119.0 605059.0 612599.0 614687.0 120162.8 121711.0 124382.0 124463.0 126203.0 853.8 877.5 1013.4 1017.7 1018.2 18704.7 18949.8 19147.0 19190.1 19272.2 39970.0 50336.0 54376.0 55216.7 56103.7 69836.3 69979.0 78085.2 80345.0 81597.6 7772.3 8141.0 8184.2 8259.7 8286.2 10689.6 12416.0 12676.2 12801.5 12840.7 10958.0 11073.8 11210.4 11398.3 11461.9 10389.4 10585.2 10614.6 10637.5 10677.0 9212.9 11007.6 11192.7 11226.8 11608.1 7973.9 8067.8 8205.6 8307.0 8344.5 10018.6 10810.7 10909.5 11219.3 11328.0 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:5403.72 Median:5096.86 stddev:2938.62 (57.7%) stddev-sans-first:2932.02 08:00:23 INFO - PROCESS | 1988 | Values: 1474.0 1493.1 1652.5 1779.1 1830.0 7481.6 7724.5 8004.9 8451.8 8476.5 7871.5 8202.1 8202.5 8309.1 8317.9 2307.7 2342.6 2357.0 2357.4 2360.9 2347.3 2365.8 2388.8 2395.7 2397.2 2336.1 2341.2 2361.0 2362.1 2362.8 2322.3 2323.3 2328.6 2352.7 2354.7 2343.8 2348.1 2352.2 2369.3 2379.5 8329.2 8367.7 8391.5 8436.7 8453.9 4998.1 5110.4 5120.8 5145.5 5154.6 3021.2 3414.5 3453.9 3475.8 3527.2 1045.5 1061.4 1077.7 1091.7 1097.5 9655.9 10133.7 10880.0 10951.9 10979.9 4269.8 4425.6 4482.7 4502.4 4502.6 8559.1 8614.7 8651.6 8671.4 8678.9 5077.6 5095.3 5098.4 5101.6 5105.2 4268.3 4430.3 4628.5 4705.5 4752.7 2954.0 3420.6 3465.2 3497.7 3542.0 1115.7 1131.6 1133.1 1133.9 1142.6 799.2 862.5 863.1 880.5 900.8 5565.7 5598.4 5765.7 5860.8 5981.6 820.4 928.3 932.1 941.4 946.8 3618.7 3833.3 3847.3 3916.0 3967.1 9789.5 10056.8 10099.7 10181.0 10181.5 9622.6 10152.4 10173.5 10179.3 10186.2 7652.9 7761.7 7805.6 7813.7 7835.6 4904.4 5299.8 5628.5 5662.2 5869.0 8946.1 9186.7 9268.9 9384.2 9401.6 9171.8 9382.9 9441.0 9499.6 9510.8 7202.4 7244.9 7261.6 7326.4 7376.1 6622.0 7894.8 7921.1 7922.6 7943.6 7135.8 7210.2 7219.1 7262.9 7335.7 6960.4 7089.8 7104.7 7126.5 7221.7 6603.6 6738.2 6741.1 6754.2 6758.9 4833.2 4857.6 4910.3 4914.5 5009.4 4831.6 4893.5 4925.8 4951.0 5021.7 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:4615.05 Median:5178.23 stddev:1406.97 (27.2%) stddev-sans-first:1372.44 08:00:23 INFO - PROCESS | 1988 | Values: 260.7 297.3 313.3 314.8 316.8 5306.4 5324.4 5444.8 5474.0 5568.4 5139.0 5289.6 5524.0 5529.6 5609.9 3709.4 3870.2 3942.9 4203.9 4244.3 3499.9 4113.6 4243.6 4262.6 4322.2 3652.8 4167.9 4194.5 4212.3 4247.1 4213.9 4237.3 4245.4 4262.6 4272.0 3620.3 3708.2 3711.5 3724.8 3728.2 4388.4 4537.5 5184.4 5306.9 5413.9 4038.6 4172.9 4229.4 4642.3 4800.3 5091.3 5785.9 5802.6 5804.4 5819.6 3847.7 4009.4 4072.3 4087.0 4119.8 6074.8 6089.8 6101.4 6123.8 6126.6 4113.8 4116.5 4132.6 4138.8 4142.9 3404.6 4024.3 4124.5 4163.7 4164.9 4429.0 4639.7 4725.0 4830.5 4870.8 4897.4 4929.5 5581.0 5727.3 5816.6 1238.9 1253.8 1290.4 1329.9 1342.3 823.3 866.2 887.9 915.3 925.3 5222.2 5234.5 5235.8 5254.7 5261.0 4961.8 5432.0 5540.9 5587.7 5722.1 4337.5 4802.3 4823.3 5203.9 5238.4 2511.9 2701.4 2996.9 3012.0 3012.3 5415.9 5796.9 5885.8 5931.4 5976.0 4646.4 4996.7 5793.9 5813.6 5879.4 5756.1 5804.4 5836.6 5858.6 5866.5 4946.7 5421.4 5659.0 5716.7 5717.9 4837.0 5131.3 5172.1 5575.1 5632.5 5566.7 5787.8 5848.2 5852.9 5862.0 3695.0 3928.2 3929.9 3937.5 3967.4 4628.0 4817.2 4841.4 5691.2 5812.7 5680.3 5695.9 5890.0 5898.3 5900.4 5388.8 5876.5 5882.2 5887.9 5893.4 5525.8 5571.2 5649.9 5703.9 5747.0 5351.5 5571.7 5858.2 5887.0 5917.8 4445.5 5097.3 5661.7 5723.8 5834.7 08:00:23 INFO - PROCESS | 1988 | 08:00:23 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:19576.31 Median:28359.00 stddev:29345.76 (103.5%) stddev-sans-first:29393.66 08:00:23 INFO - PROCESS | 1988 | Values: 645.8 693.5 705.5 762.3 808.6 13697.5 14077.4 14345.4 14422.8 14512.9 13048.7 13284.7 13292.8 13301.2 13336.3 810.3 811.1 822.2 823.0 823.6 641.3 663.4 809.2 825.5 838.1 869.0 869.4 872.0 873.3 875.0 862.0 864.6 865.0 866.2 866.5 631.0 647.6 648.1 648.8 650.4 13405.8 13484.7 13506.0 13522.9 13590.3 12897.1 13062.3 13364.1 13398.7 13456.9 10422.5 10799.2 10809.1 10893.7 11180.7 3549.8 3600.7 3627.7 3636.3 3642.0 66451.0 78469.6 78824.0 82581.0 82728.0 8711.9 9698.0 9919.9 10106.0 10211.4 20096.7 20153.3 20159.6 20368.2 20546.4 5705.9 7257.2 7263.9 7452.5 7589.4 3332.7 4100.9 4198.4 4351.7 4363.5 3313.6 3383.7 3411.4 3422.8 3459.3 626.6 639.3 643.8 648.3 660.9 584.6 617.9 626.9 642.7 672.4 7155.0 8641.4 8674.3 8816.9 8963.6 637.4 642.1 667.3 668.8 673.1 3768.8 4043.0 4238.2 4339.2 4353.2 67579.3 102181.0 106779.0 120013.0 120944.4 98588.5 100867.0 101761.0 102592.0 104986.0 65569.7 70277.3 89191.0 91153.5 91809.0 8109.9 8357.5 8534.0 8569.4 8601.6 56405.0 58214.0 58606.0 59060.4 59826.4 37232.0 52354.5 74413.6 77540.2 80513.6 8777.9 9114.6 10600.5 10744.7 11005.7 10192.2 12029.4 12090.6 12098.4 12111.5 9026.2 10940.8 11403.3 11532.5 11656.2 11552.9 11648.3 11788.3 11792.9 11849.2 9984.0 11443.5 11634.8 11879.6 11984.6 8527.4 10117.5 10277.8 10509.8 10518.4 10512.5 10517.0 10626.8 10813.8 10961.2 08:00:23 INFO - PROCESS | 1988 | -------- Summary: end -------- 08:00:23 INFO - PROCESS | 1988 | 08:00:24 INFO - TEST-INFO | 1988: exit 0 08:00:24 INFO - TEST-OK | dromaeo_css | took 1115379ms 08:00:24 INFO - TEST-START | kraken 08:00:24 INFO - operating with platform_type : mac_ 08:00:24 INFO - Initialising browser for kraken test... 08:00:24 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpZROLUj/profile http://localhost:49349/getInfo.html) 08:00:27 INFO - PROCESS | 1993 | 2017-01-15 08:00:27.182 plugin-container[1994:15644] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8637, name = 'com.apple.tsm.portname' 08:00:27 INFO - PROCESS | 1993 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:00:27 INFO - PROCESS | 1993 | 2017-01-15 08:00:27.185 plugin-container[1994:15644] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 08:00:27 INFO - PROCESS | 1993 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:00:27 INFO - PROCESS | 1993 | 2017-01-15 08:00:27.185 plugin-container[1994:15644] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:00:27 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 08:00:27 INFO - PROCESS | 1993 | colorDepth:24 08:00:27 INFO - PROCESS | 1993 | Browser inner width/height: 1024/689 08:00:27 INFO - PROCESS | 1993 | __metrics 08:00:27 ERROR - PROCESS | 1993 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:00:28 INFO - TEST-INFO | 1993: exit 0 08:00:28 INFO - Browser initialized. 08:00:28 INFO - Running cycle 1/1 for kraken test... 08:00:28 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpZROLUj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:30 INFO - PROCESS | 1995 | 2017-01-15 08:00:30.704 plugin-container[1996:15769] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.tsm.portname' 08:00:30 INFO - PROCESS | 1995 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:00:30 INFO - PROCESS | 1995 | 2017-01-15 08:00:30.705 plugin-container[1996:15769] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c03, name = 'com.apple.CFPasteboardClient' 08:00:30 INFO - PROCESS | 1995 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:00:30 INFO - PROCESS | 1995 | 2017-01-15 08:00:30.705 plugin-container[1996:15769] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:00:40 INFO - PROCESS | 1995 | RSS: Main: 228954112 08:00:40 INFO - PROCESS | 1995 | 08:00:43 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49349/tests/kraken/driver.html?testName=audio-beat-detection) 08:00:44 INFO - PROCESS | 1995 | RSS: Main: 241238016 08:00:44 INFO - PROCESS | 1995 | 08:00:47 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49349/tests/kraken/driver.html?testName=audio-dft) 08:00:47 INFO - PROCESS | 1995 | RSS: Main: 249274368 08:00:47 INFO - PROCESS | 1995 | 08:00:51 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49349/tests/kraken/driver.html?testName=audio-fft) 08:00:52 INFO - PROCESS | 1995 | RSS: Main: 251052032 08:00:52 INFO - PROCESS | 1995 | 08:00:54 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49349/tests/kraken/driver.html?testName=audio-oscillator) 08:00:54 INFO - PROCESS | 1995 | RSS: Main: 252669952 08:00:54 INFO - PROCESS | 1995 | 08:00:56 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:00:57 INFO - PROCESS | 1995 | RSS: Main: 254259200 08:00:57 INFO - PROCESS | 1995 | 08:01:00 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49349/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:00 INFO - PROCESS | 1995 | RSS: Main: 258097152 08:01:00 INFO - PROCESS | 1995 | 08:01:04 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49349/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:04 INFO - PROCESS | 1995 | RSS: Main: 257712128 08:01:04 INFO - PROCESS | 1995 | 08:01:07 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49349/tests/kraken/driver.html?testName=json-parse-financial) 08:01:07 INFO - PROCESS | 1995 | RSS: Main: 257773568 08:01:07 INFO - PROCESS | 1995 | 08:01:09 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:10 INFO - PROCESS | 1995 | RSS: Main: 256835584 08:01:10 INFO - PROCESS | 1995 | 08:01:12 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:12 INFO - PROCESS | 1995 | RSS: Main: 256802816 08:01:12 INFO - PROCESS | 1995 | 08:01:14 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:15 INFO - PROCESS | 1995 | RSS: Main: 257404928 08:01:15 INFO - PROCESS | 1995 | 08:01:18 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:19 INFO - PROCESS | 1995 | RSS: Main: 257175552 08:01:19 INFO - PROCESS | 1995 | 08:01:22 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:22 INFO - PROCESS | 1995 | RSS: Main: 257273856 08:01:22 INFO - PROCESS | 1995 | 08:01:24 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49349/tests/kraken/driver.html?testName=ai-astar) 08:01:24 INFO - PROCESS | 1995 | RSS: Main: 259125248 08:01:24 INFO - PROCESS | 1995 | 08:01:24 INFO - PROCESS | 1995 | __start_tp_report 08:01:24 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 08:01:24 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 08:01:24 INFO - PROCESS | 1995 | |i|pagename|runs| 08:01:24 INFO - PROCESS | 1995 | |0;ai-astar;107;119;119;120;108;168;175;133;118;140 08:01:24 INFO - PROCESS | 1995 | |1;audio-beat-detection;174;148;146;148;112;142;113;114;136;144 08:01:24 INFO - PROCESS | 1995 | |2;audio-dft;206;242;219;265;201;195;196;192;277;251 08:01:24 INFO - PROCESS | 1995 | |3;audio-fft;78;59;85;72;82;80;84;83;70;82 08:01:24 INFO - PROCESS | 1995 | |4;audio-oscillator;91;68;89;75;68;73;108;100;101;98 08:01:24 INFO - PROCESS | 1995 | |5;imaging-gaussian-blur;134;85;111;130;134;86;89;85;89;86 08:01:25 INFO - PROCESS | 1995 | |6;imaging-darkroom;95;95;94;104;139;94;107;149;90;155 08:01:25 INFO - PROCESS | 1995 | |7;imaging-desaturate;88;84;87;88;90;88;92;90;90;90 08:01:25 INFO - PROCESS | 1995 | |8;json-parse-financial;56;57;54;58;58;59;60;59;59;60 08:01:25 INFO - PROCESS | 1995 | |9;json-stringify-tinderbox;74;71;69;75;84;77;71;71;100;107 08:01:25 INFO - PROCESS | 1995 | |10;stanford-crypto-aes;88;85;85;86;83;85;88;87;85;88 08:01:25 INFO - PROCESS | 1995 | |11;stanford-crypto-ccm;143;139;154;148;151;146;163;168;196;155 08:01:25 INFO - PROCESS | 1995 | |12;stanford-crypto-pbkdf2;229;164;233;180;186;155;146;235;220;167 08:01:25 INFO - PROCESS | 1995 | |13;stanford-crypto-sha256-iterative;71;81;70;72;90;59;90;70;70;91 08:01:25 INFO - PROCESS | 1995 | __end_tp_report 08:01:25 INFO - PROCESS | 1995 | __start_cc_report 08:01:25 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,943 08:01:25 INFO - PROCESS | 1995 | __end_cc_report 08:01:25 INFO - PROCESS | 1995 | __startTimestamp1484496084993__endTimestamp 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | ------- Summary: start ------- 08:01:25 INFO - PROCESS | 1995 | Number of tests: 14 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#0] ai-astar Cycles:10 Average:130.70 Median:126.50 stddev:23.74 (18.8%) stddev-sans-first:23.58 08:01:25 INFO - PROCESS | 1995 | Values: 107.0 119.0 119.0 120.0 108.0 168.0 175.0 133.0 118.0 140.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:145.00 stddev:19.70 (13.6%) stddev-sans-first:15.92 08:01:25 INFO - PROCESS | 1995 | Values: 174.0 148.0 146.0 148.0 112.0 142.0 113.0 114.0 136.0 144.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#2] audio-dft Cycles:10 Average:224.40 Median:230.50 stddev:31.74 (13.8%) stddev-sans-first:32.96 08:01:25 INFO - PROCESS | 1995 | Values: 206.0 242.0 219.0 265.0 201.0 195.0 196.0 192.0 277.0 251.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#3] audio-fft Cycles:10 Average:77.50 Median:82.00 stddev:8.20 (10.0%) stddev-sans-first:8.69 08:01:25 INFO - PROCESS | 1995 | Values: 78.0 59.0 85.0 72.0 82.0 80.0 84.0 83.0 70.0 82.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:74.00 stddev:14.94 (20.2%) stddev-sans-first:15.78 08:01:25 INFO - PROCESS | 1995 | Values: 91.0 68.0 89.0 75.0 68.0 73.0 108.0 100.0 101.0 98.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#5] imaging-gaussian-blur Cycles:10 Average:102.90 Median:85.50 stddev:21.94 (25.7%) stddev-sans-first:20.18 08:01:25 INFO - PROCESS | 1995 | Values: 134.0 85.0 111.0 130.0 134.0 86.0 89.0 85.0 89.0 86.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#6] imaging-darkroom Cycles:10 Average:112.20 Median:92.00 stddev:25.27 (27.5%) stddev-sans-first:26.02 08:01:25 INFO - PROCESS | 1995 | Values: 95.0 95.0 94.0 104.0 139.0 94.0 107.0 149.0 90.0 155.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#7] imaging-desaturate Cycles:10 Average:88.70 Median:90.00 stddev:2.21 (2.5%) stddev-sans-first:2.33 08:01:25 INFO - PROCESS | 1995 | Values: 88.0 84.0 87.0 88.0 90.0 88.0 92.0 90.0 90.0 90.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:1.89 (3.2%) stddev-sans-first:1.86 08:01:25 INFO - PROCESS | 1995 | Values: 56.0 57.0 54.0 58.0 58.0 59.0 60.0 59.0 59.0 60.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#9] json-stringify-tinderbox Cycles:10 Average:79.90 Median:72.50 stddev:13.25 (18.3%) stddev-sans-first:13.88 08:01:25 INFO - PROCESS | 1995 | Values: 74.0 71.0 69.0 75.0 84.0 77.0 71.0 71.0 100.0 107.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.50 stddev:1.70 (2.0%) stddev-sans-first:1.64 08:01:25 INFO - PROCESS | 1995 | Values: 88.0 85.0 85.0 86.0 83.0 85.0 88.0 87.0 85.0 88.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#11] stanford-crypto-ccm Cycles:10 Average:156.30 Median:154.50 stddev:16.48 (10.7%) stddev-sans-first:16.76 08:01:25 INFO - PROCESS | 1995 | Values: 143.0 139.0 154.0 148.0 151.0 146.0 163.0 168.0 196.0 155.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.50 Median:203.00 stddev:34.57 (17.0%) stddev-sans-first:33.90 08:01:25 INFO - PROCESS | 1995 | Values: 229.0 164.0 233.0 180.0 186.0 155.0 146.0 235.0 220.0 167.0 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - PROCESS | 1995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:76.50 stddev:10.95 (14.3%) stddev-sans-first:11.43 08:01:25 INFO - PROCESS | 1995 | Values: 71.0 81.0 70.0 72.0 90.0 59.0 90.0 70.0 70.0 91.0 08:01:25 INFO - PROCESS | 1995 | -------- Summary: end -------- 08:01:25 INFO - PROCESS | 1995 | 08:01:25 INFO - TEST-INFO | 1995: exit 0 08:01:26 INFO - TEST-OK | kraken | took 61824ms 08:01:26 INFO - SUITE-END | took 1177s 08:01:26 INFO - Completed test suite (00:19:37) 08:01:26 INFO - javascript benchmark 08:01:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7111.006959464173, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3229.241128334841, 3319.7510186736, 3325.0357396355057, 3353.3796247694163, 3381.0871064812495, 5593.244911936888, 5627.43725627437, 5628.099504079348, 5631.8028868989595, 5679.290088738908, 4264.23243816113, 5661.886762264752, 5718.027935251007, 5729.255196824407, 5757.42425757424, 4982.651214414992, 5208.114620514502, 5228.92156617651, 5248.370195576536, 5278.340207474066, 5218.295530103444, 5243.239730239113, 5262.394824595163, 5291.206319052135, 5296.311479507678, 5151.227315902607, 5287.0, 5290.920636190441, 5300.443453437391, 5314.0, 5112.284280200774, 5153.123968925292, 5176.197689358137, 5248.0, 5257.842264732064, 5074.670146440507, 5131.307273518065, 5191.636585439021, 5283.735813209324, 5292.867678308035, 5731.684757338345, 5824.359320474744, 5832.154337621064, 5854.356020837705, 5868.471837534642, 6136.27400570097, 6142.416470435302, 6180.412860778219, 6261.405166509175, 6305.779297724604, 6225.657588832612, 6262.12330273762, 6263.686815659199, 6273.090401891745, 6305.054241863757, 4845.951540484621, 5837.357890632027, 5843.824685259449, 5846.824595262149, 5852.531797456236, 6204.503639708812, 6215.782447614311, 6233.75064997395, 6249.9062514062325, 6255.280642726054, 6132.233136608343, 6153.723082461211, 6157.0, 6164.951958167033, 6166.722497487534, 6247.156633854372, 6260.311365749764, 6266.655333956676, 6276.340984196685, 6313.873722525524, 5759.136129580513, 5768.740406681625, 5846.912296315559, 5878.382769809194, 6232.906506402408, 6151.169592105098, 6151.323354431009, 6208.037754148114, 6217.253929528486, 6290.370962903765, 4926.4088309403105, 4927.43334516528, 4935.0, 4938.160512712776, 4938.259261110862, 4293.484781826139, 4392.099619577979, 4402.603765661106, 4445.177642136216, 4465.26323156682, 5505.917411238835, 5627.803026894121, 5683.8010669626365, 5758.0, 5822.475977161991, 6227.657478838617, 6239.188905442264, 6240.812775616739, 6244.718987645567, 6267.310595834455, 5587.106063029895, 5646.096624540054, 5680.573956953245, 5739.741711622987, 5818.738156782955, 4463.754493502888, 5365.356157261153, 5427.674339539641, 5432.239486471897, 5497.120460726264, 6167.0, 6167.506599471942, 6190.41191086846, 6235.438810507076, 6285.685715714196, 6247.781327653511, 6263.342349053466, 6269.68651567429, 6278.591891527036, 6303.338149494237, 6263.968680156752, 6289.528285378707, 6291.937080629135, 6309.085182648582, 6336.1446204763615, 6049.969750151221, 6109.84725381869, 6120.508083830795, 6230.532710046674, 6282.246130464374, 6149.739303442873, 6219.657918814509, 6278.937210627835, 6284.183056202664, 6295.968520157553, 5111.769970351269, 6161.845953851011, 6163.291221509405, 6166.136740856194, 6200.534959877937, 5856.9121463178935, 5945.732442040032, 6005.219321488178, 6153.107799369156, 6162.9522981094215, 5755.482006619424, 5882.7352119294555, 5934.1988831508925, 5956.5532585055425, 6005.39946005396, 6114.021756518936, 6156.107364432221, 6161.075838624242, 6175.9382406177165, 6178.289496707756, 5662.292213473316, 5952.464278214981, 5969.253843269591, 5976.342602313655, 5987.13186587951], "value": 5670.494029079531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.90961807638473, 517.6686920370963, 528.6642981706617, 541.7128921671514, 545.6044367833324, 37948.62051379486, 39300.0, 39335.0, 39457.60542394575, 41463.792681036626, 40193.79903100488, 40259.59740402595, 40590.7970460148, 40646.18707625846, 40790.184196316055, 9264.768380790483, 9303.62785488583, 9400.905990940106, 9449.149576538144, 9497.52512374382, 9199.862002069975, 9338.0, 9388.202002829768, 9413.670521531747, 9437.433753974748, 9265.351425400224, 9376.0, 9438.952805235998, 9461.290403219751, 9484.62061517542, 9361.719148425558, 9418.905810941871, 9427.811443771156, 9429.764255893624, 9437.386569872937, 9159.862602060974, 9246.491442970633, 9349.719508414759, 9357.064293570656, 9363.391379560375, 38799.61200387988, 38938.0, 39270.018249543704, 39282.803585982176, 39291.41062884059, 3196.6323872754697, 3451.8446669899663, 3504.1414853360834, 3847.7883716395586, 3947.980260098681, 27397.17808465729, 28273.0, 29088.563671544944, 29613.259668508243, 29700.257493562618, 3159.3523327717994, 3203.6315823680343, 3220.1949512621845, 3220.72623826975, 3270.689284517967, 382935.0, 384438.0, 386849.0, 387423.9999999972, 388027.0, 42067.36898946518, 55319.17021244684, 55461.1680824788, 55533.44466555283, 55727.164092538645, 58273.708631456575, 58854.0, 59060.409395906354, 59105.0, 59204.70397647984, 15739.842601574066, 15839.52481425559, 15981.920090399473, 16001.759973600405, 16077.437289694804, 12476.875231247754, 12560.937195313965, 12698.555550555686, 12703.745925081446, 12715.809262861065, 12564.874351256552, 14267.143971361544, 14713.190774507291, 14820.147481564805, 14820.407183712747, 2772.542530482488, 5402.324709411324, 5745.454181852718, 6400.839979000469, 6558.737650494022, 866.9263112635371, 948.4214629076258, 948.5446985447024, 1008.9557308186139, 1038.127972503101, 23973.52052958966, 28729.712702872705, 29092.709072909423, 29212.85393573061, 29560.0, 873.6767396063498, 929.5352323838081, 1040.9271351005357, 1051.6109039655375, 1064.5794911010107, 14787.852121478647, 15233.933624646168, 15292.923535382475, 15484.690306194037, 15503.302351394213, 663502.0, 671299.0, 671853.0, 672567.0, 674867.0, 55220.89558208894, 55258.723706382014, 55688.443115569135, 55735.16397253963, 55737.0, 1321.729045545661, 1339.8995075369191, 1361.0404664711355, 1367.070392133339, 1371.190997311571, 28822.0, 29460.0, 29477.705222948352, 29676.10971670853, 29991.85004075053, 44582.777086114365, 44814.0, 44885.877853053935, 44886.55113448954, 44893.55106448894, 611885.0, 615058.0, 616260.0, 616414.0, 617602.0, 25221.495570088864, 25461.618075728507, 25489.872550637127, 25552.0, 25928.740712592633, 37552.0, 43253.56746432495, 44953.77523112363, 45127.77436112799, 45780.0, 36529.45205821968, 36859.0, 37488.625113748516, 38464.80767596144, 38920.80539597284, 37270.06824829401, 37307.626923730415, 37756.0, 38008.80995595004, 38553.843384698506, 36769.0, 36899.26201475902, 36931.0, 37581.4362784553, 37718.057048574, 32241.0, 32860.34279314352, 33731.494027590095, 34451.96644100681, 34494.82752586221, 25070.874645626656, 25720.614190787528, 25828.96684132689, 25854.965801368486, 25855.871489129477], "value": 19062.82290665973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.32534930139724, 351.21853875127846, 365.43722667092663, 375.41435360837096, 383.1092709450528, 17539.0, 18833.529161770963, 19214.0, 19292.807071929277, 19447.0, 19562.510937226576, 19963.800361996375, 20059.398218053444, 20361.796382036177, 20454.07956641951, 4581.954180458203, 5859.32617748959, 6105.6947152642415, 6117.816465506042, 6127.89697854386, 5884.4703976642095, 5995.0, 6066.726997285111, 6085.695715214244, 6088.1476593276975, 5869.50109240715, 5967.6121052131475, 6028.939710602904, 6158.137860699506, 6509.576877502971, 6536.705848236841, 6552.574082684634, 6570.310117437648, 6594.6372949487995, 6605.174353205849, 5652.123920792284, 5831.883362332772, 5880.529557635422, 5888.97055514724, 5890.440408161217, 17776.91111544434, 23789.0, 24447.51104977908, 24558.50882982348, 24712.13507527228, 2213.236433430464, 2226.0, 2319.489712263299, 2337.9298621041394, 2859.4995875721875, 9717.757056073584, 9825.164860986824, 9950.800983980353, 10197.290230568098, 10396.116330111874, 1614.3381213702326, 1790.3196785221533, 1809.0864113622536, 1822.0980614595728, 1864.7855496617926, 112888.43555782251, 114550.42724786323, 115207.0, 116636.0, 118591.0, 11347.602833900939, 11516.424178791027, 11717.414129293502, 11719.941400292944, 11776.646700598996, 12144.939275303566, 14309.0, 14684.853151468562, 14737.778933316009, 14745.705085898222, 6954.617496037767, 8456.492610443393, 8556.871646925301, 8686.0, 8724.127587241224, 8492.320614350838, 8504.192101750448, 8538.530380829114, 8650.307975361957, 8664.95667521671, 4400.75795831226, 4454.732716037048, 4496.7077139985795, 4559.931601025987, 4561.566651168134, 1579.431404694309, 1877.2209533043633, 1920.817522335376, 1993.481694759344, 1993.9501512462305, 837.3970741066422, 864.8702694595735, 871.8430682477215, 898.6315610599622, 982.8967958364411, 20112.497187570134, 20225.089870955842, 20428.285010024578, 20483.59032819365, 20754.688679669816, 802.6829402386142, 862.1895418306772, 875.9737207883774, 908.5321059654283, 934.4019827310527, 8889.777755556162, 10337.0, 10828.97124773161, 10945.83581246282, 10957.986888391435, 593682.0, 600119.0, 605059.0, 612599.0, 614687.0, 120162.79837201517, 121711.0, 124382.0, 124463.0, 126203.0, 853.8121613245077, 877.5349064995562, 1013.3514550687565, 1017.6743442098606, 1018.2464975917768, 18704.719429208846, 18949.810501894804, 19147.04264786783, 19190.13644385978, 19272.22911083541, 39970.0, 50336.0, 54376.0, 55216.723916381765, 56103.71948140233, 69836.30163698501, 69979.0, 78085.21914780779, 80345.0, 81597.59201203956, 7772.300492955661, 8141.0, 8184.181581841768, 8259.710910118118, 8286.171382861665, 10689.57241710354, 12416.006719462603, 12676.176048556814, 12801.487940482277, 12840.678983025498, 10958.01377875995, 11073.83389249178, 11210.43947802623, 11398.259113157617, 11461.942690286494, 10389.37663740178, 10585.153187745116, 10614.575416983234, 10637.521311540844, 10677.0, 9212.861807073034, 11007.559697612327, 11192.664220073411, 11226.831597525881, 11608.12939029593, 7973.880391794011, 8067.757967260992, 8205.58972051407, 8307.044689860744, 8344.457610255315, 10018.64934727281, 10810.67567972962, 10909.454527273763, 11219.270747401393, 11328.0], "value": 9438.695929259551, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.0, 1493.0519120358572, 1652.454689952316, 1779.0837718574928, 1829.9817001829986, 7481.6259187040705, 7724.536527808322, 8004.919950800498, 8451.788705282372, 8476.491410515366, 7871.488353257034, 8202.097769245378, 8202.548859812709, 8309.127541608135, 8317.875231871527, 2307.6884620576175, 2342.5666251743396, 2356.9528609427803, 2357.434215788207, 2360.8819559022068, 2347.319277409558, 2365.8107351411845, 2388.7850093491584, 2395.6646069550275, 2397.2328854766483, 2336.0538981712434, 2341.180586794617, 2360.976390236093, 2362.0905951208824, 2362.8227882908764, 2322.3149170994598, 2323.337848713117, 2328.5692146952697, 2352.6706261123454, 2354.682117914085, 2343.8359314847967, 2348.131191459154, 2352.2472808701223, 2369.2655276864057, 2379.5003049359657, 8329.208725171098, 8367.748967530923, 8391.454555453876, 8436.662533498653, 8453.873191902127, 4998.12532806761, 5110.386753589593, 5120.846374608767, 5145.459726728677, 5154.613403994678, 3021.169178475937, 3414.487826825996, 3453.913652158691, 3475.8088305143206, 3527.153483164048, 1045.5451878432907, 1061.3578784835217, 1077.7144056824948, 1091.6615849086809, 1097.462243500687, 9655.90344096557, 10133.746656333651, 10880.0, 10951.945240273828, 10979.945100274528, 4269.765162916007, 4425.601695847389, 4482.663800214997, 4502.392177056121, 4502.617277531381, 8559.058503564604, 8614.741557753277, 8651.6106775194, 8671.4363566368, 8678.86981695275, 5077.568406685473, 5095.286659867622, 5098.439171691111, 5101.566366858784, 5105.2342148678, 4268.274393353137, 4430.335449682509, 4628.514006029386, 4705.529447055335, 4752.714837109785, 2953.9808765975704, 3420.6237313895454, 3465.1683595937297, 3497.7026952709307, 3541.982290088533, 1115.7489564847845, 1131.6491887514896, 1133.1218305812897, 1133.880942501042, 1142.6400683784582, 799.152897928198, 862.508370228976, 863.1411745313453, 880.5245167609547, 900.7522931193843, 5565.6920623653405, 5598.440155984369, 5765.740541675635, 5860.824175274749, 5981.611195272293, 820.4420993724325, 928.3269629518545, 932.147085416836, 941.3598752847992, 946.786972931085, 3618.7105031597407, 3833.3483307837732, 3847.3074846527893, 3915.960840391617, 3967.0875698589484, 9789.461579613047, 10056.84914726265, 10099.747506312255, 10180.981901809908, 10181.54183061764, 9622.615095396106, 10152.39085654863, 10173.54219060144, 10179.287449878437, 10186.185105191715, 7652.885206721904, 7761.650725717356, 7805.609719514116, 7813.687452501837, 7835.608219588998, 4904.386951631046, 5299.761510731949, 5628.549716022791, 5662.207290979349, 5868.972929737193, 8946.060663630486, 9186.724398268063, 9268.907310927074, 9384.249260059316, 9401.623935042522, 9171.77070573241, 9382.87405511343, 9441.0, 9499.62001519959, 9510.762230944005, 7202.423806095395, 7244.927550724426, 7261.636918153966, 7326.4138868889295, 7376.114866216089, 6622.0, 7894.842103158019, 7921.089074756477, 7922.643481043482, 7943.602819858868, 7135.785926422215, 7210.1708303545765, 7219.0976127984, 7262.891056634049, 7335.669894854851, 6960.443164546926, 7089.82275443118, 7104.715811367694, 7126.5011449198055, 7221.711131554679, 6603.636799976048, 6738.157730283715, 6741.1236539249585, 6754.18949726036, 6758.898616520658, 4833.226683730586, 4857.562819346276, 4910.263460480814, 4914.533119353656, 5009.423916249678, 4831.589314908131, 4893.510648935078, 4925.778339974638, 4950.975245123751, 5021.6735912165595], "value": 4387.5626883235855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.69759079467815, 297.32507208636395, 313.25445439853155, 314.7670723664489, 316.7893350921637, 5306.389765176996, 5324.387695415028, 5444.782208711652, 5474.0, 5568.443155684429, 5139.0, 5289.56679927233, 5524.005678977783, 5529.599296432695, 5609.943900560993, 3709.4250391189275, 3870.20660764544, 3942.9156981829938, 4203.894902627429, 4244.299690551055, 3499.860005599786, 4113.588641135892, 4243.596858298457, 4262.637675797561, 4322.222000039991, 3652.817359132046, 4167.937480937789, 4194.517630472505, 4212.283911735012, 4247.065645557972, 4213.873583792491, 4237.258479766044, 4245.448091748084, 4262.552431994627, 4271.9572804271875, 3620.294042661682, 3708.2200543738886, 3711.498947642088, 3724.75220801032, 3728.2170744143764, 4388.385626012361, 4537.523560026216, 5184.403793563751, 5306.893862122774, 5413.861524697722, 4038.576853887673, 4172.895677608054, 4229.386738922839, 4642.326862604903, 4800.279958006292, 5091.257925424809, 5785.855353616151, 5802.622829516068, 5804.419558044204, 5819.592628516006, 3847.711421643388, 4009.4186342980106, 4072.2873497137884, 4086.979565102185, 4119.773412462313, 6074.848128796772, 6089.756409743605, 6101.389861013908, 6123.8162855114415, 6126.632402055891, 4113.773742444194, 4116.464859568297, 4132.586741325904, 4138.806432590732, 4142.875713728593, 3404.5744281964753, 4024.3158663027357, 4124.484439445069, 4163.687723420695, 4164.916701665949, 4429.003474218275, 4639.724075879093, 4724.976375118103, 4830.516948305141, 4870.780814863339, 4897.3878265216845, 4929.531694489017, 5581.0, 5727.284089488814, 5816.5928385013485, 1238.9442475088642, 1253.8181963615225, 1290.4322098276728, 1329.936051159069, 1342.3221273257138, 823.259066839849, 866.2290561400358, 887.9156480134377, 915.3272344826547, 925.3383830561181, 5222.190560463135, 5234.450382709761, 5235.764390602432, 5254.737263136828, 5260.9736951315, 4961.801527938915, 5432.0, 5540.944590554042, 5587.7485513152005, 5722.08173831349, 4337.544557821383, 4802.327674125625, 4823.324734537167, 5203.895922081537, 5238.371395432497, 2511.9246422606984, 2701.419194873112, 2996.9100926972224, 3011.969880301213, 3012.3071693510615, 5415.918761218585, 5796.913046304308, 5885.793997210163, 5931.436513531207, 5975.952264345216, 4646.372739680168, 4996.650234483552, 5793.942060579425, 5813.563982701315, 5879.412058794172, 5756.136579513023, 5804.401271211876, 5836.620619659709, 5858.56060795442, 5866.50134738552, 4946.664400611887, 5421.430749771375, 5658.971705141613, 5716.742746576498, 5717.912327343188, 4837.0, 5131.332316997065, 5172.060477321004, 5575.0522411191005, 5632.479230607795, 5566.693831839126, 5787.826365209051, 5848.239728835224, 5852.882942341044, 5862.0, 3694.9552893537107, 3928.2339943710704, 3929.936783188849, 3937.4684417604403, 3967.4247234150307, 4628.0, 4817.1810792164715, 4841.419029716316, 5691.174779656843, 5812.73842677089, 5680.346760122474, 5695.943040569541, 5890.0, 5898.286788077532, 5900.43945825146, 5388.811391601275, 5876.529877609695, 5882.235309409921, 5887.852803679943, 5893.410658934244, 5525.751341189576, 5571.220029195997, 5649.915251271316, 5703.942960570507, 5746.9712651436475, 5351.491608297206, 5571.749271282721, 5858.209141765807, 5886.997631208029, 5917.792877249276, 4445.488768791501, 5097.337346144977, 5661.66030038199, 5723.796338409659, 5834.708264586839], "value": 4157.418976808968, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.7610684046901, 693.4764252988992, 705.5237714542683, 762.291069305546, 808.6320724070548, 13697.452101915924, 14077.366518506666, 14345.426182952682, 14422.783658245135, 14512.854871451296, 13048.73902521949, 13284.667883302922, 13292.800607990888, 13301.201927884309, 13336.33318334082, 810.3395732478026, 811.0956283743612, 822.2065706593137, 823.0041649603986, 823.6170180865896, 641.2881701311541, 663.4161937494997, 809.1706001348635, 825.4964471672275, 838.0990435282066, 869.0353707384797, 869.4261787220436, 872.0363997782454, 873.3013589128672, 874.9737507874773, 862.0302160069921, 864.5936409887343, 864.9524276164808, 866.23338345564, 866.5147517390282, 630.9905351419733, 647.6049609738056, 648.1250312078703, 648.7761722205831, 650.4113777031794, 13405.798913016313, 13484.730305393936, 13506.0, 13522.918166546653, 13590.32048397586, 12897.09720319578, 13062.27943734782, 13364.131331463424, 13398.732025359535, 13456.93271533646, 10422.478876056166, 10799.190060745475, 10809.135269178447, 10893.727656808564, 11180.720481987933, 3549.804760738158, 3600.747947643666, 3627.7097832173363, 3636.272745450894, 3642.0, 66451.0, 78469.60765196195, 78824.0, 82581.0, 82728.0, 8711.869321960176, 9698.042295952457, 9919.851202231972, 10106.0, 10211.387316760869, 20096.69854952177, 20153.294634687714, 20159.596808063758, 20368.185272589228, 20546.383608491768, 5705.914411283834, 7257.201707812136, 7263.89104163438, 7452.515586486969, 7589.43079269057, 3332.7000569948823, 4100.856470023535, 4198.412222288882, 4351.694491652492, 4363.52001279859, 3313.5858017747782, 3383.695467407945, 3411.403004474207, 3422.8117453540294, 3459.3254315408253, 626.6490765171518, 639.338284875152, 643.8132941447021, 648.2771709543824, 660.8876490996543, 584.6316820403118, 617.9227596550431, 626.9373062693785, 642.7493277621732, 672.3881268046055, 7154.964225178841, 8641.351898607629, 8674.349423793241, 8816.911830881609, 8963.596638151299, 637.3930623748889, 642.1267076775581, 667.3226674924955, 668.759246671198, 673.0879658063254, 3768.812823960444, 4043.0274444245333, 4238.173556156582, 4339.218940590661, 4353.172897149531, 67579.32420675829, 102180.97819021864, 106779.0, 120013.0, 120944.39527802305, 98588.50705746569, 100867.0, 101761.0, 102592.0, 104986.0, 65569.67215163894, 70277.2972270281, 89191.0, 91153.54423227841, 91809.0, 8109.878351824609, 8357.498550087013, 8533.957330213558, 8569.442986205877, 8601.612927418157, 56405.0, 58214.0, 58606.0, 59060.40939590549, 59826.40173598209, 37232.0, 52354.47645523496, 74413.62793186, 77540.22459775556, 80513.59743201247, 8777.868331974898, 9114.589843457194, 10600.4699765013, 10744.731381715206, 11005.669829905115, 10192.235582331206, 12029.398530073637, 12090.576829810914, 12098.395080245777, 12111.45498452554, 9026.18764311215, 10940.835887461535, 11403.315801051964, 11532.481038353462, 11656.18406711522, 11552.884471155518, 11648.301101933912, 11788.29270243788, 11792.882071179522, 11849.170558060852, 9984.0, 11443.485043173243, 11634.825477618011, 11879.643610691694, 11984.64046078619, 8527.360447966552, 10117.494125293853, 10277.845832312372, 10509.78980420372, 10518.421486818299, 10512.526936287732, 10517.0, 10626.787464250518, 10813.783724325313, 10961.232713709964], "value": 6946.635217831581, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 119.0, 120.0, 108.0, 168.0, 175.0, 133.0, 118.0, 140.0], "value": 130.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 148.0, 146.0, 148.0, 112.0, 142.0, 113.0, 114.0, 136.0, 144.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 242.0, 219.0, 265.0, 201.0, 195.0, 196.0, 192.0, 277.0, 251.0], "value": 224.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 85.0, 72.0, 82.0, 80.0, 84.0, 83.0, 70.0, 82.0], "value": 77.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 89.0, 75.0, 68.0, 73.0, 108.0, 100.0, 101.0, 98.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 85.0, 111.0, 130.0, 134.0, 86.0, 89.0, 85.0, 89.0, 86.0], "value": 102.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 104.0, 139.0, 94.0, 107.0, 149.0, 90.0, 155.0], "value": 112.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 88.0, 90.0, 88.0, 92.0, 90.0, 90.0, 90.0], "value": 88.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 69.0, 75.0, 84.0, 77.0, 71.0, 71.0, 100.0, 107.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 86.0, 83.0, 85.0, 88.0, 87.0, 85.0, 88.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 154.0, 148.0, 151.0, 146.0, 163.0, 168.0, 196.0, 155.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 164.0, 233.0, 180.0, 186.0, 155.0, 146.0, 235.0, 220.0, 167.0], "value": 191.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 70.0, 72.0, 90.0, 59.0, 90.0, 70.0, 70.0, 91.0], "value": 76.4, "unit": "score"}]}]} 08:01:26 INFO - Return code: 0 08:01:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:01:26 ERROR - # TBPL SUCCESS # 08:01:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:01:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:01:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:01:26 INFO - 2017-01-15 08:01:26.304 screenresolution[2000:16151] starting screenresolution argv=screenresolution get 08:01:26 INFO - 2017-01-15 08:01:26.306 screenresolution[2000:16151] Display 0: 1600x1200x32@60 08:01:26 INFO - 2017-01-15 08:01:26.312 screenresolution[2001:16154] starting screenresolution argv=screenresolution list 08:01:26 INFO - Available Modes on Display 0 08:01:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:01:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:01:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:01:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:01:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:01:26 INFO - Intel Iris: 08:01:26 INFO - Chipset Model: Intel Iris 08:01:26 INFO - Type: GPU 08:01:26 INFO - Bus: Built-In 08:01:26 INFO - VRAM (Dynamic, Max): 1536 MB 08:01:26 INFO - Vendor: Intel (0x8086) 08:01:26 INFO - Device ID: 0x0a2e 08:01:26 INFO - Revision ID: 0x0009 08:01:26 INFO - Displays: 08:01:26 INFO - Display: 08:01:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:01:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:01:26 INFO - Display Serial Number: 1600x1200 60 08:01:26 INFO - Main Display: Yes 08:01:26 INFO - Mirror: Off 08:01:26 INFO - Online: Yes 08:01:26 INFO - Rotation: Supported 08:01:26 INFO - Return code: 0 08:01:26 INFO - Running post-action listener: _resource_record_post_action 08:01:26 INFO - [mozharness: 2017-01-15 16:01:26.562174Z] Finished run-tests step (success) 08:01:26 INFO - Running post-run listener: _resource_record_post_run 08:01:26 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 356352; Write bytes: 665624576; Read time: 6; Write time: 1970 08:01:26 INFO - TinderboxPrint: CPU usage
54.3% 08:01:26 INFO - TinderboxPrint: I/O read bytes / time
356,352 / 6 08:01:26 INFO - TinderboxPrint: I/O write bytes / time
665,624,576 / 1,970 08:01:26 INFO - TinderboxPrint: CPU idle
2,209.3 (45.7%) 08:01:26 INFO - TinderboxPrint: CPU system
979.3 (20.2%) 08:01:26 INFO - TinderboxPrint: CPU user
1,649.1 (34.1%) 08:01:26 INFO - TinderboxPrint: Swap in / out
348,905,472 / 0 08:01:26 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 348303872; Write bytes: 345458688; Read time: 26889; Write time: 644 08:01:26 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 229376; Write bytes: 312903680; Read time: 4; Write time: 1295 08:01:27 INFO - Running post-run listener: _upload_blobber_files 08:01:27 INFO - Blob upload gear active. 08:01:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:27 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:01:27 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:01:27 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:01:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:01:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:01:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:28 INFO - (blobuploader) - INFO - Done attempting. 08:01:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:01:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:01:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:29 INFO - (blobuploader) - INFO - Done attempting. 08:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:31 INFO - (blobuploader) - INFO - Done attempting. 08:01:31 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:31 INFO - Return code: 0 08:01:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7b243449d45d02f2181b256f30c3e06c7ff07b3c7eac7c09b533e38f2ea3c3d5bcb6d900e5af74c7787de3b6d67a3d8db6ca2ba26a98bea4cf58ece4ac60c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba03203d269b50385c87970ec3b6e01a4ec558fc4ffa49a67ac9b58ebb5b02aa9d1ff1b85744afe9d137f6810ce46156e88ff5b471ae91ee8e04de4241caa25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3807c4bf378c0699bdaab0b184165c5ca1a2e6e2ca6e6f57b3ea0cb8039a39b5a394e758d2f04aebf67aeb511ac6d6c854da36969f47b213f458189340262c"} 08:01:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:31 INFO - Contents: 08:01:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7b243449d45d02f2181b256f30c3e06c7ff07b3c7eac7c09b533e38f2ea3c3d5bcb6d900e5af74c7787de3b6d67a3d8db6ca2ba26a98bea4cf58ece4ac60c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba03203d269b50385c87970ec3b6e01a4ec558fc4ffa49a67ac9b58ebb5b02aa9d1ff1b85744afe9d137f6810ce46156e88ff5b471ae91ee8e04de4241caa25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3807c4bf378c0699bdaab0b184165c5ca1a2e6e2ca6e6f57b3ea0cb8039a39b5a394e758d2f04aebf67aeb511ac6d6c854da36969f47b213f458189340262c"} 08:01:31 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:31 INFO - Copying logs to upload dir... 08:01:31 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.712461 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-15 08:01:31.462700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 08:01:31.466207) ========= 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.1u90pwlYhn/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.oO2FqB18Gr/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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/a7b243449d45d02f2181b256f30c3e06c7ff07b3c7eac7c09b533e38f2ea3c3d5bcb6d900e5af74c7787de3b6d67a3d8db6ca2ba26a98bea4cf58ece4ac60c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba03203d269b50385c87970ec3b6e01a4ec558fc4ffa49a67ac9b58ebb5b02aa9d1ff1b85744afe9d137f6810ce46156e88ff5b471ae91ee8e04de4241caa25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3807c4bf378c0699bdaab0b184165c5ca1a2e6e2ca6e6f57b3ea0cb8039a39b5a394e758d2f04aebf67aeb511ac6d6c854da36969f47b213f458189340262c"} build_url:https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/EJpjIjxVR6ubefd7MKjoVg/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/a7b243449d45d02f2181b256f30c3e06c7ff07b3c7eac7c09b533e38f2ea3c3d5bcb6d900e5af74c7787de3b6d67a3d8db6ca2ba26a98bea4cf58ece4ac60c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ba03203d269b50385c87970ec3b6e01a4ec558fc4ffa49a67ac9b58ebb5b02aa9d1ff1b85744afe9d137f6810ce46156e88ff5b471ae91ee8e04de4241caa25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3807c4bf378c0699bdaab0b184165c5ca1a2e6e2ca6e6f57b3ea0cb8039a39b5a394e758d2f04aebf67aeb511ac6d6c854da36969f47b213f458189340262c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 08:01:31.500538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 08:01:31.500867) ========= 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.1u90pwlYhn/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.oO2FqB18Gr/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005353 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 08:01:31.549299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 08:01:31.549591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 08:01:31.549905) ========= ========= Total master_lag: 0.18 =========