builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0204 starttime: 1485014660.54 results: success (0) buildid: 20170121070324 builduid: b6ed1739d3b74464a0cfe2ff37864145 revision: b58eb6e9e6c683cd32855ad927990fa6d585a1a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:20.541206) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:20.541778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:20.542111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:20.572070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:20.572884) ========= 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.L2BL11ISPM/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.V0cK9UCUzj/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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-21 08:04:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 63.1M=0s 2017-01-21 08:04:21 (63.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.593492 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:21.193511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:21.193874) ========= 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.L2BL11ISPM/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.V0cK9UCUzj/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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.026024 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:21.244741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-21 08:04:21.245109) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b58eb6e9e6c683cd32855ad927990fa6d585a1a8 --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 b58eb6e9e6c683cd32855ad927990fa6d585a1a8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L2BL11ISPM/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.V0cK9UCUzj/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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-21 08:04:21,346 truncating revision to first 12 chars 2017-01-21 08:04:21,346 Setting DEBUG logging. 2017-01-21 08:04:21,346 attempt 1/10 2017-01-21 08:04:21,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b58eb6e9e6c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-21 08:04:23,357 unpacking tar archive at: mozilla-aurora-b58eb6e9e6c6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.265126 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-21 08:04:23.538056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:23.538864) ========= script_repo_revision: b58eb6e9e6c683cd32855ad927990fa6d585a1a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:23.539875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:23.540476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 08:04:23.561323) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-21 08:04:23.562102) ========= /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.L2BL11ISPM/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.V0cK9UCUzj/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:04:23 INFO - MultiFileLogger online at 20170121 08:04:23 in /builds/slave/test 08:04:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:04:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:23 INFO - {'append_to_log': False, 08:04:23 INFO - 'base_work_dir': '/builds/slave/test', 08:04:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:04:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:23 INFO - 'branch': 'Mozilla-Aurora', 08:04:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:23 INFO - 'config_files': ('talos/mac_config.py',), 08:04:23 INFO - 'default_actions': ('clobber', 08:04:23 INFO - 'read-buildbot-config', 08:04:23 INFO - 'download-and-extract', 08:04:23 INFO - 'populate-webroot', 08:04:23 INFO - 'create-virtualenv', 08:04:23 INFO - 'install', 08:04:23 INFO - 'run-tests'), 08:04:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:23 INFO - 'download_minidump_stackwalk': True, 08:04:23 INFO - 'download_symbols': 'ondemand', 08:04:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:23 INFO - 'installer_path': 'installer.exe', 08:04:23 INFO - 'log_level': 'info', 08:04:23 INFO - 'log_name': 'talos', 08:04:23 INFO - 'log_to_console': True, 08:04:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:04:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:04:23 INFO - 'opt_config_files': (), 08:04:23 INFO - 'pip_index': False, 08:04:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:04:23 INFO - 'cmd': ('bash', 08:04:23 INFO - '-c', 08:04:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:04:23 INFO - 'enabled': True, 08:04:23 INFO - 'halt_on_failure': False, 08:04:23 INFO - 'name': 'check_screen_resolution'},), 08:04:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:04:23 INFO - 'cmd': ('bash', 08:04:23 INFO - '-c', 08:04:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:04:23 INFO - 'enabled': True, 08:04:23 INFO - 'halt_on_failure': False, 08:04:23 INFO - 'name': 'check_screen_resolution'},), 08:04:23 INFO - 'run_cmd_checks_enabled': True, 08:04:23 INFO - 'sps_profile': False, 08:04:23 INFO - 'sps_profile_interval': 0, 08:04:23 INFO - 'suite': 'dromaeojs-e10s', 08:04:23 INFO - 'system_bits': '32', 08:04:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:23 INFO - 'title': 't-yosemite-r7-0204', 08:04:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:23 INFO - 'use_talos_json': True, 08:04:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:23 INFO - 'work_dir': 'build'} 08:04:23 INFO - [mozharness: 2017-01-21 16:04:23.770348Z] Running clobber step. 08:04:23 INFO - Running pre-action listener: _resource_record_pre_action 08:04:23 INFO - Running main action method: clobber 08:04:23 INFO - rmtree: /builds/slave/test/build 08:04:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:26 INFO - Running post-action listener: _resource_record_post_action 08:04:26 INFO - [mozharness: 2017-01-21 16:04:26.374088Z] Finished clobber step (success) 08:04:26 INFO - [mozharness: 2017-01-21 16:04:26.374252Z] Running read-buildbot-config step. 08:04:26 INFO - Running pre-action listener: _resource_record_pre_action 08:04:26 INFO - Running main action method: read_buildbot_config 08:04:26 INFO - Using buildbot properties: 08:04:26 INFO - { 08:04:26 INFO - "project": "", 08:04:26 INFO - "product": "firefox", 08:04:26 INFO - "script_repo_revision": "production", 08:04:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:04:26 INFO - "repository": "", 08:04:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:04:26 INFO - "buildid": "20170121070324", 08:04:26 INFO - "pgo_build": "False", 08:04:26 INFO - "basedir": "/builds/slave/test", 08:04:26 INFO - "buildnumber": 39, 08:04:26 INFO - "slavename": "t-yosemite-r7-0204", 08:04:26 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:04:26 INFO - "platform": "yosemite_r7", 08:04:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:04:26 INFO - "branch": "mozilla-aurora", 08:04:26 INFO - "repo_path": "releases/mozilla-aurora", 08:04:26 INFO - "revision": "b58eb6e9e6c683cd32855ad927990fa6d585a1a8", 08:04:26 INFO - "stage_platform": "macosx64", 08:04:26 INFO - "builduid": "b6ed1739d3b74464a0cfe2ff37864145", 08:04:26 INFO - "slavebuilddir": "test" 08:04:26 INFO - } 08:04:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:04:26 INFO - Running post-action listener: _resource_record_post_action 08:04:26 INFO - [mozharness: 2017-01-21 16:04:26.377855Z] Finished read-buildbot-config step (success) 08:04:26 INFO - [mozharness: 2017-01-21 16:04:26.377984Z] Running download-and-extract step. 08:04:26 INFO - Running pre-action listener: _resource_record_pre_action 08:04:26 INFO - Running main action method: download_and_extract 08:04:26 INFO - mkdir: /builds/slave/test/build/tests 08:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:26 INFO - trying https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:04:26 INFO - Downloading https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:04:27 INFO - Downloaded 1199 bytes. 08:04:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:04:27 INFO - Using the following test package requirements: 08:04:27 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:04:27 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:04:27 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:04:27 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'jsshell-mac.zip'], 08:04:27 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:04:27 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:04:27 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:04:27 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:04:27 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:04:27 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:04:27 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:04:27 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:04:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:04:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:04:27 INFO - Fetch https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:04:27 INFO - Http code: 200 08:04:27 INFO - via: 1.1 6e65abb04cb818a6ec78111935b507f7.cloudfront.net (CloudFront) 08:04:27 INFO - x-amz-cf-id: OJ_O-g0daWSxG-RLXVoF2CfJYoh-eQtqmPMi2Ves3kt2J7KX-JIsAA== 08:04:27 INFO - x-amz-version-id: lrzOdeAGfFkFKDiJ3DQO9r.rLkvTbpzh 08:04:28 INFO - Expected file size: 16277533 08:04:28 INFO - Obtained file size: 16277533 08:04:34 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:04:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:04:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:04:34 INFO - Fetch https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:04:35 INFO - Http code: 200 08:04:35 INFO - via: 1.1 0576b942ae9f4fc9c0b62b0736e9bfd6.cloudfront.net (CloudFront) 08:04:35 INFO - x-amz-cf-id: fSUHS8MgaQUd5D4JrWxnlcNjB7lsR9AuI4jYVQay76UBQdVF9EfTmw== 08:04:35 INFO - x-amz-version-id: lrzOdeAGfFkFKDiJ3DQO9r.rLkvTbpzh 08:04:35 INFO - Expected file size: 16277533 08:04:35 INFO - Obtained file size: 16277533 08:04:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:04:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:04:42 INFO - Fetch https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:04:43 INFO - Http code: 200 08:04:43 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 08:04:43 INFO - x-amz-cf-id: eZE-BB_H25HhKBWFv4fUV4B0yZFmT-wtvqhHU4ft2sB-pfZddH5CfQ== 08:04:43 INFO - x-amz-version-id: IZKJRgkDaO.6Cw37smZeEfOGM2_ys8cG 08:04:43 INFO - Expected file size: 14402992 08:04:43 INFO - Obtained file size: 14402992 08:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:43 INFO - trying https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:04:43 INFO - Downloading https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:04:46 INFO - Downloaded 110607605 bytes. 08:04:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:04:46 INFO - mkdir: /builds/slave/test/properties 08:04:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:46 INFO - Contents: 08:04:46 INFO - build_url:https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:04:47 INFO - Running post-action listener: _resource_record_post_action 08:04:47 INFO - Running post-action listener: set_extra_try_arguments 08:04:47 INFO - [mozharness: 2017-01-21 16:04:47.255657Z] Finished download-and-extract step (success) 08:04:47 INFO - [mozharness: 2017-01-21 16:04:47.255788Z] Running populate-webroot step. 08:04:47 INFO - Running pre-action listener: _resource_record_pre_action 08:04:47 INFO - Running main action method: populate_webroot 08:04:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:47 INFO - '--tppagecycles', 08:04:47 INFO - '7'], 08:04:47 INFO - 'tests': ['tsvgm']}}, 08:04:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:04:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:04:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:04:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['damp', 'tps']}, 08:04:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'tests': ['damp', 'tps']}, 08:04:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['dromaeo_dom']}, 08:04:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['basic_compositor_video']}, 08:04:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:04:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['a11yr', 08:04:47 INFO - 'ts_paint', 08:04:47 INFO - 'tpaint', 08:04:47 INFO - 'sessionrestore', 08:04:47 INFO - 'sessionrestore_no_auto_restore', 08:04:47 INFO - 'tabpaint']}, 08:04:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:04:47 INFO - 'ts_paint', 08:04:47 INFO - 'tpaint', 08:04:47 INFO - 'sessionrestore', 08:04:47 INFO - 'sessionrestore_no_auto_restore', 08:04:47 INFO - 'tabpaint']}, 08:04:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:04:47 INFO - 'ts_paint', 08:04:47 INFO - 'tpaint', 08:04:47 INFO - 'sessionrestore', 08:04:47 INFO - 'sessionrestore_no_auto_restore', 08:04:47 INFO - 'tabpaint']}, 08:04:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:04:47 INFO - 'ts_paint', 08:04:47 INFO - 'tpaint', 08:04:47 INFO - 'sessionrestore', 08:04:47 INFO - 'sessionrestore_no_auto_restore', 08:04:47 INFO - 'tabpaint']}, 08:04:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['a11yr', 08:04:47 INFO - 'ts_paint', 08:04:47 INFO - 'tpaint', 08:04:47 INFO - 'sessionrestore', 08:04:47 INFO - 'sessionrestore_no_auto_restore', 08:04:47 INFO - 'tabpaint']}, 08:04:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['a11yr', 08:04:47 INFO - 'ts_paint', 08:04:47 INFO - 'tpaint', 08:04:47 INFO - 'sessionrestore', 08:04:47 INFO - 'sessionrestore_no_auto_restore', 08:04:47 INFO - 'tabpaint']}, 08:04:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['tsvgx', 08:04:47 INFO - 'tsvgr_opacity', 08:04:47 INFO - 'tart', 08:04:47 INFO - 'tscrollx', 08:04:47 INFO - 'cart']}, 08:04:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:04:47 INFO - 'tsvgr_opacity', 08:04:47 INFO - 'tart', 08:04:47 INFO - 'tscrollx', 08:04:47 INFO - 'cart']}, 08:04:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'talos_options': ['--disable-e10s'], 08:04:47 INFO - 'tests': ['tp5o']}, 08:04:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'tests': ['tp5o']}, 08:04:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'talos_options': ['--disable-e10s', 08:04:47 INFO - '--xperf_path', 08:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:47 INFO - 'tests': ['tp5n']}, 08:04:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:47 INFO - 'talos_options': ['--xperf_path', 08:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:47 INFO - 'tests': ['tp5n']}}, 08:04:47 INFO - 'talos.zip': {'path': '', 08:04:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:47 INFO - Running post-action listener: _resource_record_post_action 08:04:47 INFO - [mozharness: 2017-01-21 16:04:47.275269Z] Finished populate-webroot step (success) 08:04:47 INFO - [mozharness: 2017-01-21 16:04:47.275388Z] Running create-virtualenv step. 08:04:47 INFO - Running pre-action listener: _resource_record_pre_action 08:04:47 INFO - Running main action method: create_virtualenv 08:04:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:04:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:47 INFO - Using real prefix '/tools/python27' 08:04:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:51 INFO - Installing pip.................done. 08:04:51 INFO - Return code: 0 08:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:04:51 INFO - Reading from file tmpfile_stdout 08:04:51 INFO - Output received: 08:04:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:04:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:51 INFO - 'HOME': '/Users/cltbld', 08:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:51 INFO - 'LOGNAME': 'cltbld', 08:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:51 INFO - 'MOZ_NO_REMOTE': '1', 08:04:51 INFO - 'NO_EM_RESTART': '1', 08:04:51 INFO - 'PAGER': '/bin/cat', 08:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:51 INFO - 'PWD': '/builds/slave/test', 08:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:51 INFO - 'SHELL': '/bin/bash', 08:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:04:51 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:51 INFO - 'USER': 'cltbld', 08:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:51 INFO - 'XPC_FLAGS': '0x0', 08:04:51 INFO - 'XPC_SERVICE_NAME': '0', 08:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:04:51 INFO - Cleaning up... 08:04:51 INFO - Return code: 0 08:04:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:51 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:51 INFO - 'HOME': '/Users/cltbld', 08:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:51 INFO - 'LOGNAME': 'cltbld', 08:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:51 INFO - 'MOZ_NO_REMOTE': '1', 08:04:51 INFO - 'NO_EM_RESTART': '1', 08:04:51 INFO - 'PAGER': '/bin/cat', 08:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:51 INFO - 'PWD': '/builds/slave/test', 08:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:51 INFO - 'SHELL': '/bin/bash', 08:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:04:51 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:51 INFO - 'USER': 'cltbld', 08:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:51 INFO - 'XPC_FLAGS': '0x0', 08:04:51 INFO - 'XPC_SERVICE_NAME': '0', 08:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:51 INFO - Downloading/unpacking psutil>=3.1.1 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:55 INFO - Installing collected packages: psutil 08:04:55 INFO - Running setup.py install for psutil 08:04:56 INFO - building 'psutil._psutil_osx' extension 08:04:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:04:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:04:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:04:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:04:56 INFO - building 'psutil._psutil_posix' extension 08:04:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:04:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:04:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:04:56 INFO - ^ 08:04:56 INFO - 1 warning generated. 08:04:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:04:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:57 INFO - Successfully installed psutil 08:04:57 INFO - Cleaning up... 08:04:57 INFO - Return code: 0 08:04:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:04: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:04: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 mozsystemmonitor==0.3 08:04:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:04:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:57 INFO - 'HOME': '/Users/cltbld', 08:04:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:57 INFO - 'LOGNAME': 'cltbld', 08:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:57 INFO - 'MOZ_NO_REMOTE': '1', 08:04:57 INFO - 'NO_EM_RESTART': '1', 08:04:57 INFO - 'PAGER': '/bin/cat', 08:04:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:57 INFO - 'PWD': '/builds/slave/test', 08:04:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:57 INFO - 'SHELL': '/bin/bash', 08:04:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:04:57 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:04:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:57 INFO - 'USER': 'cltbld', 08:04:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:57 INFO - 'XPC_FLAGS': '0x0', 08:04:57 INFO - 'XPC_SERVICE_NAME': '0', 08:04:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:05:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:00 INFO - Installing collected packages: mozsystemmonitor 08:05:00 INFO - Running setup.py install for mozsystemmonitor 08:05:00 INFO - Successfully installed mozsystemmonitor 08:05:00 INFO - Cleaning up... 08:05:00 INFO - Return code: 0 08:05:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:00 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:05:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:00 INFO - 'HOME': '/Users/cltbld', 08:05:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:00 INFO - 'LOGNAME': 'cltbld', 08:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:00 INFO - 'MOZ_NO_REMOTE': '1', 08:05:00 INFO - 'NO_EM_RESTART': '1', 08:05:00 INFO - 'PAGER': '/bin/cat', 08:05:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:00 INFO - 'PWD': '/builds/slave/test', 08:05:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:00 INFO - 'SHELL': '/bin/bash', 08:05:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:00 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:00 INFO - 'USER': 'cltbld', 08:05:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:00 INFO - 'XPC_FLAGS': '0x0', 08:05:00 INFO - 'XPC_SERVICE_NAME': '0', 08:05:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:03 INFO - warning: no files found matching '*.txt' 08:05:03 INFO - no previously-included directories found matching 'build' 08:05:03 INFO - no previously-included directories found matching 'dist' 08:05:03 INFO - no previously-included directories found matching '.git*' 08:05:03 INFO - Installing collected packages: jsonschema, functools32 08:05:03 INFO - Running setup.py install for functools32 08:05:04 INFO - warning: no files found matching '*.txt' 08:05:04 INFO - no previously-included directories found matching 'build' 08:05:04 INFO - no previously-included directories found matching 'dist' 08:05:04 INFO - no previously-included directories found matching '.git*' 08:05:04 INFO - Successfully installed jsonschema functools32 08:05:04 INFO - Cleaning up... 08:05:04 INFO - Return code: 0 08:05:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:04 INFO - 'HOME': '/Users/cltbld', 08:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:04 INFO - 'LOGNAME': 'cltbld', 08:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:04 INFO - 'MOZ_NO_REMOTE': '1', 08:05:04 INFO - 'NO_EM_RESTART': '1', 08:05:04 INFO - 'PAGER': '/bin/cat', 08:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:04 INFO - 'PWD': '/builds/slave/test', 08:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:04 INFO - 'SHELL': '/bin/bash', 08:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:04 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:04 INFO - 'USER': 'cltbld', 08:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:04 INFO - 'XPC_FLAGS': '0x0', 08:05:04 INFO - 'XPC_SERVICE_NAME': '0', 08:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:05:04 INFO - Cleaning up... 08:05:04 INFO - Return code: 0 08:05:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:04 INFO - 'HOME': '/Users/cltbld', 08:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:04 INFO - 'LOGNAME': 'cltbld', 08:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:04 INFO - 'MOZ_NO_REMOTE': '1', 08:05:04 INFO - 'NO_EM_RESTART': '1', 08:05:04 INFO - 'PAGER': '/bin/cat', 08:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:04 INFO - 'PWD': '/builds/slave/test', 08:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:04 INFO - 'SHELL': '/bin/bash', 08:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:04 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:04 INFO - 'USER': 'cltbld', 08:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:04 INFO - 'XPC_FLAGS': '0x0', 08:05:04 INFO - 'XPC_SERVICE_NAME': '0', 08:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:08 INFO - Downloading docopt-0.6.1.tar.gz 08:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:08 INFO - Running setup.py install for blobuploader 08:05:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:08 INFO - Running setup.py install for requests 08:05:09 INFO - Running setup.py install for docopt 08:05:09 INFO - Successfully installed blobuploader requests docopt 08:05:09 INFO - Cleaning up... 08:05:09 INFO - Return code: 0 08:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:09 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:09 INFO - 'HOME': '/Users/cltbld', 08:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:09 INFO - 'LOGNAME': 'cltbld', 08:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:09 INFO - 'MOZ_NO_REMOTE': '1', 08:05:09 INFO - 'NO_EM_RESTART': '1', 08:05:09 INFO - 'PAGER': '/bin/cat', 08:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:09 INFO - 'PWD': '/builds/slave/test', 08:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:09 INFO - 'SHELL': '/bin/bash', 08:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:09 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:09 INFO - 'USER': 'cltbld', 08:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:09 INFO - 'XPC_FLAGS': '0x0', 08:05:09 INFO - 'XPC_SERVICE_NAME': '0', 08:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:09 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-G6xGq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-nCMHKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-vaJDY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-O8HAKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-T6pC3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-yjoedt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-QFrSdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-K1v0Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-0X_xxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-A4fQW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:10 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-WcjLxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:11 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-AfZp_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:11 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-f78uAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:11 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-wwFDxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:11 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-_nzc6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:11 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-UwkUkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:11 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-ZRl3Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:11 INFO - Running setup.py install for manifestparser 08:05:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:11 INFO - Running setup.py install for mozcrash 08:05:11 INFO - Running setup.py install for mozdebug 08:05:12 INFO - Running setup.py install for mozdevice 08:05:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Running setup.py install for mozfile 08:05:12 INFO - Running setup.py install for mozhttpd 08:05:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Running setup.py install for mozinfo 08:05:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Running setup.py install for mozInstall 08:05:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:12 INFO - Running setup.py install for mozleak 08:05:12 INFO - Running setup.py install for mozlog 08:05:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:13 INFO - Running setup.py install for moznetwork 08:05:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:13 INFO - Running setup.py install for mozprocess 08:05:13 INFO - Running setup.py install for mozprofile 08:05:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:13 INFO - Running setup.py install for mozrunner 08:05:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:13 INFO - Running setup.py install for mozscreenshot 08:05:13 INFO - Running setup.py install for moztest 08:05:14 INFO - Running setup.py install for mozversion 08:05:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:14 INFO - Cleaning up... 08:05:14 INFO - Return code: 0 08:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:14 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:14 INFO - 'HOME': '/Users/cltbld', 08:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:14 INFO - 'LOGNAME': 'cltbld', 08:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:14 INFO - 'MOZ_NO_REMOTE': '1', 08:05:14 INFO - 'NO_EM_RESTART': '1', 08:05:14 INFO - 'PAGER': '/bin/cat', 08:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:14 INFO - 'PWD': '/builds/slave/test', 08:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:14 INFO - 'SHELL': '/bin/bash', 08:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:14 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:14 INFO - 'USER': 'cltbld', 08:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:14 INFO - 'XPC_FLAGS': '0x0', 08:05:14 INFO - 'XPC_SERVICE_NAME': '0', 08:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:14 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-HE1p3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:14 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-FXd1sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:14 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-CUj699-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:14 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-VtRT5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:14 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-nqgsLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-KVpxY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-iZEOhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-3SaRNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-KbNUlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-oLkP1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-NwlVdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-8QEqdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-YZGWZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:15 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-RjTCtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:16 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-KASPa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:16 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-h8GWz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:16 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-sIyR5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:19 INFO - Downloading blessings-1.6.tar.gz 08:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:19 INFO - Installing collected packages: blessings 08:05:19 INFO - Running setup.py install for blessings 08:05:19 INFO - Successfully installed blessings 08:05:19 INFO - Cleaning up... 08:05:19 INFO - Return code: 0 08:05:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:19 INFO - Reading from file tmpfile_stdout 08:05:19 INFO - Current package versions: 08:05:19 INFO - blessings == 1.6 08:05:19 INFO - blobuploader == 1.2.4 08:05:19 INFO - docopt == 0.6.1 08:05:19 INFO - functools32 == 3.2.3-2 08:05:19 INFO - jsonschema == 2.5.1 08:05:19 INFO - manifestparser == 1.1 08:05:19 INFO - mozInstall == 1.12 08:05:19 INFO - mozcrash == 1.0 08:05:19 INFO - mozdebug == 0.1 08:05:19 INFO - mozdevice == 0.48 08:05:19 INFO - mozfile == 1.2 08:05:19 INFO - mozhttpd == 0.7 08:05:19 INFO - mozinfo == 0.9 08:05:19 INFO - mozleak == 0.1 08:05:19 INFO - mozlog == 3.4 08:05:19 INFO - moznetwork == 0.27 08:05:19 INFO - mozprocess == 0.23 08:05:19 INFO - mozprofile == 0.28 08:05:19 INFO - mozrunner == 6.13 08:05:19 INFO - mozscreenshot == 0.1 08:05:19 INFO - mozsystemmonitor == 0.3 08:05:19 INFO - moztest == 0.8 08:05:19 INFO - mozversion == 1.4 08:05:19 INFO - psutil == 3.1.1 08:05:19 INFO - requests == 1.2.3 08:05:19 INFO - wsgiref == 0.1.2 08:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:19 INFO - 'HOME': '/Users/cltbld', 08:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:19 INFO - 'LOGNAME': 'cltbld', 08:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:19 INFO - 'MOZ_NO_REMOTE': '1', 08:05:19 INFO - 'NO_EM_RESTART': '1', 08:05:19 INFO - 'PAGER': '/bin/cat', 08:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:19 INFO - 'PWD': '/builds/slave/test', 08:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:19 INFO - 'SHELL': '/bin/bash', 08:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:19 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:19 INFO - 'USER': 'cltbld', 08:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:19 INFO - 'XPC_FLAGS': '0x0', 08:05:19 INFO - 'XPC_SERVICE_NAME': '0', 08:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:19 INFO - Cleaning up... 08:05:19 INFO - Return code: 0 08:05:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 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 0x10dbe1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e858bbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, '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.L2BL11ISPM/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.V0cK9UCUzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:19 INFO - 'HOME': '/Users/cltbld', 08:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:19 INFO - 'LOGNAME': 'cltbld', 08:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:19 INFO - 'MOZ_NO_REMOTE': '1', 08:05:19 INFO - 'NO_EM_RESTART': '1', 08:05:19 INFO - 'PAGER': '/bin/cat', 08:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:19 INFO - 'PWD': '/builds/slave/test', 08:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:19 INFO - 'SHELL': '/bin/bash', 08:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:19 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:19 INFO - 'USER': 'cltbld', 08:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:19 INFO - 'XPC_FLAGS': '0x0', 08:05:19 INFO - 'XPC_SERVICE_NAME': '0', 08:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:20 INFO - Cleaning up... 08:05:20 INFO - Return code: 0 08:05:20 INFO - Running post-action listener: _resource_record_post_action 08:05:20 INFO - Running post-action listener: _start_resource_monitoring 08:05:20 INFO - Starting resource monitoring. 08:05:20 INFO - [mozharness: 2017-01-21 16:05:20.276403Z] Finished create-virtualenv step (success) 08:05:20 INFO - [mozharness: 2017-01-21 16:05:20.277370Z] Running install step. 08:05:20 INFO - Running pre-action listener: _resource_record_pre_action 08:05:20 INFO - Running main action method: install 08:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:20 INFO - Reading from file tmpfile_stdout 08:05:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:20 INFO - Reading from file tmpfile_stdout 08:05:20 INFO - Output received: 08:05:20 INFO - Usage: mozinstall [options] installer 08:05:20 INFO - Options: 08:05:20 INFO - -h, --help show this help message and exit 08:05:20 INFO - -d DEST, --destination=DEST 08:05:20 INFO - Directory to install application into. [default: 08:05:20 INFO - "/builds/slave/test"] 08:05:20 INFO - --app=APP Application being installed. [default: firefox] 08:05:20 INFO - mkdir: /builds/slave/test/build/application 08:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:05:52 INFO - Reading from file tmpfile_stdout 08:05:52 INFO - Output received: 08:05:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:05:52 INFO - Running post-action listener: _resource_record_post_action 08:05:52 INFO - [mozharness: 2017-01-21 16:05:52.632794Z] Finished install step (success) 08:05:52 INFO - [mozharness: 2017-01-21 16:05:52.632928Z] Running run-tests step. 08:05:52 INFO - Running pre-action listener: _resource_record_pre_action 08:05:52 INFO - Running main action method: run_tests 08:05:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:05:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:05:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:05:52 INFO - 2017-01-21 08:05:52.647 screenresolution[1636:8971] starting screenresolution argv=screenresolution get 08:05:52 INFO - 2017-01-21 08:05:52.650 screenresolution[1636:8971] Display 0: 1600x1200x32@60 08:05:52 INFO - 2017-01-21 08:05:52.656 screenresolution[1637:8974] starting screenresolution argv=screenresolution list 08:05:52 INFO - Available Modes on Display 0 08:05:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:05:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:05:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:05:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:05:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:05:52 INFO - Intel Iris: 08:05:52 INFO - Chipset Model: Intel Iris 08:05:52 INFO - Type: GPU 08:05:52 INFO - Bus: Built-In 08:05:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:05:52 INFO - Vendor: Intel (0x8086) 08:05:52 INFO - Device ID: 0x0a2e 08:05:52 INFO - Revision ID: 0x0009 08:05:52 INFO - Displays: 08:05:52 INFO - Display: 08:05:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:05:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:05:52 INFO - Display Serial Number: 1600x1200 60 08:05:52 INFO - Main Display: Yes 08:05:52 INFO - Mirror: Off 08:05:52 INFO - Online: Yes 08:05:52 INFO - Rotation: Supported 08:05:52 INFO - Return code: 0 08:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:52 INFO - Python 2.7.3 08:05:52 INFO - Return code: 0 08:05:52 INFO - grabbing minidump binary from tooltool 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:52 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 0x10d9f5d30>, '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 0x10d85bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9edb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:05:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:05:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:05:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:53 INFO - Return code: 0 08:05:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:05:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:05:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:53 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/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0204', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:05:53 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/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0204 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2BL11ISPM/Render', 08:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:53 INFO - 'HOME': '/Users/cltbld', 08:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:53 INFO - 'LOGNAME': 'cltbld', 08:05:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:53 INFO - 'MOZ_NO_REMOTE': '1', 08:05:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:53 INFO - 'NO_EM_RESTART': '1', 08:05:53 INFO - 'PAGER': '/bin/cat', 08:05:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:53 INFO - 'PWD': '/builds/slave/test', 08:05:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:53 INFO - 'SHELL': '/bin/bash', 08:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0cK9UCUzj/Listeners', 08:05:53 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 08:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:53 INFO - 'USER': 'cltbld', 08:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:53 INFO - 'XPC_FLAGS': '0x0', 08:05:53 INFO - 'XPC_SERVICE_NAME': '0', 08:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:53 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/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0204', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:05:53 INFO - mozversion application_buildid: 20170121070324 08:05:53 INFO - mozversion application_changeset: b58eb6e9e6c683cd32855ad927990fa6d585a1a8 08:05:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:05:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:53 INFO - mozversion application_name: Firefox 08:05:53 INFO - mozversion application_remotingname: firefox-dev 08:05:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:05:53 INFO - mozversion application_vendor: Mozilla 08:05:53 INFO - mozversion application_version: 52.0a2 08:05:53 INFO - mozversion platform_buildid: 20170121070324 08:05:53 INFO - mozversion platform_changeset: b58eb6e9e6c683cd32855ad927990fa6d585a1a8 08:05:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:05:53 INFO - mozversion platform_version: 52.0a2 08:05:53 INFO - using testdate: 1485014753 08:05:53 INFO - actual date: 1485014753 08:05:53 INFO - starting webserver on 'localhost:49240' 08:05:53 INFO - SUITE-START | Running 2 tests 08:05:53 INFO - TEST-START | dromaeo_css 08:05:53 INFO - operating with platform_type : mac_ 08:05:53 INFO - Initialising browser for dromaeo_css test... 08:05:53 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpMibs7s/profile http://localhost:49240/getInfo.html) 08:05:56 INFO - PROCESS | 1647 | 2017-01-21 08:05:56.358 plugin-container[1650:9154] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 08:05:56 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:05:56 INFO - PROCESS | 1647 | 2017-01-21 08:05:56.361 plugin-container[1650:9154] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920f, name = 'com.apple.CFPasteboardClient' 08:05:56 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:05:56 INFO - PROCESS | 1647 | 2017-01-21 08:05:56.361 plugin-container[1650:9154] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:05:56 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:05:56 INFO - PROCESS | 1647 | colorDepth:24 08:05:56 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:05:56 INFO - PROCESS | 1647 | __metrics 08:05:56 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:05:57 INFO - TEST-INFO | 1647: exit 0 08:05:57 INFO - Browser initialized. 08:05:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:57 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpMibs7s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:59 INFO - PROCESS | 1651 | 2017-01-21 08:05:59.859 plugin-container[1652:9279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833b, name = 'com.apple.tsm.portname' 08:05:59 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:05:59 INFO - PROCESS | 1651 | 2017-01-21 08:05:59.860 plugin-container[1652:9279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:05:59 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:05:59 INFO - PROCESS | 1651 | 2017-01-21 08:05:59.860 plugin-container[1652:9279] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:09 INFO - PROCESS | 1651 | RSS: Main: 228761600 08:06:09 INFO - PROCESS | 1651 | 08:09:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:09:13 INFO - PROCESS | 1651 | RSS: Main: 234196992 08:09:13 INFO - PROCESS | 1651 | 08:12:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:12:16 INFO - PROCESS | 1651 | RSS: Main: 243867648 08:12:16 INFO - PROCESS | 1651 | 08:15:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:15:18 INFO - PROCESS | 1651 | RSS: Main: 246665216 08:15:18 INFO - PROCESS | 1651 | 08:18:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:18:21 INFO - PROCESS | 1651 | RSS: Main: 245993472 08:18:21 INFO - PROCESS | 1651 | 08:21:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:21:24 INFO - PROCESS | 1651 | RSS: Main: 249544704 08:21:24 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:24:27 INFO - PROCESS | 1651 | RSS: Main: 250888192 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | __start_tp_report 08:24:27 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:24:27 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:24:27 INFO - PROCESS | 1651 | |i|pagename|runs| 08:24:27 INFO - PROCESS | 1651 | |0;dojo.html;3422.7775194612364;3430.1767575781814;3456.7925924444526;3469.7397695172854;3476.0440878758354;5701.800436984707;5771.480566748997;5811.941880581193;5812.215350927634;5826.300843898733;5826.475617194452;5916.2308899843065;5927.911081333784;5936.851578710523;5942.792002279921;4194.580541945811;5296.3379577552805;5309.654872433289;5412.83761487156;5425.647332923367;5458.426865179159;5480.095784195603;5480.945190548104;5488.7530061147145;5490.450954904498;5292.179712144623;5317.335333083364;5449.945500545004;5451;5455.727213639322;5326.041312563737;5353.170258609902;5410.864728381783;5458.6724796511935;5498.1752737089755;5278.736063196825;5382.2464854920345;5395.352557693062;5411.21537377082;5428.375736790241;5654.321481422256;5845.824625261249;5866.413358664099;5949.524038076944;5970.432808883149;6173.382661733835;6222.96888515559;6225.035119556476;6281.246250449975;6353.396427339396;6314.368563143695;6344.936550634527;6351.047342898556;6356.841078973016;6362.300146983828;5919.763209471616;5962.731677074542;5967.1347654589845;5974.880502389928;5981.0729336952845;6207.441330280297;6258.561900666909;6293.811185664437;6304.590201636879;6316.557840951089;6198.690065496708;6261.624302541862;6282.905756413657;6291.905621415683;6297.6536290503545;5516.696581687966;6324.968375158095;6325.114483972247;6345.397187267202;6368.522360822864;5326.7869285228935;5708.372079071299;5966.970165149147;6107.603005804608;6187.257529096537;5566.916496252559;6179.938200618026;6350.65071421067;6360.968195158995;6374.745010199633;5020.874478138003;5024.974875125601;5035.84892453227;5037.571806396498;5038.672486288379;4333.025069359432;4366.104948485617;4431.047324825178;4493.6854420190275;4519.367288579601;5410.945890541044;5489.725513724298;5943.940560594338;5976.850578735566;6040.124181993587;6318.842028949313;6324.810255692337;6337.873242535124;6342.841428964312;6379.425851673279;5789.044807606698;5887.146363777314;5968.940310596925;5982.880342393128;5993.160957465958;5514.80698175562;5516.089845175501;5516.9448305516435;5541.473560011873;5541.9168712469345;6451.161349024596;6468.838279043061;6471.611703297817;6473.06140609609;6493.805185844432;6157.630542167484;6184;6242;6261.843453913689;6331.430171284606;6472.579282346633;6481.578697384655;6483.157189565326;6484.5460817742305;6525.282218956006;6309.211348581427;6329.208848893888;6334.144890439732;6337.524685648503;6341.619502829845;6241.687915604292;6280.9685951569945;6281.152044473937;6323.683815809283;6330.303666596763;4816.470188279357;6118.9846826261555;6143.112737013596;6190.102435146969;6252.562320637512;6185.505159587312;6230.6884655766125;6242.3133455320785;6245.219347581552;6273.74905003813;4947.45577986414;5902.1736956826935;5926.436988486087;5964.671943043;6139.2325959255095;6136;6146.200993870947;6156.415140561639;6265.655388953652;6269.840079585291;6134.78528251509;6149.938500614937;6165.445109940127;6172.5679202457195;6191.133241346125 08:24:27 INFO - PROCESS | 1651 | |1;ext.html;470.98267741677984;473.6613321475145;488.0190816458917;519.2470917170103;523.8428471458561;31452.68547314529;36154;38795;38814.22371552567;38847.028824279405;39168.804155979255;39474;39527;39564.406533902016;39565.604343956555;9270.629174832999;9316.394434361744;9338.252939764803;9435.481048542328;9474.05259474054;9131.908680913173;9273.07269273074;9298.860517092215;9337.393069450463;9379.437233765962;9252.67615633453;9301.441913485212;9301.674441394553;9361.953190234039;9381.15569598736;9150.130737579919;9249.12133347331;9318.72043838686;9336.486493242868;9346.252299815998;9304.674336398193;9363.719088427359;9396.62413503459;9405.670801521914;9408;37274.25451490982;37670.246595068216;38022.809885950395;38069.428958565644;38098.80950595229;3177;3329.6836800503916;3386.0011296667544;3458.792472451661;3720.9813950930343;29544;29752.55371169434;30053.849730751426;30190.396192076034;30196.24509387283;3125.9687403125904;3216.5818443602416;3218.5494030835703;3222.4038552867796;3245.318483118548;503323;505213;505396.47301763255;505802;505998.4700076513;54495;54728;55156;55672.44327556754;55720.44279557152;57868.42131578714;58441.70779146077;58636.41363586395;58729.70635146797;58781.41218587845;15589.532314030597;15614;15681.68636627261;15812.683746325009;15830.28763705636;12287.385630718429;12290.262584244794;12376.690582735324;12382.75234495305;12393.442295096742;13015.804762928563;14716.852831471762;15050.849491505163;15052.441085015573;15226.46707365237;3185.761067919915;5059.519345662156;5377.7580008899695;6649.4347980421235;6697.8995315070315;856.7900864288165;906.60109551797;961.024560071514;992.5235886774389;1100.4277775556666;28680;29016.7098329014;29391.412171756445;30069;30358.241043974078;714.7569826259097;857.8241460500583;908.5094049213483;1038.657243109787;1122.5060973171778;14710.55868323952;14768.335424905905;14902.925485372503;14911.403543858341;15642.765358519631;558821;706587;709695;712093;713342;55522.16716749252;55879.720601397545;55887.44112558822;55930.44069559334;56196.719016404655;1139.8544462814818;1356.7286542691502;1356.9932150339184;1376.7865980772997;1379.703363776813;29160.27099322534;29911.401771964873;30130.548041779828;30252.84873575618;30511.08466746001;47337.05325893532;48150.518494816;48167.277490838365;48178.518214817406;48399.75800120977;622423;624000;626703;627101.322466942;628058;24786.50426991486;24903.62644560369;24954.251372458857;25303.74696253014;25344.873275633505;42750.57249427466;42925;43428.78285608552;44011.55988440075;44058.55941440545;33865.98402047942;33928;33931;34121;34424.483632745025;30772.384552309275;34024.82987585046;36165.819170903975;36882.8155859219;37136.62863371332;35108.946731598095;35115.29769404649;35637;35822.641773581934;36041;25235.87382063078;32859.83570082134;32933.34133317368;32967.17582060468;33036.66963330336;19326.76894893513;19453.124609392893;22952.540949181257;22987;23009.424764381023 08:24:27 INFO - PROCESS | 1651 | |2;jquery.html;374.27577637271884;374.7483405425877;384.2871473416812;386.7312218008485;402.5491449576473;18178.72731909021;19225.615487690236;19681.803181968175;19826.10782514787;19944.900275498603;18956.05219739011;19164.808351916476;19350.12924418401;19414.80585194151;19756.50608734779;4629.675922685414;5751.166080918275;5947.940520594803;5977.043673012319;5993.250843644544;4201.138766552865;4437.711548749337;5779.508741756935;5955.136505206742;6267.122602835607;6500.992346186349;6558.278589355167;6564.704588293538;6616.172978377703;6619.735210591571;5278.973605131969;6525.412712855842;6553.6395498247575;6560;6571.507136964723;5541.855937702822;5669.6314739541795;5679.545636349124;5723.112917497794;5732.942670573324;24633;24802.751972480226;24893.50212995748;24902;25317.11390101356;2193.8025577698086;2645.854478003709;3016.894408695707;3070.969290307113;3073.7694672899397;12603.621891343275;14618.415263389452;15454.768178477332;15596.986195897343;15795.973261738065;1839.0804597701149;1845.9261629534803;1849.824266694662;1860.962780744391;1915.3775023117541;120042;124152;124607;126109.36945315215;126604;10601.41692206936;10701.946490267499;11116.833247501294;11201.495932683049;11287.20989530725;13637.795433068512;13644.727105457836;13652;13655.931720341534;13719.657008574866;8289.751307460785;8522.914770852212;8532.70135545253;8619;8656.437331573428;8495.872561911576;8500.234978851933;8502.617382217815;8600.483970961637;8638.222559969632;5933.970330148408;6116;6616.503762217853;6631.3090162008375;6751.0886030386255;1597.752348386002;1672.523330850726;1679.1016806008727;1833.7988617455587;1875.7057630235095;884.195382202193;891.8974317953518;900.2797761790541;918.7060140755028;966.8501382285757;16735.49793506197;19836.60326793485;20190.394288171377;20263.392098237076;20706.378808635764;887.7824932891483;929.5259417696888;941.773974246176;966.246327864267;982.8034393121404;8974;8999.965004024622;10265.384076955406;10489.479025541254;10760.677179684622;501504;505306;614224;621462;624001;74348;84574;86552.56723716341;89847.20305593852;141723;939.8590211468335;945.1257586732245;964.2093483343731;965.280865755017;967.1005964453267;17468.73796893022;17976.730349044512;18132.365367212085;18194;18242.45272641823;52862.67843303948;53034.46965530295;53169.202461963876;53204;57962.7101864488;79565.60217198876;83382.91542711481;83908.16091839003;84593.15406845853;85208;6209.223847019122;7288.890666640111;7414.740484083031;7560.206178351194;7978.0825205102155;10675.306105103144;12596.433160507982;12653.620391388273;12674.746505070032;12687.80968285495;10848.349099054081;11068.723281918017;11188.992990630883;11270.211085223955;11396.48715807774;10164.84752728695;10648.361098334124;10852.131829453467;10978;11413.315201087962;11152.386618736047;11197.776044479227;11257.493412796608;11300;11552.59565915189;7387.889181662387;7438.590877501573;7453.180150183367;7536.869469579607;7725.575093369918;9321.580528876082;10888.29226100301;11165.218434709492;11263.549458021587;11316.26444281152 08:24:27 INFO - PROCESS | 1651 | |3;mootools.html;1278.0350835119484;1410.8165938428003;1572.9225480545826;1767.5227688524108;1783.1262681286173;7095.7516486922905;7472.58900760458;7726.227377262271;8095.554744489051;8507.149285071497;7948.761537153895;8310.12743661916;8336.624851881665;8368.330533557317;8381;2295.954080918385;2313.097891822191;2334.171369163948;2339.2748248043076;2344.296710986706;2340.777626125524;2350.224425939436;2377.2511658827416;2383.5947888858936;2389.474315650554;2291.702078729763;2317.918872839451;2329.9184528541505;2330.1611419888827;2350.165691179632;1969.2516843599412;2298.1841446286494;2313.3175713164655;2324.035525257016;2341.285907798121;2315.513742114141;2317.606006978801;2348.178137651825;2348.518553696488;2352.8941197646145;8293.917060829435;8344.958275208584;8373.743938409227;8376.53929033903;8382.16178382157;5058.342415486;5182.922256166161;5207.375114986188;5211.088059589594;5226.869328266824;3115.517094850302;3281.3109247058146;3312.5590368189673;3365.125067482448;3597.7301702372165;1049.0663309654415;1057.2229411382627;1077.805994920914;1080.3193987787722;1087.4943151434543;10822.404767737771;10824.891751082467;10847.186461015377;10913.890861091368;10915.235933484659;4498.932516012263;4586.793594288265;4667.743274119888;4687.226607609774;4755.262934245197;9265.166135047743;9266.629334826666;9425.905740942502;9465.195458386115;9467.857982130274;5193.68837869729;5197.376314842243;5205.5315021647475;5205.635605507654;5209.114450543417;4230.978845105817;4277.935830962538;4720.858374248709;4756.619470442356;4763.809447622126;3810.904727381838;3818.560865500503;3895.824687889052;3910.980445097813;3927.587603301612;1159.3507635724022;1217.0750229825396;1265.9683507912375;1278.8721127887322;1288.6778305423645;761.3452430909414;884.8451520983803;902.9277657787361;905.9501727404925;917.2936838634214;5501.779928802883;5578.553715702734;5611.691356975405;5670.7731690732735;5827.417258274223;959.3380567408466;972;1003.9347442416366;1012.4684540616236;1033.3128469567803;3738.532683414573;3789.1285004448578;3806.885793426202;3846.519185101862;3940.625640564142;9936.205103591696;10141.138003269658;10260.794784104426;10269;10302.227332950059;10111.898881011095;10224.64213752515;10228.488575571191;10230;10230.079292863678;6902.965485172542;6920.688569014406;7801.882971755428;7930.405219608437;7959.164287749819;5380;5549.278593782944;5624.29696287964;5674.092145256739;5767.3367562729145;9292.6282948684;9338.066193380608;9431.198348140484;9432.52837358143;9439.433633981984;9055;9380.530973451163;9456.385334953206;9466.763330916781;9469.384490008128;6588.835279117869;6756.493263005196;6922.550034247758;7043.718251269892;7176.712931482891;6883.414909732729;7767.456278060482;7906.604669766603;7965.681372745025;7973.122956474899;6904.758333458305;7150.785476435715;7221.061262035902;7235.167955685163;7272.927270727225;6064.757409703562;6860.656967151723;6942.923846803754;7079.115110611174;7116.288371162842;6607.834804129935;6669.566478178903;6758.628275444701;6764.188297404343;6773.153355830521;4847.903041939212;4856.368672072608;4883.267509873547;4888.095702295087;4910.386201724785;4798.2802579613335;4853.611711063177;4944.82693105754;4955.884925891645;4964.4539100698175 08:24:27 INFO - PROCESS | 1651 | |4;prototype.html;279.86846182294323;291.8074071113066;296.09985643643324;312.9671384504627;317.73310419247827;5060.974695126524;5331.973340133303;5416.702081385522;5485.588580856442;5633.380328163904;4535.795889184987;5233.796226867813;5244.711540865251;5452.609584555933;5527.55779537637;3457.8098204598737;4203.684723645739;4215.810288537024;4255.319148936171;4267.829286828539;3470.3753324401596;3719.340671419934;4072.617518751534;4271.444712187426;4278.694998025601;3630.6913912317355;4158.708890377659;4167.291560434734;4184.4978602567735;4225.359150530918;4052.918941621151;4176.394422808676;4182.954261434641;4192.496900371944;4210.768407737573;3628.618995005539;3632.418812989909;3634.83643236055;3639.5268615080136;3641.5630124385243;5269.710165940872;5384.326959130109;5397.919031214535;5419.729013549307;5420.620556561043;4666;4720.858374248778;4747.8575642730775;4761.357216775726;4807.663463557552;4338.826446942118;4500.864974050751;5765.711714414262;5790.073588225906;5798.202557207279;3747.3019426013225;3905.628965248297;3940.428637847525;3951.597183000022;3975.3241948868763;6070.484008859252;6115.296740874812;6134.96932515339;6201.317855035897;6233.698747863959;4003.3794761811964;4004.3392840181045;4030.984507746127;4034;4043.332850079763;2949.42486215186;3593.964060359363;3935.901602459904;4036.9394459083137;4084.4281800547947;4099.97950010254;4465.531119232499;4733.148033354029;4756.170078803107;4761.571458568746;5842.474177324061;5878.147668588031;5881.470667639933;5894.850504151735;5944.464998150187;1237.7029512917015;1264.709995804293;1307.4704744578462;1325.4963114016805;1340.4973135074347;873.1486800369715;889.7286327669993;898.0749827677503;898.2185498616116;905;4684.578387945033;4857.659963802571;5221.765020574083;5231.372235331784;5243.580513558983;5119.692818430906;5686;5715.799947001919;5732.971335143297;5766.826995190151;4952.2914594464855;5149.292509393231;5228.777769447969;5260.421353651095;5297.311349524614;2744.874601413451;2870.985645071761;2991.880324786984;2994.37118205175;2999.9550006749914;4978.182963218399;5276.366835979707;5341.439148889388;5954.469350526009;5960.159044136683;4898.853034408902;4986.850394488171;5584.609077364546;5857.912131318034;5895.7052147393315;5295.788168473218;5752.769889204469;5872.647641141545;5892.616979896378;5908.261467316585;5049.748261807679;5169.689818610896;5347.973260133675;5716.514096301861;5761.020626493422;4941.728204948618;5247.635614740118;5346.545543628835;5447.945520544902;5536.307961504812;5014.398272207359;5060.746962651926;5839.270091238595;5920.763169473345;5998.670073146019;3171.460851655178;3555.1112221944513;3557.928841423105;3808.5239345081864;3813.161104556993;5200.6879587224885;5451.672899626035;5669;5721.19661365936;5739.684317362418;5428.45715428454;5654.247183373168;5708.629928817137;5870.589058766016;5902.439268269508;5811.38487680537;5865.912011319919;5872.354041055395;5913.156448308634;5936.554758393051;5056.598115894921;5294.841154765363;5515.531179849597;5652.77791658767;5747.453991870766;4887.804487820447;5379.784808607612;5612.85967850807;5623.915641265303;5858.5898987072205;4837.806487740451;5522.438027472338;5676.836248569116;5741.712914354349;5784.21913041734 08:24:27 INFO - PROCESS | 1651 | |5;yui.html;555.6860373888752;713.9714411423544;736.2343163110365;763.9694412223508;778.0740918307214;13949.093308934926;14440.133591984488;14523.709525809478;14601.342939567718;15005.099694018367;13215.603531894034;13436.52972145975;13502.662433439169;13518.662033449169;13523.256220907846;783.0212234706617;793.1869833420732;802.4783890471182;802.7993001749562;803.3131672420055;626.7054484392328;648.44881850427;766.0768773627765;776.9106552746422;789.917058708836;809.2069771623812;812.6140083460368;814.5031530766228;838.0864857305536;839.0476808822001;797.9042514898191;829.1749709039544;833.3916241143969;834.5785378383907;834.64110432514;597.7399831073453;612.7395856760903;617.2038070888549;618.5453691536717;619.6313193649817;13385.598432047054;13538.390772415265;13584.117032392962;13655.38550765218;13670.248136352497;13432.798508022388;13615.25116118613;13704.862951370558;13788.241646709426;14024.439022439192;11015.944920275428;11142.442877856074;11299.435028248554;11320.433978301053;11329.206955513117;3532.717382609385;3612.566492020948;3682.779033258013;3704.9814750926344;3728.7949162796035;82279;82369.76445353325;82466.17533824645;83524.16475835224;84964;10441.112505436971;10572.471376431147;10599.364038157735;10623.034738573235;10625.628103016357;20321.593568128555;20576.074076666588;20655;20761.89619051895;20809.479763006046;6397.744090236339;7509.211532789088;7516.323530882138;7558.206388329256;7763.573003484749;4136.152088821845;4233.597808208216;4289.120730250291;4301.5698430156735;4327.82688692455;2747.7114902935305;3236.1909522619344;3357.815320157366;3364.444866597033;3365.899023029313;582.8659408336107;590.5275779376482;598.0132780911531;608.9269287685418;632.4371309534517;554.7586799742045;611.9326874043852;627.5513008199159;649.2339039932924;684.7569112964925;8675.6529738811;8894;9071.27429805614;9102.362834601647;9137.314701397421;598.3418239936035;617.1544983372808;623.4731651754352;660.8447014951579;671.9328067193339;3793.241351729665;4300.591443812833;4316.115196384733;4552.157850797613;4553.430821147356;113103;113586.72826543423;114308;117062;118932;82407;83508.58245708732;91829;99473.00526994783;101406;65347.67326163339;79488.60255698685;82968.58515707383;83242.16757832465;84842.57578712191;9091.545422728705;9147.0852914708;9204.309676774135;9503.334766566273;9506.334556580972;46324.53675463202;53169.468305318;54379.72810135924;54432.455675444326;56917;54120;68931.65534172297;73903;78257;79707.60146199232;10061.39631622105;11945.820812687643;12193.146479746332;12201.816972745593;12275.877241227474;13274.535391261259;13464.192148471124;13642.658933526742;13843.377048032662;14020.369083391475;10672.039516443558;12502.437390317276;13165;13318.00114991399;13365.866341336463;12687.0484713645;12743.745125097632;13335.199888006751;13639.659008524866;13821.654458638615;12615.116941813985;13148.211107333591;13202.537911173064;13468.663283417993;13642.386092625657;10205.591776328863;10295.485225738534;10767.407792571485;10974.122070234522;11098.500567474644;9367.344285899922;10946.179036572448;11122.221444498808;11128.721781955192;11225.214235003472 08:24:27 INFO - PROCESS | 1651 | __end_tp_report 08:24:27 INFO - PROCESS | 1651 | __start_cc_report 08:24:27 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,369 08:24:27 INFO - PROCESS | 1651 | __end_cc_report 08:24:27 INFO - PROCESS | 1651 | __startTimestamp1485015867829__endTimestamp 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:24:27 INFO - PROCESS | 1651 | Number of tests: 6 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5824.58 Median:5982.88 stddev:651.53 (10.9%) stddev-sans-first:625.70 08:24:27 INFO - PROCESS | 1651 | Values: 3422.8 3430.2 3456.8 3469.7 3476.0 5701.8 5771.5 5811.9 5812.2 5826.3 5826.5 5916.2 5927.9 5936.9 5942.8 4194.6 5296.3 5309.7 5412.8 5425.6 5458.4 5480.1 5480.9 5488.8 5490.5 5292.2 5317.3 5449.9 5451.0 5455.7 5326.0 5353.2 5410.9 5458.7 5498.2 5278.7 5382.2 5395.4 5411.2 5428.4 5654.3 5845.8 5866.4 5949.5 5970.4 6173.4 6223.0 6225.0 6281.2 6353.4 6314.4 6344.9 6351.0 6356.8 6362.3 5919.8 5962.7 5967.1 5974.9 5981.1 6207.4 6258.6 6293.8 6304.6 6316.6 6198.7 6261.6 6282.9 6291.9 6297.7 5516.7 6325.0 6325.1 6345.4 6368.5 5326.8 5708.4 5967.0 6107.6 6187.3 5566.9 6179.9 6350.7 6361.0 6374.7 5020.9 5025.0 5035.8 5037.6 5038.7 4333.0 4366.1 4431.0 4493.7 4519.4 5410.9 5489.7 5943.9 5976.9 6040.1 6318.8 6324.8 6337.9 6342.8 6379.4 5789.0 5887.1 5968.9 5982.9 5993.2 5514.8 5516.1 5516.9 5541.5 5541.9 6451.2 6468.8 6471.6 6473.1 6493.8 6157.6 6184.0 6242.0 6261.8 6331.4 6472.6 6481.6 6483.2 6484.5 6525.3 6309.2 6329.2 6334.1 6337.5 6341.6 6241.7 6281.0 6281.2 6323.7 6330.3 4816.5 6119.0 6143.1 6190.1 6252.6 6185.5 6230.7 6242.3 6245.2 6273.7 4947.5 5902.2 5926.4 5964.7 6139.2 6136.0 6146.2 6156.4 6265.7 6269.8 6134.8 6149.9 6165.4 6172.6 6191.1 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:71613.15 Median:38446.90 stddev:163422.37 (425.1%) stddev-sans-first:163793.52 08:24:27 INFO - PROCESS | 1651 | Values: 471.0 473.7 488.0 519.2 523.8 31452.7 36154.0 38795.0 38814.2 38847.0 39168.8 39474.0 39527.0 39564.4 39565.6 9270.6 9316.4 9338.3 9435.5 9474.1 9131.9 9273.1 9298.9 9337.4 9379.4 9252.7 9301.4 9301.7 9362.0 9381.2 9150.1 9249.1 9318.7 9336.5 9346.3 9304.7 9363.7 9396.6 9405.7 9408.0 37274.3 37670.2 38022.8 38069.4 38098.8 3177.0 3329.7 3386.0 3458.8 3721.0 29544.0 29752.6 30053.8 30190.4 30196.2 3126.0 3216.6 3218.5 3222.4 3245.3 503323.0 505213.0 505396.5 505802.0 505998.5 54495.0 54728.0 55156.0 55672.4 55720.4 57868.4 58441.7 58636.4 58729.7 58781.4 15589.5 15614.0 15681.7 15812.7 15830.3 12287.4 12290.3 12376.7 12382.8 12393.4 13015.8 14716.9 15050.8 15052.4 15226.5 3185.8 5059.5 5377.8 6649.4 6697.9 856.8 906.6 961.0 992.5 1100.4 28680.0 29016.7 29391.4 30069.0 30358.2 714.8 857.8 908.5 1038.7 1122.5 14710.6 14768.3 14902.9 14911.4 15642.8 558821.0 706587.0 709695.0 712093.0 713342.0 55522.2 55879.7 55887.4 55930.4 56196.7 1139.9 1356.7 1357.0 1376.8 1379.7 29160.3 29911.4 30130.5 30252.8 30511.1 47337.1 48150.5 48167.3 48178.5 48399.8 622423.0 624000.0 626703.0 627101.3 628058.0 24786.5 24903.6 24954.3 25303.7 25344.9 42750.6 42925.0 43428.8 44011.6 44058.6 33866.0 33928.0 33931.0 34121.0 34424.5 30772.4 34024.8 36165.8 36882.8 37136.6 35108.9 35115.3 35637.0 35822.6 36041.0 25235.9 32859.8 32933.3 32967.2 33036.7 19326.8 19453.1 22952.5 22987.0 23009.4 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:33739.08 Median:385.51 stddev:95979.08 (24896.7%) stddev-sans-first:96215.63 08:24:27 INFO - PROCESS | 1651 | Values: 374.3 374.7 384.3 386.7 402.5 18178.7 19225.6 19681.8 19826.1 19944.9 18956.1 19164.8 19350.1 19414.8 19756.5 4629.7 5751.2 5947.9 5977.0 5993.3 4201.1 4437.7 5779.5 5955.1 6267.1 6501.0 6558.3 6564.7 6616.2 6619.7 5279.0 6525.4 6553.6 6560.0 6571.5 5541.9 5669.6 5679.5 5723.1 5732.9 24633.0 24802.8 24893.5 24902.0 25317.1 2193.8 2645.9 3016.9 3071.0 3073.8 12603.6 14618.4 15454.8 15597.0 15796.0 1839.1 1845.9 1849.8 1861.0 1915.4 120042.0 124152.0 124607.0 126109.4 126604.0 10601.4 10701.9 11116.8 11201.5 11287.2 13637.8 13644.7 13652.0 13655.9 13719.7 8289.8 8522.9 8532.7 8619.0 8656.4 8495.9 8500.2 8502.6 8600.5 8638.2 5934.0 6116.0 6616.5 6631.3 6751.1 1597.8 1672.5 1679.1 1833.8 1875.7 884.2 891.9 900.3 918.7 966.9 16735.5 19836.6 20190.4 20263.4 20706.4 887.8 929.5 941.8 966.2 982.8 8974.0 9000.0 10265.4 10489.5 10760.7 501504.0 505306.0 614224.0 621462.0 624001.0 74348.0 84574.0 86552.6 89847.2 141723.0 939.9 945.1 964.2 965.3 967.1 17468.7 17976.7 18132.4 18194.0 18242.5 52862.7 53034.5 53169.2 53204.0 57962.7 79565.6 83382.9 83908.2 84593.2 85208.0 6209.2 7288.9 7414.7 7560.2 7978.1 10675.3 12596.4 12653.6 12674.7 12687.8 10848.3 11068.7 11189.0 11270.2 11396.5 10164.8 10648.4 10852.1 10978.0 11413.3 11152.4 11197.8 11257.5 11300.0 11552.6 7387.9 7438.6 7453.2 7536.9 7725.6 9321.6 10888.3 11165.2 11263.5 11316.3 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5431.56 Median:4960.17 stddev:2965.83 (59.8%) stddev-sans-first:2957.72 08:24:27 INFO - PROCESS | 1651 | Values: 1278.0 1410.8 1572.9 1767.5 1783.1 7095.8 7472.6 7726.2 8095.6 8507.1 7948.8 8310.1 8336.6 8368.3 8381.0 2296.0 2313.1 2334.2 2339.3 2344.3 2340.8 2350.2 2377.3 2383.6 2389.5 2291.7 2317.9 2329.9 2330.2 2350.2 1969.3 2298.2 2313.3 2324.0 2341.3 2315.5 2317.6 2348.2 2348.5 2352.9 8293.9 8345.0 8373.7 8376.5 8382.2 5058.3 5182.9 5207.4 5211.1 5226.9 3115.5 3281.3 3312.6 3365.1 3597.7 1049.1 1057.2 1077.8 1080.3 1087.5 10822.4 10824.9 10847.2 10913.9 10915.2 4498.9 4586.8 4667.7 4687.2 4755.3 9265.2 9266.6 9425.9 9465.2 9467.9 5193.7 5197.4 5205.5 5205.6 5209.1 4231.0 4277.9 4720.9 4756.6 4763.8 3810.9 3818.6 3895.8 3911.0 3927.6 1159.4 1217.1 1266.0 1278.9 1288.7 761.3 884.8 902.9 906.0 917.3 5501.8 5578.6 5611.7 5670.8 5827.4 959.3 972.0 1003.9 1012.5 1033.3 3738.5 3789.1 3806.9 3846.5 3940.6 9936.2 10141.1 10260.8 10269.0 10302.2 10111.9 10224.6 10228.5 10230.0 10230.1 6903.0 6920.7 7801.9 7930.4 7959.2 5380.0 5549.3 5624.3 5674.1 5767.3 9292.6 9338.1 9431.2 9432.5 9439.4 9055.0 9380.5 9456.4 9466.8 9469.4 6588.8 6756.5 6922.6 7043.7 7176.7 6883.4 7767.5 7906.6 7965.7 7973.1 6904.8 7150.8 7221.1 7235.2 7272.9 6064.8 6860.7 6942.9 7079.1 7116.3 6607.8 6669.6 6758.6 6764.2 6773.2 4847.9 4856.4 4883.3 4888.1 4910.4 4798.3 4853.6 4944.8 4955.9 4964.5 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4596.81 Median:5211.23 stddev:1415.41 (27.2%) stddev-sans-first:1381.79 08:24:27 INFO - PROCESS | 1651 | Values: 279.9 291.8 296.1 313.0 317.7 5061.0 5332.0 5416.7 5485.6 5633.4 4535.8 5233.8 5244.7 5452.6 5527.6 3457.8 4203.7 4215.8 4255.3 4267.8 3470.4 3719.3 4072.6 4271.4 4278.7 3630.7 4158.7 4167.3 4184.5 4225.4 4052.9 4176.4 4183.0 4192.5 4210.8 3628.6 3632.4 3634.8 3639.5 3641.6 5269.7 5384.3 5397.9 5419.7 5420.6 4666.0 4720.9 4747.9 4761.4 4807.7 4338.8 4500.9 5765.7 5790.1 5798.2 3747.3 3905.6 3940.4 3951.6 3975.3 6070.5 6115.3 6135.0 6201.3 6233.7 4003.4 4004.3 4031.0 4034.0 4043.3 2949.4 3594.0 3935.9 4036.9 4084.4 4100.0 4465.5 4733.1 4756.2 4761.6 5842.5 5878.1 5881.5 5894.9 5944.5 1237.7 1264.7 1307.5 1325.5 1340.5 873.1 889.7 898.1 898.2 905.0 4684.6 4857.7 5221.8 5231.4 5243.6 5119.7 5686.0 5715.8 5733.0 5766.8 4952.3 5149.3 5228.8 5260.4 5297.3 2744.9 2871.0 2991.9 2994.4 3000.0 4978.2 5276.4 5341.4 5954.5 5960.2 4898.9 4986.9 5584.6 5857.9 5895.7 5295.8 5752.8 5872.6 5892.6 5908.3 5049.7 5169.7 5348.0 5716.5 5761.0 4941.7 5247.6 5346.5 5447.9 5536.3 5014.4 5060.7 5839.3 5920.8 5998.7 3171.5 3555.1 3557.9 3808.5 3813.2 5200.7 5451.7 5669.0 5721.2 5739.7 5428.5 5654.2 5708.6 5870.6 5902.4 5811.4 5865.9 5872.4 5913.2 5936.6 5056.6 5294.8 5515.5 5652.8 5747.5 4887.8 5379.8 5612.9 5623.9 5858.6 4837.8 5522.4 5676.8 5741.7 5784.2 08:24:27 INFO - PROCESS | 1651 | 08:24:27 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20121.22 Median:4308.84 stddev:29511.94 (684.9%) stddev-sans-first:29558.17 08:24:27 INFO - PROCESS | 1651 | Values: 555.7 714.0 736.2 764.0 778.1 13949.1 14440.1 14523.7 14601.3 15005.1 13215.6 13436.5 13502.7 13518.7 13523.3 783.0 793.2 802.5 802.8 803.3 626.7 648.4 766.1 776.9 789.9 809.2 812.6 814.5 838.1 839.0 797.9 829.2 833.4 834.6 834.6 597.7 612.7 617.2 618.5 619.6 13385.6 13538.4 13584.1 13655.4 13670.2 13432.8 13615.3 13704.9 13788.2 14024.4 11015.9 11142.4 11299.4 11320.4 11329.2 3532.7 3612.6 3682.8 3705.0 3728.8 82279.0 82369.8 82466.2 83524.2 84964.0 10441.1 10572.5 10599.4 10623.0 10625.6 20321.6 20576.1 20655.0 20761.9 20809.5 6397.7 7509.2 7516.3 7558.2 7763.6 4136.2 4233.6 4289.1 4301.6 4327.8 2747.7 3236.2 3357.8 3364.4 3365.9 582.9 590.5 598.0 608.9 632.4 554.8 611.9 627.6 649.2 684.8 8675.7 8894.0 9071.3 9102.4 9137.3 598.3 617.2 623.5 660.8 671.9 3793.2 4300.6 4316.1 4552.2 4553.4 113103.0 113586.7 114308.0 117062.0 118932.0 82407.0 83508.6 91829.0 99473.0 101406.0 65347.7 79488.6 82968.6 83242.2 84842.6 9091.5 9147.1 9204.3 9503.3 9506.3 46324.5 53169.5 54379.7 54432.5 56917.0 54120.0 68931.7 73903.0 78257.0 79707.6 10061.4 11945.8 12193.1 12201.8 12275.9 13274.5 13464.2 13642.7 13843.4 14020.4 10672.0 12502.4 13165.0 13318.0 13365.9 12687.0 12743.7 13335.2 13639.7 13821.7 12615.1 13148.2 13202.5 13468.7 13642.4 10205.6 10295.5 10767.4 10974.1 11098.5 9367.3 10946.2 11122.2 11128.7 11225.2 08:24:27 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:24:27 INFO - PROCESS | 1651 | 08:24:28 INFO - TEST-INFO | 1651: exit 0 08:24:28 INFO - TEST-OK | dromaeo_css | took 1115224ms 08:24:28 INFO - TEST-START | kraken 08:24:28 INFO - operating with platform_type : mac_ 08:24:28 INFO - Initialising browser for kraken test... 08:24:28 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpWEjkB6/profile http://localhost:49240/getInfo.html) 08:24:31 INFO - PROCESS | 1658 | 2017-01-21 08:24:31.403 plugin-container[1659:11346] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 08:24:31 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:31 INFO - PROCESS | 1658 | 2017-01-21 08:24:31.406 plugin-container[1659:11346] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 08:24:31 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:31 INFO - PROCESS | 1658 | 2017-01-21 08:24:31.407 plugin-container[1659:11346] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:24:31 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 08:24:31 INFO - PROCESS | 1658 | colorDepth:24 08:24:31 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 08:24:31 INFO - PROCESS | 1658 | __metrics 08:24:31 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:24:32 INFO - TEST-INFO | 1658: exit 0 08:24:32 INFO - Browser initialized. 08:24:32 INFO - Running cycle 1/1 for kraken test... 08:24:32 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpWEjkB6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:35 INFO - PROCESS | 1660 | 2017-01-21 08:24:35.178 plugin-container[1661:11472] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 08:24:35 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:35 INFO - PROCESS | 1660 | 2017-01-21 08:24:35.179 plugin-container[1661:11472] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:24:35 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:35 INFO - PROCESS | 1660 | 2017-01-21 08:24:35.179 plugin-container[1661:11472] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:24:44 INFO - PROCESS | 1660 | RSS: Main: 228614144 08:24:44 INFO - PROCESS | 1660 | 08:24:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:48 INFO - PROCESS | 1660 | RSS: Main: 240967680 08:24:48 INFO - PROCESS | 1660 | 08:24:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 08:24:51 INFO - PROCESS | 1660 | RSS: Main: 250105856 08:24:51 INFO - PROCESS | 1660 | 08:24:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 08:24:55 INFO - PROCESS | 1660 | RSS: Main: 253145088 08:24:55 INFO - PROCESS | 1660 | 08:24:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 08:24:58 INFO - PROCESS | 1660 | RSS: Main: 253014016 08:24:58 INFO - PROCESS | 1660 | 08:25:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:00 INFO - PROCESS | 1660 | RSS: Main: 253526016 08:25:00 INFO - PROCESS | 1660 | 08:25:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:04 INFO - PROCESS | 1660 | RSS: Main: 256954368 08:25:04 INFO - PROCESS | 1660 | 08:25:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:08 INFO - PROCESS | 1660 | RSS: Main: 256851968 08:25:08 INFO - PROCESS | 1660 | 08:25:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 08:25:11 INFO - PROCESS | 1660 | RSS: Main: 256397312 08:25:11 INFO - PROCESS | 1660 | 08:25:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:14 INFO - PROCESS | 1660 | RSS: Main: 256626688 08:25:14 INFO - PROCESS | 1660 | 08:25:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:16 INFO - PROCESS | 1660 | RSS: Main: 256794624 08:25:16 INFO - PROCESS | 1660 | 08:25:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:19 INFO - PROCESS | 1660 | RSS: Main: 256733184 08:25:19 INFO - PROCESS | 1660 | 08:25:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:23 INFO - PROCESS | 1660 | RSS: Main: 256671744 08:25:23 INFO - PROCESS | 1660 | 08:25:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:26 INFO - PROCESS | 1660 | RSS: Main: 257146880 08:25:26 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 08:25:28 INFO - PROCESS | 1660 | RSS: Main: 259031040 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | __start_tp_report 08:25:28 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:25:28 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:25:28 INFO - PROCESS | 1660 | |i|pagename|runs| 08:25:28 INFO - PROCESS | 1660 | |0;ai-astar;106;117;117;117;125;102;174;177;174;118 08:25:28 INFO - PROCESS | 1660 | |1;audio-beat-detection;141;117;111;147;112;128;140;134;138;114 08:25:28 INFO - PROCESS | 1660 | |2;audio-dft;191;200;196;197;194;196;195;196;201;205 08:25:28 INFO - PROCESS | 1660 | |3;audio-fft;84;59;59;84;62;61;59;69;104;62 08:25:28 INFO - PROCESS | 1660 | |4;audio-oscillator;95;71;90;73;70;69;90;87;70;73 08:25:28 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;85;89;76;103;94;73;118;126;79;123 08:25:28 INFO - PROCESS | 1660 | |6;imaging-darkroom;100;101;100;102;128;124;100;101;105;102 08:25:28 INFO - PROCESS | 1660 | |7;imaging-desaturate;116;78;135;135;117;91;101;124;87;89 08:25:28 INFO - PROCESS | 1660 | |8;json-parse-financial;57;57;55;59;61;70;77;92;90;60 08:25:28 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;70;75;70;73;76;70;70;70;73;85 08:25:28 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;84;84;85;83;84;85;84;86;83;86 08:25:28 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;151;155;157;142;152;148;160;163;184;166 08:25:28 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;185;233;164;166;185;169;179;216;165;166 08:25:28 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;67;68;73;64;60 08:25:28 INFO - PROCESS | 1660 | __end_tp_report 08:25:28 INFO - PROCESS | 1660 | __start_cc_report 08:25:28 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,953 08:25:28 INFO - PROCESS | 1660 | __end_cc_report 08:25:28 INFO - PROCESS | 1660 | __startTimestamp1485015928654__endTimestamp 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:25:28 INFO - PROCESS | 1660 | Number of tests: 14 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:132.70 Median:121.50 stddev:29.90 (24.6%) stddev-sans-first:30.11 08:25:28 INFO - PROCESS | 1660 | Values: 106.0 117.0 117.0 117.0 125.0 102.0 174.0 177.0 174.0 118.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:136.00 stddev:13.63 (10.0%) stddev-sans-first:13.65 08:25:28 INFO - PROCESS | 1660 | Values: 141.0 117.0 111.0 147.0 112.0 128.0 140.0 134.0 138.0 114.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:197.10 Median:196.50 stddev:3.96 (2.0%) stddev-sans-first:3.53 08:25:28 INFO - PROCESS | 1660 | Values: 191.0 200.0 196.0 197.0 194.0 196.0 195.0 196.0 201.0 205.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:70.30 Median:62.00 stddev:15.35 (24.8%) stddev-sans-first:15.46 08:25:28 INFO - PROCESS | 1660 | Values: 84.0 59.0 59.0 84.0 62.0 61.0 59.0 69.0 104.0 62.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:80.00 stddev:10.33 (12.9%) stddev-sans-first:9.14 08:25:28 INFO - PROCESS | 1660 | Values: 95.0 71.0 90.0 73.0 70.0 69.0 90.0 87.0 70.0 73.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:77.50 stddev:19.86 (25.6%) stddev-sans-first:20.62 08:25:28 INFO - PROCESS | 1660 | Values: 85.0 89.0 76.0 103.0 94.0 73.0 118.0 126.0 79.0 123.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:102.00 stddev:10.53 (10.3%) stddev-sans-first:10.92 08:25:28 INFO - PROCESS | 1660 | Values: 100.0 101.0 100.0 102.0 128.0 124.0 100.0 101.0 105.0 102.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:106.50 stddev:20.80 (19.5%) stddev-sans-first:21.82 08:25:28 INFO - PROCESS | 1660 | Values: 116.0 78.0 135.0 135.0 117.0 91.0 101.0 124.0 87.0 89.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:65.50 stddev:13.94 (21.3%) stddev-sans-first:14.23 08:25:28 INFO - PROCESS | 1660 | Values: 57.0 57.0 55.0 59.0 61.0 70.0 77.0 92.0 90.0 60.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.00 stddev:4.73 (6.5%) stddev-sans-first:4.88 08:25:28 INFO - PROCESS | 1660 | Values: 70.0 75.0 70.0 73.0 76.0 70.0 70.0 70.0 73.0 85.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.07 (1.3%) stddev-sans-first:1.13 08:25:28 INFO - PROCESS | 1660 | Values: 84.0 84.0 85.0 83.0 84.0 85.0 84.0 86.0 83.0 86.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:157.80 Median:158.50 stddev:11.64 (7.3%) stddev-sans-first:12.08 08:25:28 INFO - PROCESS | 1660 | Values: 151.0 155.0 157.0 142.0 152.0 148.0 160.0 163.0 184.0 166.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:182.00 stddev:23.74 (13.0%) stddev-sans-first:25.17 08:25:28 INFO - PROCESS | 1660 | Values: 185.0 233.0 164.0 166.0 185.0 169.0 179.0 216.0 165.0 166.0 08:25:28 INFO - PROCESS | 1660 | 08:25:28 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:3.26 (4.9%) stddev-sans-first:3.46 08:25:28 INFO - PROCESS | 1660 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 68.0 73.0 64.0 60.0 08:25:28 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:25:28 INFO - PROCESS | 1660 | 08:25:29 INFO - TEST-INFO | 1660: exit 0 08:25:29 INFO - TEST-OK | kraken | took 61223ms 08:25:29 INFO - SUITE-END | took 1176s 08:25:29 INFO - Completed test suite (00:19:36) 08:25:29 INFO - javascript benchmark 08:25:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7174.356655317004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3422.7775194612364, 3430.1767575781814, 3456.7925924444526, 3469.7397695172854, 3476.0440878758354, 5701.800436984707, 5771.480566748997, 5811.941880581193, 5812.215350927634, 5826.300843898733, 5826.475617194452, 5916.2308899843065, 5927.911081333784, 5936.851578710523, 5942.792002279921, 4194.580541945811, 5296.3379577552805, 5309.654872433289, 5412.83761487156, 5425.647332923367, 5458.426865179159, 5480.095784195603, 5480.945190548104, 5488.7530061147145, 5490.450954904498, 5292.179712144623, 5317.335333083364, 5449.945500545004, 5451.0, 5455.727213639322, 5326.041312563737, 5353.170258609902, 5410.864728381783, 5458.6724796511935, 5498.1752737089755, 5278.736063196825, 5382.2464854920345, 5395.352557693062, 5411.21537377082, 5428.375736790241, 5654.321481422256, 5845.824625261249, 5866.413358664099, 5949.524038076944, 5970.432808883149, 6173.382661733835, 6222.96888515559, 6225.035119556476, 6281.246250449975, 6353.396427339396, 6314.368563143695, 6344.936550634527, 6351.047342898556, 6356.841078973016, 6362.300146983828, 5919.763209471616, 5962.731677074542, 5967.1347654589845, 5974.880502389928, 5981.0729336952845, 6207.441330280297, 6258.561900666909, 6293.811185664437, 6304.590201636879, 6316.557840951089, 6198.690065496708, 6261.624302541862, 6282.905756413657, 6291.905621415683, 6297.6536290503545, 5516.696581687966, 6324.968375158095, 6325.114483972247, 6345.397187267202, 6368.522360822864, 5326.7869285228935, 5708.372079071299, 5966.970165149147, 6107.603005804608, 6187.257529096537, 5566.916496252559, 6179.938200618026, 6350.65071421067, 6360.968195158995, 6374.745010199633, 5020.874478138003, 5024.974875125601, 5035.84892453227, 5037.571806396498, 5038.672486288379, 4333.025069359432, 4366.104948485617, 4431.047324825178, 4493.6854420190275, 4519.367288579601, 5410.945890541044, 5489.725513724298, 5943.940560594338, 5976.850578735566, 6040.124181993587, 6318.842028949313, 6324.810255692337, 6337.873242535124, 6342.841428964312, 6379.425851673279, 5789.044807606698, 5887.146363777314, 5968.940310596925, 5982.880342393128, 5993.160957465958, 5514.80698175562, 5516.089845175501, 5516.9448305516435, 5541.473560011873, 5541.9168712469345, 6451.161349024596, 6468.838279043061, 6471.611703297817, 6473.06140609609, 6493.805185844432, 6157.630542167484, 6184.0, 6242.0, 6261.843453913689, 6331.430171284606, 6472.579282346633, 6481.578697384655, 6483.157189565326, 6484.5460817742305, 6525.282218956006, 6309.211348581427, 6329.208848893888, 6334.144890439732, 6337.524685648503, 6341.619502829845, 6241.687915604292, 6280.9685951569945, 6281.152044473937, 6323.683815809283, 6330.303666596763, 4816.470188279357, 6118.9846826261555, 6143.112737013596, 6190.102435146969, 6252.562320637512, 6185.505159587312, 6230.6884655766125, 6242.3133455320785, 6245.219347581552, 6273.74905003813, 4947.45577986414, 5902.1736956826935, 5926.436988486087, 5964.671943043, 6139.2325959255095, 6136.0, 6146.200993870947, 6156.415140561639, 6265.655388953652, 6269.840079585291, 6134.78528251509, 6149.938500614937, 6165.445109940127, 6172.5679202457195, 6191.133241346125], "value": 5784.736088530895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.98267741677984, 473.6613321475145, 488.0190816458917, 519.2470917170103, 523.8428471458561, 31452.68547314529, 36154.0, 38795.0, 38814.22371552567, 38847.028824279405, 39168.804155979255, 39474.0, 39527.0, 39564.406533902016, 39565.604343956555, 9270.629174832999, 9316.394434361744, 9338.252939764803, 9435.481048542328, 9474.05259474054, 9131.908680913173, 9273.07269273074, 9298.860517092215, 9337.393069450463, 9379.437233765962, 9252.67615633453, 9301.441913485212, 9301.674441394553, 9361.953190234039, 9381.15569598736, 9150.130737579919, 9249.12133347331, 9318.72043838686, 9336.486493242868, 9346.252299815998, 9304.674336398193, 9363.719088427359, 9396.62413503459, 9405.670801521914, 9408.0, 37274.25451490982, 37670.246595068216, 38022.809885950395, 38069.428958565644, 38098.80950595229, 3177.0, 3329.6836800503916, 3386.0011296667544, 3458.792472451661, 3720.9813950930343, 29544.0, 29752.55371169434, 30053.849730751426, 30190.396192076034, 30196.24509387283, 3125.9687403125904, 3216.5818443602416, 3218.5494030835703, 3222.4038552867796, 3245.318483118548, 503323.0, 505213.0, 505396.47301763255, 505802.0, 505998.4700076513, 54495.0, 54728.0, 55156.0, 55672.44327556754, 55720.44279557152, 57868.42131578714, 58441.70779146077, 58636.41363586395, 58729.70635146797, 58781.41218587845, 15589.532314030597, 15614.0, 15681.68636627261, 15812.683746325009, 15830.28763705636, 12287.385630718429, 12290.262584244794, 12376.690582735324, 12382.75234495305, 12393.442295096742, 13015.804762928563, 14716.852831471762, 15050.849491505163, 15052.441085015573, 15226.46707365237, 3185.761067919915, 5059.519345662156, 5377.7580008899695, 6649.4347980421235, 6697.8995315070315, 856.7900864288165, 906.60109551797, 961.024560071514, 992.5235886774389, 1100.4277775556666, 28680.0, 29016.7098329014, 29391.412171756445, 30069.0, 30358.241043974078, 714.7569826259097, 857.8241460500583, 908.5094049213483, 1038.657243109787, 1122.5060973171778, 14710.55868323952, 14768.335424905905, 14902.925485372503, 14911.403543858341, 15642.765358519631, 558821.0, 706587.0, 709695.0, 712093.0, 713342.0, 55522.16716749252, 55879.720601397545, 55887.44112558822, 55930.44069559334, 56196.719016404655, 1139.8544462814818, 1356.7286542691502, 1356.9932150339184, 1376.7865980772997, 1379.703363776813, 29160.27099322534, 29911.401771964873, 30130.548041779828, 30252.84873575618, 30511.08466746001, 47337.05325893532, 48150.518494816, 48167.277490838365, 48178.518214817406, 48399.75800120977, 622423.0, 624000.0, 626703.0, 627101.322466942, 628058.0, 24786.50426991486, 24903.62644560369, 24954.251372458857, 25303.74696253014, 25344.873275633505, 42750.57249427466, 42925.0, 43428.78285608552, 44011.55988440075, 44058.55941440545, 33865.98402047942, 33928.0, 33931.0, 34121.0, 34424.483632745025, 30772.384552309275, 34024.82987585046, 36165.819170903975, 36882.8155859219, 37136.62863371332, 35108.946731598095, 35115.29769404649, 35637.0, 35822.641773581934, 36041.0, 25235.87382063078, 32859.83570082134, 32933.34133317368, 32967.17582060468, 33036.66963330336, 19326.76894893513, 19453.124609392893, 22952.540949181257, 22987.0, 23009.424764381023], "value": 18890.291189880845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.27577637271884, 374.7483405425877, 384.2871473416812, 386.7312218008485, 402.5491449576473, 18178.72731909021, 19225.615487690236, 19681.803181968175, 19826.10782514787, 19944.900275498603, 18956.05219739011, 19164.808351916476, 19350.12924418401, 19414.80585194151, 19756.50608734779, 4629.675922685414, 5751.166080918275, 5947.940520594803, 5977.043673012319, 5993.250843644544, 4201.138766552865, 4437.711548749337, 5779.508741756935, 5955.136505206742, 6267.122602835607, 6500.992346186349, 6558.278589355167, 6564.704588293538, 6616.172978377703, 6619.735210591571, 5278.973605131969, 6525.412712855842, 6553.6395498247575, 6560.0, 6571.507136964723, 5541.855937702822, 5669.6314739541795, 5679.545636349124, 5723.112917497794, 5732.942670573324, 24633.0, 24802.751972480226, 24893.50212995748, 24902.0, 25317.11390101356, 2193.8025577698086, 2645.854478003709, 3016.894408695707, 3070.969290307113, 3073.7694672899397, 12603.621891343275, 14618.415263389452, 15454.768178477332, 15596.986195897343, 15795.973261738065, 1839.0804597701149, 1845.9261629534803, 1849.824266694662, 1860.962780744391, 1915.3775023117541, 120042.0, 124152.0, 124607.0, 126109.36945315215, 126604.0, 10601.41692206936, 10701.946490267499, 11116.833247501294, 11201.495932683049, 11287.20989530725, 13637.795433068512, 13644.727105457836, 13652.0, 13655.931720341534, 13719.657008574866, 8289.751307460785, 8522.914770852212, 8532.70135545253, 8619.0, 8656.437331573428, 8495.872561911576, 8500.234978851933, 8502.617382217815, 8600.483970961637, 8638.222559969632, 5933.970330148408, 6116.0, 6616.503762217853, 6631.3090162008375, 6751.0886030386255, 1597.752348386002, 1672.523330850726, 1679.1016806008727, 1833.7988617455587, 1875.7057630235095, 884.195382202193, 891.8974317953518, 900.2797761790541, 918.7060140755028, 966.8501382285757, 16735.49793506197, 19836.60326793485, 20190.394288171377, 20263.392098237076, 20706.378808635764, 887.7824932891483, 929.5259417696888, 941.773974246176, 966.246327864267, 982.8034393121404, 8974.0, 8999.965004024622, 10265.384076955406, 10489.479025541254, 10760.677179684622, 501504.0, 505306.0, 614224.0, 621462.0, 624001.0, 74348.0, 84574.0, 86552.56723716341, 89847.20305593852, 141723.0, 939.8590211468335, 945.1257586732245, 964.2093483343731, 965.280865755017, 967.1005964453267, 17468.73796893022, 17976.730349044512, 18132.365367212085, 18194.0, 18242.45272641823, 52862.67843303948, 53034.46965530295, 53169.202461963876, 53204.0, 57962.7101864488, 79565.60217198876, 83382.91542711481, 83908.16091839003, 84593.15406845853, 85208.0, 6209.223847019122, 7288.890666640111, 7414.740484083031, 7560.206178351194, 7978.0825205102155, 10675.306105103144, 12596.433160507982, 12653.620391388273, 12674.746505070032, 12687.80968285495, 10848.349099054081, 11068.723281918017, 11188.992990630883, 11270.211085223955, 11396.48715807774, 10164.84752728695, 10648.361098334124, 10852.131829453467, 10978.0, 11413.315201087962, 11152.386618736047, 11197.776044479227, 11257.493412796608, 11300.0, 11552.59565915189, 7387.889181662387, 7438.590877501573, 7453.180150183367, 7536.869469579607, 7725.575093369918, 9321.580528876082, 10888.29226100301, 11165.218434709492, 11263.549458021587, 11316.26444281152], "value": 9571.64472607141, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.0350835119484, 1410.8165938428003, 1572.9225480545826, 1767.5227688524108, 1783.1262681286173, 7095.7516486922905, 7472.58900760458, 7726.227377262271, 8095.554744489051, 8507.149285071497, 7948.761537153895, 8310.12743661916, 8336.624851881665, 8368.330533557317, 8381.0, 2295.954080918385, 2313.097891822191, 2334.171369163948, 2339.2748248043076, 2344.296710986706, 2340.777626125524, 2350.224425939436, 2377.2511658827416, 2383.5947888858936, 2389.474315650554, 2291.702078729763, 2317.918872839451, 2329.9184528541505, 2330.1611419888827, 2350.165691179632, 1969.2516843599412, 2298.1841446286494, 2313.3175713164655, 2324.035525257016, 2341.285907798121, 2315.513742114141, 2317.606006978801, 2348.178137651825, 2348.518553696488, 2352.8941197646145, 8293.917060829435, 8344.958275208584, 8373.743938409227, 8376.53929033903, 8382.16178382157, 5058.342415486, 5182.922256166161, 5207.375114986188, 5211.088059589594, 5226.869328266824, 3115.517094850302, 3281.3109247058146, 3312.5590368189673, 3365.125067482448, 3597.7301702372165, 1049.0663309654415, 1057.2229411382627, 1077.805994920914, 1080.3193987787722, 1087.4943151434543, 10822.404767737771, 10824.891751082467, 10847.186461015377, 10913.890861091368, 10915.235933484659, 4498.932516012263, 4586.793594288265, 4667.743274119888, 4687.226607609774, 4755.262934245197, 9265.166135047743, 9266.629334826666, 9425.905740942502, 9465.195458386115, 9467.857982130274, 5193.68837869729, 5197.376314842243, 5205.5315021647475, 5205.635605507654, 5209.114450543417, 4230.978845105817, 4277.935830962538, 4720.858374248709, 4756.619470442356, 4763.809447622126, 3810.904727381838, 3818.560865500503, 3895.824687889052, 3910.980445097813, 3927.587603301612, 1159.3507635724022, 1217.0750229825396, 1265.9683507912375, 1278.8721127887322, 1288.6778305423645, 761.3452430909414, 884.8451520983803, 902.9277657787361, 905.9501727404925, 917.2936838634214, 5501.779928802883, 5578.553715702734, 5611.691356975405, 5670.7731690732735, 5827.417258274223, 959.3380567408466, 972.0, 1003.9347442416366, 1012.4684540616236, 1033.3128469567803, 3738.532683414573, 3789.1285004448578, 3806.885793426202, 3846.519185101862, 3940.625640564142, 9936.205103591696, 10141.138003269658, 10260.794784104426, 10269.0, 10302.227332950059, 10111.898881011095, 10224.64213752515, 10228.488575571191, 10230.0, 10230.079292863678, 6902.965485172542, 6920.688569014406, 7801.882971755428, 7930.405219608437, 7959.164287749819, 5380.0, 5549.278593782944, 5624.29696287964, 5674.092145256739, 5767.3367562729145, 9292.6282948684, 9338.066193380608, 9431.198348140484, 9432.52837358143, 9439.433633981984, 9055.0, 9380.530973451163, 9456.385334953206, 9466.763330916781, 9469.384490008128, 6588.835279117869, 6756.493263005196, 6922.550034247758, 7043.718251269892, 7176.712931482891, 6883.414909732729, 7767.456278060482, 7906.604669766603, 7965.681372745025, 7973.122956474899, 6904.758333458305, 7150.785476435715, 7221.061262035902, 7235.167955685163, 7272.927270727225, 6064.757409703562, 6860.656967151723, 6942.923846803754, 7079.115110611174, 7116.288371162842, 6607.834804129935, 6669.566478178903, 6758.628275444701, 6764.188297404343, 6773.153355830521, 4847.903041939212, 4856.368672072608, 4883.267509873547, 4888.095702295087, 4910.386201724785, 4798.2802579613335, 4853.611711063177, 4944.82693105754, 4955.884925891645, 4964.4539100698175], "value": 4417.791781678788, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.86846182294323, 291.8074071113066, 296.09985643643324, 312.9671384504627, 317.73310419247827, 5060.974695126524, 5331.973340133303, 5416.702081385522, 5485.588580856442, 5633.380328163904, 4535.795889184987, 5233.796226867813, 5244.711540865251, 5452.609584555933, 5527.55779537637, 3457.8098204598737, 4203.684723645739, 4215.810288537024, 4255.319148936171, 4267.829286828539, 3470.3753324401596, 3719.340671419934, 4072.617518751534, 4271.444712187426, 4278.694998025601, 3630.6913912317355, 4158.708890377659, 4167.291560434734, 4184.4978602567735, 4225.359150530918, 4052.918941621151, 4176.394422808676, 4182.954261434641, 4192.496900371944, 4210.768407737573, 3628.618995005539, 3632.418812989909, 3634.83643236055, 3639.5268615080136, 3641.5630124385243, 5269.710165940872, 5384.326959130109, 5397.919031214535, 5419.729013549307, 5420.620556561043, 4666.0, 4720.858374248778, 4747.8575642730775, 4761.357216775726, 4807.663463557552, 4338.826446942118, 4500.864974050751, 5765.711714414262, 5790.073588225906, 5798.202557207279, 3747.3019426013225, 3905.628965248297, 3940.428637847525, 3951.597183000022, 3975.3241948868763, 6070.484008859252, 6115.296740874812, 6134.96932515339, 6201.317855035897, 6233.698747863959, 4003.3794761811964, 4004.3392840181045, 4030.984507746127, 4034.0, 4043.332850079763, 2949.42486215186, 3593.964060359363, 3935.901602459904, 4036.9394459083137, 4084.4281800547947, 4099.97950010254, 4465.531119232499, 4733.148033354029, 4756.170078803107, 4761.571458568746, 5842.474177324061, 5878.147668588031, 5881.470667639933, 5894.850504151735, 5944.464998150187, 1237.7029512917015, 1264.709995804293, 1307.4704744578462, 1325.4963114016805, 1340.4973135074347, 873.1486800369715, 889.7286327669993, 898.0749827677503, 898.2185498616116, 905.0, 4684.578387945033, 4857.659963802571, 5221.765020574083, 5231.372235331784, 5243.580513558983, 5119.692818430906, 5686.0, 5715.799947001919, 5732.971335143297, 5766.826995190151, 4952.2914594464855, 5149.292509393231, 5228.777769447969, 5260.421353651095, 5297.311349524614, 2744.874601413451, 2870.985645071761, 2991.880324786984, 2994.37118205175, 2999.9550006749914, 4978.182963218399, 5276.366835979707, 5341.439148889388, 5954.469350526009, 5960.159044136683, 4898.853034408902, 4986.850394488171, 5584.609077364546, 5857.912131318034, 5895.7052147393315, 5295.788168473218, 5752.769889204469, 5872.647641141545, 5892.616979896378, 5908.261467316585, 5049.748261807679, 5169.689818610896, 5347.973260133675, 5716.514096301861, 5761.020626493422, 4941.728204948618, 5247.635614740118, 5346.545543628835, 5447.945520544902, 5536.307961504812, 5014.398272207359, 5060.746962651926, 5839.270091238595, 5920.763169473345, 5998.670073146019, 3171.460851655178, 3555.1112221944513, 3557.928841423105, 3808.5239345081864, 3813.161104556993, 5200.6879587224885, 5451.672899626035, 5669.0, 5721.19661365936, 5739.684317362418, 5428.45715428454, 5654.247183373168, 5708.629928817137, 5870.589058766016, 5902.439268269508, 5811.38487680537, 5865.912011319919, 5872.354041055395, 5913.156448308634, 5936.554758393051, 5056.598115894921, 5294.841154765363, 5515.531179849597, 5652.77791658767, 5747.453991870766, 4887.804487820447, 5379.784808607612, 5612.85967850807, 5623.915641265303, 5858.5898987072205, 4837.806487740451, 5522.438027472338, 5676.836248569116, 5741.712914354349, 5784.21913041734], "value": 4139.23660153154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6860373888752, 713.9714411423544, 736.2343163110365, 763.9694412223508, 778.0740918307214, 13949.093308934926, 14440.133591984488, 14523.709525809478, 14601.342939567718, 15005.099694018367, 13215.603531894034, 13436.52972145975, 13502.662433439169, 13518.662033449169, 13523.256220907846, 783.0212234706617, 793.1869833420732, 802.4783890471182, 802.7993001749562, 803.3131672420055, 626.7054484392328, 648.44881850427, 766.0768773627765, 776.9106552746422, 789.917058708836, 809.2069771623812, 812.6140083460368, 814.5031530766228, 838.0864857305536, 839.0476808822001, 797.9042514898191, 829.1749709039544, 833.3916241143969, 834.5785378383907, 834.64110432514, 597.7399831073453, 612.7395856760903, 617.2038070888549, 618.5453691536717, 619.6313193649817, 13385.598432047054, 13538.390772415265, 13584.117032392962, 13655.38550765218, 13670.248136352497, 13432.798508022388, 13615.25116118613, 13704.862951370558, 13788.241646709426, 14024.439022439192, 11015.944920275428, 11142.442877856074, 11299.435028248554, 11320.433978301053, 11329.206955513117, 3532.717382609385, 3612.566492020948, 3682.779033258013, 3704.9814750926344, 3728.7949162796035, 82279.0, 82369.76445353325, 82466.17533824645, 83524.16475835224, 84964.0, 10441.112505436971, 10572.471376431147, 10599.364038157735, 10623.034738573235, 10625.628103016357, 20321.593568128555, 20576.074076666588, 20655.0, 20761.89619051895, 20809.479763006046, 6397.744090236339, 7509.211532789088, 7516.323530882138, 7558.206388329256, 7763.573003484749, 4136.152088821845, 4233.597808208216, 4289.120730250291, 4301.5698430156735, 4327.82688692455, 2747.7114902935305, 3236.1909522619344, 3357.815320157366, 3364.444866597033, 3365.899023029313, 582.8659408336107, 590.5275779376482, 598.0132780911531, 608.9269287685418, 632.4371309534517, 554.7586799742045, 611.9326874043852, 627.5513008199159, 649.2339039932924, 684.7569112964925, 8675.6529738811, 8894.0, 9071.27429805614, 9102.362834601647, 9137.314701397421, 598.3418239936035, 617.1544983372808, 623.4731651754352, 660.8447014951579, 671.9328067193339, 3793.241351729665, 4300.591443812833, 4316.115196384733, 4552.157850797613, 4553.430821147356, 113103.0, 113586.72826543423, 114308.0, 117062.0, 118932.0, 82407.0, 83508.58245708732, 91829.0, 99473.00526994783, 101406.0, 65347.67326163339, 79488.60255698685, 82968.58515707383, 83242.16757832465, 84842.57578712191, 9091.545422728705, 9147.0852914708, 9204.309676774135, 9503.334766566273, 9506.334556580972, 46324.53675463202, 53169.468305318, 54379.72810135924, 54432.455675444326, 56917.0, 54120.0, 68931.65534172297, 73903.0, 78257.0, 79707.60146199232, 10061.39631622105, 11945.820812687643, 12193.146479746332, 12201.816972745593, 12275.877241227474, 13274.535391261259, 13464.192148471124, 13642.658933526742, 13843.377048032662, 14020.369083391475, 10672.039516443558, 12502.437390317276, 13165.0, 13318.00114991399, 13365.866341336463, 12687.0484713645, 12743.745125097632, 13335.199888006751, 13639.659008524866, 13821.654458638615, 12615.116941813985, 13148.211107333591, 13202.537911173064, 13468.663283417993, 13642.386092625657, 10205.591776328863, 10295.485225738534, 10767.407792571485, 10974.122070234522, 11098.500567474644, 9367.344285899922, 10946.179036572448, 11122.221444498808, 11128.721781955192, 11225.214235003472], "value": 7128.844460660086, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 117.0, 117.0, 125.0, 102.0, 174.0, 177.0, 174.0, 118.0], "value": 132.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 111.0, 147.0, 112.0, 128.0, 140.0, 134.0, 138.0, 114.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 200.0, 196.0, 197.0, 194.0, 196.0, 195.0, 196.0, 201.0, 205.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 84.0, 62.0, 61.0, 59.0, 69.0, 104.0, 62.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 71.0, 90.0, 73.0, 70.0, 69.0, 90.0, 87.0, 70.0, 73.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 76.0, 103.0, 94.0, 73.0, 118.0, 126.0, 79.0, 123.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 100.0, 102.0, 128.0, 124.0, 100.0, 101.0, 105.0, 102.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 78.0, 135.0, 135.0, 117.0, 91.0, 101.0, 124.0, 87.0, 89.0], "value": 107.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 59.0, 61.0, 70.0, 77.0, 92.0, 90.0, 60.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 70.0, 73.0, 76.0, 70.0, 70.0, 70.0, 73.0, 85.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 83.0, 84.0, 85.0, 84.0, 86.0, 83.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 157.0, 142.0, 152.0, 148.0, 160.0, 163.0, 184.0, 166.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 233.0, 164.0, 166.0, 185.0, 169.0, 179.0, 216.0, 165.0, 166.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 73.0, 64.0, 60.0], "value": 66.8, "unit": "score"}]}]} 08:25:29 INFO - Return code: 0 08:25:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:29 ERROR - # TBPL SUCCESS # 08:25:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:25:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:25:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:25:29 INFO - 2017-01-21 08:25:29.977 screenresolution[1665:11998] starting screenresolution argv=screenresolution get 08:25:29 INFO - 2017-01-21 08:25:29.979 screenresolution[1665:11998] Display 0: 1600x1200x32@60 08:25:29 INFO - 2017-01-21 08:25:29.985 screenresolution[1666:12001] starting screenresolution argv=screenresolution list 08:25:29 INFO - Available Modes on Display 0 08:25:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:25:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:25:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:25:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:25:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:25:30 INFO - Intel Iris: 08:25:30 INFO - Chipset Model: Intel Iris 08:25:30 INFO - Type: GPU 08:25:30 INFO - Bus: Built-In 08:25:30 INFO - VRAM (Dynamic, Max): 1536 MB 08:25:30 INFO - Vendor: Intel (0x8086) 08:25:30 INFO - Device ID: 0x0a2e 08:25:30 INFO - Revision ID: 0x0009 08:25:30 INFO - Displays: 08:25:30 INFO - Display: 08:25:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:25:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:25:30 INFO - Display Serial Number: 1600x1200 60 08:25:30 INFO - Main Display: Yes 08:25:30 INFO - Mirror: Off 08:25:30 INFO - Online: Yes 08:25:30 INFO - Rotation: Supported 08:25:30 INFO - Return code: 0 08:25:30 INFO - Running post-action listener: _resource_record_post_action 08:25:30 INFO - [mozharness: 2017-01-21 16:25:30.229896Z] Finished run-tests step (success) 08:25:30 INFO - Running post-run listener: _resource_record_post_run 08:25:30 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33374720; Write bytes: 665223168; Read time: 201; Write time: 1942 08:25:30 INFO - TinderboxPrint: CPU usage
54.3% 08:25:30 INFO - TinderboxPrint: I/O read bytes / time
33,374,720 / 201 08:25:30 INFO - TinderboxPrint: I/O write bytes / time
665,223,168 / 1,942 08:25:30 INFO - TinderboxPrint: CPU idle
2,209.1 (45.7%) 08:25:30 INFO - TinderboxPrint: CPU system
976.8 (20.2%) 08:25:30 INFO - TinderboxPrint: CPU user
1,651.7 (34.1%) 08:25:30 INFO - TinderboxPrint: Swap in / out
381,210,624 / 0 08:25:30 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 348994048; Write bytes: 348231680; Read time: 27636; Write time: 734 08:25:30 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31298048; Write bytes: 309815296; Read time: 182; Write time: 1179 08:25:30 INFO - Running post-run listener: _upload_blobber_files 08:25:30 INFO - Blob upload gear active. 08:25:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:30 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:25:30 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:25:30 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:25:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:32 INFO - (blobuploader) - INFO - Done attempting. 08:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:25:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:33 INFO - (blobuploader) - INFO - Done attempting. 08:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:35 INFO - (blobuploader) - INFO - Done attempting. 08:25:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:35 INFO - Return code: 0 08:25:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa4d9759fe3b9c63ebbf621c14037454deee901c0e69a372069b58a61c55fa136124d0b915536f97adc364285c70cbf9ba21ccd24a164a90d6d31f534f77c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9cc35dbd1f8e8aab9a153742e867e61a60f9b41055cbee9871510ccb62b209acc5d1f317c0f3523f8d0e13b9f9a6ff684425d92c5600c5d876c2fb505b8470d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/677a953516944cc8bfd48b60aad9f178c6ecd35a5ca3d264e25dec6abe660ab2cdcd1457f8e5722dbacd8fc6482994938cf67b1f59fb0f825e9db12832947e36"} 08:25:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:35 INFO - Contents: 08:25:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa4d9759fe3b9c63ebbf621c14037454deee901c0e69a372069b58a61c55fa136124d0b915536f97adc364285c70cbf9ba21ccd24a164a90d6d31f534f77c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9cc35dbd1f8e8aab9a153742e867e61a60f9b41055cbee9871510ccb62b209acc5d1f317c0f3523f8d0e13b9f9a6ff684425d92c5600c5d876c2fb505b8470d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/677a953516944cc8bfd48b60aad9f178c6ecd35a5ca3d264e25dec6abe660ab2cdcd1457f8e5722dbacd8fc6482994938cf67b1f59fb0f825e9db12832947e36"} 08:25:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:35 INFO - Copying logs to upload dir... 08:25:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.373918 ========= master_lag: 2.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-21 08:25:38.145227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 08:25:38.150429) ========= 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.L2BL11ISPM/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.V0cK9UCUzj/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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/3aa4d9759fe3b9c63ebbf621c14037454deee901c0e69a372069b58a61c55fa136124d0b915536f97adc364285c70cbf9ba21ccd24a164a90d6d31f534f77c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9cc35dbd1f8e8aab9a153742e867e61a60f9b41055cbee9871510ccb62b209acc5d1f317c0f3523f8d0e13b9f9a6ff684425d92c5600c5d876c2fb505b8470d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/677a953516944cc8bfd48b60aad9f178c6ecd35a5ca3d264e25dec6abe660ab2cdcd1457f8e5722dbacd8fc6482994938cf67b1f59fb0f825e9db12832947e36"} build_url:https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/b8QGS0x6SleI5IAcI54Oqg/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/3aa4d9759fe3b9c63ebbf621c14037454deee901c0e69a372069b58a61c55fa136124d0b915536f97adc364285c70cbf9ba21ccd24a164a90d6d31f534f77c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9cc35dbd1f8e8aab9a153742e867e61a60f9b41055cbee9871510ccb62b209acc5d1f317c0f3523f8d0e13b9f9a6ff684425d92c5600c5d876c2fb505b8470d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/677a953516944cc8bfd48b60aad9f178c6ecd35a5ca3d264e25dec6abe660ab2cdcd1457f8e5722dbacd8fc6482994938cf67b1f59fb0f825e9db12832947e36"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 08:25:38.190560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-01-21 08:25:38.190861) ========= 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.L2BL11ISPM/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.V0cK9UCUzj/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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.005134 ========= master_lag: 3.96 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-01-21 08:25:42.158611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 08:25:42.158993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 08:25:42.165038) ========= ========= Total master_lag: 6.28 =========