builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0023 starttime: 1485266171.7 results: success (0) buildid: 20170124031844 builduid: 63e14f3674a54fb1942699bb1e70483f revision: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.704205) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.704642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.704918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.730621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.731261) ========= 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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-24 05:56:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 55.8M=0s 2017-01-24 05:56:11 (55.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141268 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.899245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:11.899873) ========= 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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.020318 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:12.050180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:56:12.050489) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-24 05:56:12,167 truncating revision to first 12 chars 2017-01-24 05:56:12,167 Setting DEBUG logging. 2017-01-24 05:56:12,167 attempt 1/10 2017-01-24 05:56:12,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5a883b3f3178?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 05:56:12,884 unpacking tar archive at: mozilla-beta-5a883b3f3178/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982683 ========= master_lag: 0.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:56:13.786985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:13.787325) ========= script_repo_revision: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:13.787715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:13.787979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:56:13.809108) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 05:56:13.809449) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:56:14 INFO - MultiFileLogger online at 20170124 05:56:14 in /builds/slave/test 05:56:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:56:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:14 INFO - {'append_to_log': False, 05:56:14 INFO - 'base_work_dir': '/builds/slave/test', 05:56:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:56:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:14 INFO - 'branch': 'Mozilla-Beta', 05:56:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:14 INFO - 'config_files': ('talos/mac_config.py',), 05:56:14 INFO - 'default_actions': ('clobber', 05:56:14 INFO - 'read-buildbot-config', 05:56:14 INFO - 'download-and-extract', 05:56:14 INFO - 'populate-webroot', 05:56:14 INFO - 'create-virtualenv', 05:56:14 INFO - 'install', 05:56:14 INFO - 'run-tests'), 05:56:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:14 INFO - 'download_minidump_stackwalk': True, 05:56:14 INFO - 'download_symbols': 'ondemand', 05:56:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:14 INFO - 'installer_path': 'installer.exe', 05:56:14 INFO - 'log_level': 'info', 05:56:14 INFO - 'log_name': 'talos', 05:56:14 INFO - 'log_to_console': True, 05:56:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:56:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:56:14 INFO - 'opt_config_files': (), 05:56:14 INFO - 'pip_index': False, 05:56:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:14 INFO - 'cmd': ('bash', 05:56:14 INFO - '-c', 05:56:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:14 INFO - 'enabled': True, 05:56:14 INFO - 'halt_on_failure': False, 05:56:14 INFO - 'name': 'check_screen_resolution'},), 05:56:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:14 INFO - 'cmd': ('bash', 05:56:14 INFO - '-c', 05:56:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:14 INFO - 'enabled': True, 05:56:14 INFO - 'halt_on_failure': False, 05:56:14 INFO - 'name': 'check_screen_resolution'},), 05:56:14 INFO - 'run_cmd_checks_enabled': True, 05:56:14 INFO - 'sps_profile': False, 05:56:14 INFO - 'sps_profile_interval': 0, 05:56:14 INFO - 'suite': 'dromaeojs-e10s', 05:56:14 INFO - 'system_bits': '32', 05:56:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:14 INFO - 'title': 't-yosemite-r7-0023', 05:56:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:14 INFO - 'use_talos_json': True, 05:56:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:14 INFO - 'work_dir': 'build'} 05:56:14 INFO - [mozharness: 2017-01-24 13:56:14.025987Z] Running clobber step. 05:56:14 INFO - Running pre-action listener: _resource_record_pre_action 05:56:14 INFO - Running main action method: clobber 05:56:14 INFO - rmtree: /builds/slave/test/build 05:56:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:15 INFO - Running post-action listener: _resource_record_post_action 05:56:15 INFO - [mozharness: 2017-01-24 13:56:15.842124Z] Finished clobber step (success) 05:56:15 INFO - [mozharness: 2017-01-24 13:56:15.842252Z] Running read-buildbot-config step. 05:56:15 INFO - Running pre-action listener: _resource_record_pre_action 05:56:15 INFO - Running main action method: read_buildbot_config 05:56:15 INFO - Using buildbot properties: 05:56:15 INFO - { 05:56:15 INFO - "project": "", 05:56:15 INFO - "product": "firefox", 05:56:15 INFO - "script_repo_revision": "production", 05:56:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 05:56:15 INFO - "repository": "", 05:56:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 05:56:15 INFO - "buildid": "20170124031844", 05:56:15 INFO - "pgo_build": "False", 05:56:15 INFO - "basedir": "/builds/slave/test", 05:56:15 INFO - "buildnumber": 7, 05:56:15 INFO - "slavename": "t-yosemite-r7-0023", 05:56:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:56:15 INFO - "platform": "yosemite_r7", 05:56:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:56:15 INFO - "branch": "mozilla-beta", 05:56:15 INFO - "repo_path": "releases/mozilla-beta", 05:56:15 INFO - "revision": "5a883b3f3178302819d4cc821ca4d0c3465e5ca8", 05:56:15 INFO - "stage_platform": "macosx64", 05:56:15 INFO - "builduid": "63e14f3674a54fb1942699bb1e70483f", 05:56:15 INFO - "slavebuilddir": "test" 05:56:15 INFO - } 05:56:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 05:56:15 INFO - Running post-action listener: _resource_record_post_action 05:56:15 INFO - [mozharness: 2017-01-24 13:56:15.845687Z] Finished read-buildbot-config step (success) 05:56:15 INFO - [mozharness: 2017-01-24 13:56:15.845807Z] Running download-and-extract step. 05:56:15 INFO - Running pre-action listener: _resource_record_pre_action 05:56:15 INFO - Running main action method: download_and_extract 05:56:15 INFO - mkdir: /builds/slave/test/build/tests 05:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:15 INFO - trying https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 05:56:15 INFO - Downloading https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 05:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 05:56:16 INFO - Downloaded 1165 bytes. 05:56:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 05:56:16 INFO - Using the following test package requirements: 05:56:16 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 05:56:16 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 05:56:16 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 05:56:16 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:56:16 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 05:56:16 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 05:56:16 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 05:56:16 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 05:56:16 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 05:56:16 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:56:16 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 05:56:16 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 05:56:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 05:56:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 05:56:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 05:56:17 INFO - Http code: 200 05:56:17 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 05:56:17 INFO - x-amz-cf-id: h4gpcIAv-c3LEmu0mtDsNcFrzGFPF1K72ACNDo9IR6aiXhAyYGxNOA== 05:56:17 INFO - x-amz-version-id: p8Pu4v8W._tH84M6CoXLp6UQ7xMIsLuZ 05:56:17 INFO - Expected file size: 16086058 05:56:17 INFO - Obtained file size: 16086058 05:56:24 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:56:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 05:56:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 05:56:24 INFO - Fetch https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 05:56:24 INFO - Http code: 200 05:56:24 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 05:56:24 INFO - x-amz-cf-id: nZdyNEE2p35DpYQvGtA5S73cWp6-bvvMV22dzS90yt1cKYzgQ7hw2w== 05:56:24 INFO - x-amz-version-id: p8Pu4v8W._tH84M6CoXLp6UQ7xMIsLuZ 05:56:25 INFO - Expected file size: 16086058 05:56:25 INFO - Obtained file size: 16086058 05:56:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 05:56:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 05:56:31 INFO - Fetch https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 05:56:32 INFO - Http code: 200 05:56:32 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 05:56:32 INFO - x-amz-cf-id: awLh694Q-S5DZOkUsCXHfGArU0FTpeN_zowrDhymQqYEyKuBUsLt4w== 05:56:32 INFO - x-amz-version-id: 6ercy8005qRcAdaQ4hWqfBhBczEbrNb8 05:56:32 INFO - Expected file size: 14402992 05:56:32 INFO - Obtained file size: 14402992 05:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:32 INFO - trying https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 05:56:32 INFO - Downloading https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 05:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 05:56:35 INFO - Downloaded 82123611 bytes. 05:56:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 05:56:35 INFO - mkdir: /builds/slave/test/properties 05:56:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:35 INFO - Contents: 05:56:35 INFO - build_url:https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 05:56:35 INFO - Running post-action listener: _resource_record_post_action 05:56:35 INFO - Running post-action listener: set_extra_try_arguments 05:56:35 INFO - [mozharness: 2017-01-24 13:56:35.823584Z] Finished download-and-extract step (success) 05:56:35 INFO - [mozharness: 2017-01-24 13:56:35.823701Z] Running populate-webroot step. 05:56:35 INFO - Running pre-action listener: _resource_record_pre_action 05:56:35 INFO - Running main action method: populate_webroot 05:56:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:35 INFO - '--tppagecycles', 05:56:35 INFO - '7'], 05:56:35 INFO - 'tests': ['tsvgm']}}, 05:56:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['damp', 'tps']}, 05:56:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'tests': ['damp', 'tps']}, 05:56:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['dromaeo_dom']}, 05:56:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['basic_compositor_video']}, 05:56:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:56:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['a11yr', 05:56:35 INFO - 'ts_paint', 05:56:35 INFO - 'tpaint', 05:56:35 INFO - 'sessionrestore', 05:56:35 INFO - 'sessionrestore_no_auto_restore', 05:56:35 INFO - 'tabpaint']}, 05:56:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:35 INFO - 'ts_paint', 05:56:35 INFO - 'tpaint', 05:56:35 INFO - 'sessionrestore', 05:56:35 INFO - 'sessionrestore_no_auto_restore', 05:56:35 INFO - 'tabpaint']}, 05:56:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:35 INFO - 'ts_paint', 05:56:35 INFO - 'tpaint', 05:56:35 INFO - 'sessionrestore', 05:56:35 INFO - 'sessionrestore_no_auto_restore', 05:56:35 INFO - 'tabpaint']}, 05:56:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:35 INFO - 'ts_paint', 05:56:35 INFO - 'tpaint', 05:56:35 INFO - 'sessionrestore', 05:56:35 INFO - 'sessionrestore_no_auto_restore', 05:56:35 INFO - 'tabpaint']}, 05:56:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['a11yr', 05:56:35 INFO - 'ts_paint', 05:56:35 INFO - 'tpaint', 05:56:35 INFO - 'sessionrestore', 05:56:35 INFO - 'sessionrestore_no_auto_restore', 05:56:35 INFO - 'tabpaint']}, 05:56:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['a11yr', 05:56:35 INFO - 'ts_paint', 05:56:35 INFO - 'tpaint', 05:56:35 INFO - 'sessionrestore', 05:56:35 INFO - 'sessionrestore_no_auto_restore', 05:56:35 INFO - 'tabpaint']}, 05:56:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['tsvgx', 05:56:35 INFO - 'tsvgr_opacity', 05:56:35 INFO - 'tart', 05:56:35 INFO - 'tscrollx', 05:56:35 INFO - 'cart']}, 05:56:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:35 INFO - 'tsvgr_opacity', 05:56:35 INFO - 'tart', 05:56:35 INFO - 'tscrollx', 05:56:35 INFO - 'cart']}, 05:56:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'talos_options': ['--disable-e10s'], 05:56:35 INFO - 'tests': ['tp5o']}, 05:56:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'tests': ['tp5o']}, 05:56:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'talos_options': ['--disable-e10s', 05:56:35 INFO - '--xperf_path', 05:56:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:35 INFO - 'tests': ['tp5n']}, 05:56:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:35 INFO - 'talos_options': ['--xperf_path', 05:56:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:35 INFO - 'tests': ['tp5n']}}, 05:56:35 INFO - 'talos.zip': {'path': '', 05:56:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:35 INFO - Running post-action listener: _resource_record_post_action 05:56:35 INFO - [mozharness: 2017-01-24 13:56:35.842580Z] Finished populate-webroot step (success) 05:56:35 INFO - [mozharness: 2017-01-24 13:56:35.842703Z] Running create-virtualenv step. 05:56:35 INFO - Running pre-action listener: _resource_record_pre_action 05:56:35 INFO - Running main action method: create_virtualenv 05:56:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:56:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:35 INFO - Using real prefix '/tools/python27' 05:56:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:39 INFO - Installing pip.................done. 05:56:39 INFO - Return code: 0 05:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:56:39 INFO - Reading from file tmpfile_stdout 05:56:39 INFO - Output received: 05:56:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:56:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:39 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:56:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:39 INFO - 'HOME': '/Users/cltbld', 05:56:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:39 INFO - 'LOGNAME': 'cltbld', 05:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:39 INFO - 'MOZ_NO_REMOTE': '1', 05:56:39 INFO - 'NO_EM_RESTART': '1', 05:56:39 INFO - 'PAGER': '/bin/cat', 05:56:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:39 INFO - 'PWD': '/builds/slave/test', 05:56:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:39 INFO - 'SHELL': '/bin/bash', 05:56:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:39 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:39 INFO - 'USER': 'cltbld', 05:56:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:39 INFO - 'XPC_FLAGS': '0x0', 05:56:39 INFO - 'XPC_SERVICE_NAME': '0', 05:56:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:56:40 INFO - Cleaning up... 05:56:40 INFO - Return code: 0 05:56:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:56:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:40 INFO - 'HOME': '/Users/cltbld', 05:56:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:40 INFO - 'LOGNAME': 'cltbld', 05:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:40 INFO - 'MOZ_NO_REMOTE': '1', 05:56:40 INFO - 'NO_EM_RESTART': '1', 05:56:40 INFO - 'PAGER': '/bin/cat', 05:56:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:40 INFO - 'PWD': '/builds/slave/test', 05:56:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:40 INFO - 'SHELL': '/bin/bash', 05:56:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:40 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:40 INFO - 'USER': 'cltbld', 05:56:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:40 INFO - 'XPC_FLAGS': '0x0', 05:56:40 INFO - 'XPC_SERVICE_NAME': '0', 05:56:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:40 INFO - Downloading/unpacking psutil>=3.1.1 05:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:43 INFO - Installing collected packages: psutil 05:56:43 INFO - Running setup.py install for psutil 05:56:44 INFO - building 'psutil._psutil_osx' extension 05:56:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:56:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:56:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:56:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:56:44 INFO - building 'psutil._psutil_posix' extension 05:56:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:56:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:56:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:56:44 INFO - ^ 05:56:44 INFO - 1 warning generated. 05:56:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:44 INFO - Successfully installed psutil 05:56:44 INFO - Cleaning up... 05:56:44 INFO - Return code: 0 05:56:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:44 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:44 INFO - 'HOME': '/Users/cltbld', 05:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:44 INFO - 'LOGNAME': 'cltbld', 05:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:44 INFO - 'MOZ_NO_REMOTE': '1', 05:56:44 INFO - 'NO_EM_RESTART': '1', 05:56:44 INFO - 'PAGER': '/bin/cat', 05:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:44 INFO - 'PWD': '/builds/slave/test', 05:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:44 INFO - 'SHELL': '/bin/bash', 05:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:44 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:44 INFO - 'USER': 'cltbld', 05:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:44 INFO - 'XPC_FLAGS': '0x0', 05:56:44 INFO - 'XPC_SERVICE_NAME': '0', 05:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:56:47 INFO - Installing collected packages: mozsystemmonitor 05:56:47 INFO - Running setup.py install for mozsystemmonitor 05:56:47 INFO - Successfully installed mozsystemmonitor 05:56:47 INFO - Cleaning up... 05:56:47 INFO - Return code: 0 05:56:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:47 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:47 INFO - 'HOME': '/Users/cltbld', 05:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:47 INFO - 'LOGNAME': 'cltbld', 05:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:47 INFO - 'MOZ_NO_REMOTE': '1', 05:56:47 INFO - 'NO_EM_RESTART': '1', 05:56:47 INFO - 'PAGER': '/bin/cat', 05:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:47 INFO - 'PWD': '/builds/slave/test', 05:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:47 INFO - 'SHELL': '/bin/bash', 05:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:47 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:47 INFO - 'USER': 'cltbld', 05:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:47 INFO - 'XPC_FLAGS': '0x0', 05:56:47 INFO - 'XPC_SERVICE_NAME': '0', 05:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:48 INFO - Downloading/unpacking jsonschema==2.5.1 05:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:51 INFO - warning: no files found matching '*.txt' 05:56:51 INFO - no previously-included directories found matching 'build' 05:56:51 INFO - no previously-included directories found matching 'dist' 05:56:51 INFO - no previously-included directories found matching '.git*' 05:56:51 INFO - Installing collected packages: jsonschema, functools32 05:56:51 INFO - Running setup.py install for functools32 05:56:51 INFO - warning: no files found matching '*.txt' 05:56:51 INFO - no previously-included directories found matching 'build' 05:56:51 INFO - no previously-included directories found matching 'dist' 05:56:51 INFO - no previously-included directories found matching '.git*' 05:56:51 INFO - Successfully installed jsonschema functools32 05:56:51 INFO - Cleaning up... 05:56:51 INFO - Return code: 0 05:56:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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', '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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:56: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 functools32==3.2.3-2 05:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:51 INFO - 'HOME': '/Users/cltbld', 05:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:51 INFO - 'LOGNAME': 'cltbld', 05:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:51 INFO - 'MOZ_NO_REMOTE': '1', 05:56:51 INFO - 'NO_EM_RESTART': '1', 05:56:51 INFO - 'PAGER': '/bin/cat', 05:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:51 INFO - 'PWD': '/builds/slave/test', 05:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:51 INFO - 'SHELL': '/bin/bash', 05:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:51 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:51 INFO - 'USER': 'cltbld', 05:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:51 INFO - 'XPC_FLAGS': '0x0', 05:56:51 INFO - 'XPC_SERVICE_NAME': '0', 05:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:56:52 INFO - Cleaning up... 05:56:52 INFO - Return code: 0 05:56:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:52 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:52 INFO - 'HOME': '/Users/cltbld', 05:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:52 INFO - 'LOGNAME': 'cltbld', 05:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:52 INFO - 'MOZ_NO_REMOTE': '1', 05:56:52 INFO - 'NO_EM_RESTART': '1', 05:56:52 INFO - 'PAGER': '/bin/cat', 05:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:52 INFO - 'PWD': '/builds/slave/test', 05:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:52 INFO - 'SHELL': '/bin/bash', 05:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:52 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:52 INFO - 'USER': 'cltbld', 05:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:52 INFO - 'XPC_FLAGS': '0x0', 05:56:52 INFO - 'XPC_SERVICE_NAME': '0', 05:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:56:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:56 INFO - Downloading docopt-0.6.1.tar.gz 05:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:56 INFO - Running setup.py install for blobuploader 05:56:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:56:56 INFO - Running setup.py install for requests 05:56:56 INFO - Running setup.py install for docopt 05:56:56 INFO - Successfully installed blobuploader requests docopt 05:56:56 INFO - Cleaning up... 05:56:57 INFO - Return code: 0 05:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:56:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:56:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:57 INFO - 'HOME': '/Users/cltbld', 05:56:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:57 INFO - 'LOGNAME': 'cltbld', 05:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:57 INFO - 'MOZ_NO_REMOTE': '1', 05:56:57 INFO - 'NO_EM_RESTART': '1', 05:56:57 INFO - 'PAGER': '/bin/cat', 05:56:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:57 INFO - 'PWD': '/builds/slave/test', 05:56:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:57 INFO - 'SHELL': '/bin/bash', 05:56:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:56:57 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:56:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:57 INFO - 'USER': 'cltbld', 05:56:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:57 INFO - 'XPC_FLAGS': '0x0', 05:56:57 INFO - 'XPC_SERVICE_NAME': '0', 05:56:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jSvLCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-PsEbiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-bPMtTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-yMPFYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1EY9LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-YPx2n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-SgNC7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-S1QMnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gylgwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MS0nec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WlI_Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Mv_g0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-JlaQy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-YSoyDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-L7ITFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gH5Djz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ExBK31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:56:59 INFO - Running setup.py install for manifestparser 05:56:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:56:59 INFO - Running setup.py install for mozcrash 05:56:59 INFO - Running setup.py install for mozdebug 05:56:59 INFO - Running setup.py install for mozdevice 05:56:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:56:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:56:59 INFO - Running setup.py install for mozfile 05:56:59 INFO - Running setup.py install for mozhttpd 05:57:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozinfo 05:57:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozInstall 05:57:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozleak 05:57:00 INFO - Running setup.py install for mozlog 05:57:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for moznetwork 05:57:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozprocess 05:57:00 INFO - Running setup.py install for mozprofile 05:57:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozrunner 05:57:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozscreenshot 05:57:01 INFO - Running setup.py install for moztest 05:57:01 INFO - Running setup.py install for mozversion 05:57:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:01 INFO - Cleaning up... 05:57:01 INFO - Return code: 0 05:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:01 INFO - 'HOME': '/Users/cltbld', 05:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:01 INFO - 'LOGNAME': 'cltbld', 05:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:01 INFO - 'MOZ_NO_REMOTE': '1', 05:57:01 INFO - 'NO_EM_RESTART': '1', 05:57:01 INFO - 'PAGER': '/bin/cat', 05:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:01 INFO - 'PWD': '/builds/slave/test', 05:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:01 INFO - 'SHELL': '/bin/bash', 05:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:57:01 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:01 INFO - 'USER': 'cltbld', 05:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:01 INFO - 'XPC_FLAGS': '0x0', 05:57:01 INFO - 'XPC_SERVICE_NAME': '0', 05:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-NF0xfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-75hIUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ciae8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZFoE1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-A0WGbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-HZNK6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rQIGty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-y_RjSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-KS5V5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-vkI4A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AdtDWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mucjYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-764kaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-LAAEdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-lt5q5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gH_LW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:03 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-264owJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:07 INFO - Downloading blessings-1.6.tar.gz 05:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:07 INFO - Installing collected packages: blessings 05:57:07 INFO - Running setup.py install for blessings 05:57:07 INFO - Successfully installed blessings 05:57:07 INFO - Cleaning up... 05:57:07 INFO - Return code: 0 05:57:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:08 INFO - Reading from file tmpfile_stdout 05:57:08 INFO - Current package versions: 05:57:08 INFO - blessings == 1.6 05:57:08 INFO - blobuploader == 1.2.4 05:57:08 INFO - docopt == 0.6.1 05:57:08 INFO - functools32 == 3.2.3-2 05:57:08 INFO - jsonschema == 2.5.1 05:57:08 INFO - manifestparser == 1.1 05:57:08 INFO - mozInstall == 1.12 05:57:08 INFO - mozcrash == 1.0 05:57:08 INFO - mozdebug == 0.1 05:57:08 INFO - mozdevice == 0.48 05:57:08 INFO - mozfile == 1.2 05:57:08 INFO - mozhttpd == 0.7 05:57:08 INFO - mozinfo == 0.9 05:57:08 INFO - mozleak == 0.1 05:57:08 INFO - mozlog == 3.4 05:57:08 INFO - moznetwork == 0.27 05:57:08 INFO - mozprocess == 0.23 05:57:08 INFO - mozprofile == 0.28 05:57:08 INFO - mozrunner == 6.13 05:57:08 INFO - mozscreenshot == 0.1 05:57:08 INFO - mozsystemmonitor == 0.3 05:57:08 INFO - moztest == 0.8 05:57:08 INFO - mozversion == 1.4 05:57:08 INFO - psutil == 3.1.1 05:57:08 INFO - requests == 1.2.3 05:57:08 INFO - wsgiref == 0.1.2 05:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:08 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 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:08 INFO - 'HOME': '/Users/cltbld', 05:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:08 INFO - 'LOGNAME': 'cltbld', 05:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:08 INFO - 'MOZ_NO_REMOTE': '1', 05:57:08 INFO - 'NO_EM_RESTART': '1', 05:57:08 INFO - 'PAGER': '/bin/cat', 05:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:08 INFO - 'PWD': '/builds/slave/test', 05:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:08 INFO - 'SHELL': '/bin/bash', 05:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:57:08 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:08 INFO - 'USER': 'cltbld', 05:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:08 INFO - 'XPC_FLAGS': '0x0', 05:57:08 INFO - 'XPC_SERVICE_NAME': '0', 05:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:09 INFO - Cleaning up... 05:57:09 INFO - Return code: 0 05:57:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10feed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85ebdc09d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, '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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:09 INFO - 'HOME': '/Users/cltbld', 05:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:09 INFO - 'LOGNAME': 'cltbld', 05:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:09 INFO - 'MOZ_NO_REMOTE': '1', 05:57:09 INFO - 'NO_EM_RESTART': '1', 05:57:09 INFO - 'PAGER': '/bin/cat', 05:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:09 INFO - 'PWD': '/builds/slave/test', 05:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:09 INFO - 'SHELL': '/bin/bash', 05:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:57:09 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:09 INFO - 'USER': 'cltbld', 05:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:09 INFO - 'XPC_FLAGS': '0x0', 05:57:09 INFO - 'XPC_SERVICE_NAME': '0', 05:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:57:09 INFO - Cleaning up... 05:57:09 INFO - Return code: 0 05:57:09 INFO - Running post-action listener: _resource_record_post_action 05:57:09 INFO - Running post-action listener: _start_resource_monitoring 05:57:09 INFO - Starting resource monitoring. 05:57:09 INFO - [mozharness: 2017-01-24 13:57:09.842447Z] Finished create-virtualenv step (success) 05:57:09 INFO - [mozharness: 2017-01-24 13:57:09.843537Z] Running install step. 05:57:09 INFO - Running pre-action listener: _resource_record_pre_action 05:57:09 INFO - Running main action method: install 05:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:10 INFO - Reading from file tmpfile_stdout 05:57:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:10 INFO - Reading from file tmpfile_stdout 05:57:10 INFO - Output received: 05:57:10 INFO - Usage: mozinstall [options] installer 05:57:10 INFO - Options: 05:57:10 INFO - -h, --help show this help message and exit 05:57:10 INFO - -d DEST, --destination=DEST 05:57:10 INFO - Directory to install application into. [default: 05:57:10 INFO - "/builds/slave/test"] 05:57:10 INFO - --app=APP Application being installed. [default: firefox] 05:57:10 INFO - mkdir: /builds/slave/test/build/application 05:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:57:31 INFO - Reading from file tmpfile_stdout 05:57:31 INFO - Output received: 05:57:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:57:31 INFO - Running post-action listener: _resource_record_post_action 05:57:31 INFO - [mozharness: 2017-01-24 13:57:31.549466Z] Finished install step (success) 05:57:31 INFO - [mozharness: 2017-01-24 13:57:31.549573Z] Running run-tests step. 05:57:31 INFO - Running pre-action listener: _resource_record_pre_action 05:57:31 INFO - Running main action method: run_tests 05:57:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:31 INFO - 2017-01-24 05:57:31.564 screenresolution[2164:29859] starting screenresolution argv=screenresolution get 05:57:31 INFO - 2017-01-24 05:57:31.567 screenresolution[2164:29859] Display 0: 1600x1200x32@60 05:57:31 INFO - 2017-01-24 05:57:31.572 screenresolution[2165:29863] starting screenresolution argv=screenresolution list 05:57:31 INFO - Available Modes on Display 0 05:57:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:31 INFO - Intel Iris: 05:57:31 INFO - Chipset Model: Intel Iris 05:57:31 INFO - Type: GPU 05:57:31 INFO - Bus: Built-In 05:57:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:31 INFO - Vendor: Intel (0x8086) 05:57:31 INFO - Device ID: 0x0a2e 05:57:31 INFO - Revision ID: 0x0009 05:57:31 INFO - Displays: 05:57:31 INFO - Display: 05:57:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:31 INFO - Display Serial Number: 1600x1200 60 05:57:31 INFO - Main Display: Yes 05:57:31 INFO - Mirror: Off 05:57:31 INFO - Online: Yes 05:57:31 INFO - Rotation: Supported 05:57:31 INFO - Return code: 0 05:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:31 INFO - Python 2.7.3 05:57:31 INFO - Return code: 0 05:57:31 INFO - grabbing minidump binary from tooltool 05:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:31 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 0x10fd01d30>, '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 0x10fb67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:57:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:57:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:57:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:31 INFO - Return code: 0 05:57:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:57:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:57:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8Q42zp0P1t/Render', 05:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:31 INFO - 'HOME': '/Users/cltbld', 05:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:31 INFO - 'LOGNAME': 'cltbld', 05:57:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:31 INFO - 'MOZ_NO_REMOTE': '1', 05:57:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:31 INFO - 'NO_EM_RESTART': '1', 05:57:31 INFO - 'PAGER': '/bin/cat', 05:57:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:31 INFO - 'PWD': '/builds/slave/test', 05:57:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:31 INFO - 'SHELL': '/bin/bash', 05:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aT3YaqX1Z/Listeners', 05:57:31 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:31 INFO - 'USER': 'cltbld', 05:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:31 INFO - 'XPC_FLAGS': '0x0', 05:57:31 INFO - 'XPC_SERVICE_NAME': '0', 05:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:57:32 INFO - mozversion application_buildid: 20170124031844 05:57:32 INFO - mozversion application_changeset: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 05:57:32 INFO - mozversion application_display_name: Firefox 05:57:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:32 INFO - mozversion application_name: Firefox 05:57:32 INFO - mozversion application_remotingname: firefox 05:57:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:57:32 INFO - mozversion application_vendor: Mozilla 05:57:32 INFO - mozversion application_version: 52.0 05:57:32 INFO - mozversion platform_buildid: 20170124031844 05:57:32 INFO - mozversion platform_changeset: 5a883b3f3178302819d4cc821ca4d0c3465e5ca8 05:57:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:57:32 INFO - mozversion platform_version: 52.0 05:57:32 INFO - using testdate: 1485266252 05:57:32 INFO - actual date: 1485266252 05:57:32 INFO - starting webserver on 'localhost:62183' 05:57:32 INFO - SUITE-START | Running 2 tests 05:57:32 INFO - TEST-START | dromaeo_css 05:57:32 INFO - operating with platform_type : mac_ 05:57:32 INFO - Initialising browser for dromaeo_css test... 05:57:32 INFO - TEST-INFO | started process 2175 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp_suo4G/profile http://localhost:62183/getInfo.html) 05:57:35 INFO - PROCESS | 2175 | 2017-01-24 05:57:35.133 plugin-container[2178:30040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 05:57:35 INFO - PROCESS | 2175 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:35 INFO - PROCESS | 2175 | 2017-01-24 05:57:35.133 plugin-container[2178:30040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a2b, name = 'com.apple.CFPasteboardClient' 05:57:35 INFO - PROCESS | 2175 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:35 INFO - PROCESS | 2175 | 2017-01-24 05:57:35.133 plugin-container[2178:30040] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:57:35 INFO - PROCESS | 2175 | __metrics Screen width/height:1600/1200 05:57:35 INFO - PROCESS | 2175 | colorDepth:24 05:57:35 INFO - PROCESS | 2175 | Browser inner width/height: 1024/689 05:57:35 INFO - PROCESS | 2175 | __metrics 05:57:35 ERROR - PROCESS | 2175 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 05:57:36 INFO - TEST-INFO | 2175: exit 0 05:57:36 INFO - Browser initialized. 05:57:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:36 INFO - TEST-INFO | started process 2179 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp_suo4G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:38 INFO - PROCESS | 2179 | 2017-01-24 05:57:38.427 plugin-container[2180:30172] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 05:57:38 INFO - PROCESS | 2179 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:38 INFO - PROCESS | 2179 | 2017-01-24 05:57:38.429 plugin-container[2180:30172] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 05:57:38 INFO - PROCESS | 2179 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:38 INFO - PROCESS | 2179 | 2017-01-24 05:57:38.429 plugin-container[2180:30172] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:57:48 INFO - PROCESS | 2179 | RSS: Main: 178380800 05:57:48 INFO - PROCESS | 2179 | 06:00:50 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:62183/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62183/tests/dromaeo/cssquery-ext.html) 06:00:52 INFO - PROCESS | 2179 | RSS: Main: 183533568 06:00:52 INFO - PROCESS | 2179 | 06:03:54 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:62183/tests/dromaeo/cssquery-ext.html (next: http://localhost:62183/tests/dromaeo/cssquery-jquery.html) 06:03:55 INFO - PROCESS | 2179 | RSS: Main: 193839104 06:03:55 INFO - PROCESS | 2179 | 06:06:57 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:62183/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62183/tests/dromaeo/cssquery-mootools.html) 06:06:57 INFO - PROCESS | 2179 | RSS: Main: 196349952 06:06:57 INFO - PROCESS | 2179 | 06:09:59 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:62183/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62183/tests/dromaeo/cssquery-prototype.html) 06:10:00 INFO - PROCESS | 2179 | RSS: Main: 199757824 06:10:00 INFO - PROCESS | 2179 | 06:13:03 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:62183/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62183/tests/dromaeo/cssquery-yui.html) 06:13:03 INFO - PROCESS | 2179 | RSS: Main: 205254656 06:13:03 INFO - PROCESS | 2179 | 06:16:05 INFO - PROCESS | 2179 | Cycle 1(1): loaded http://localhost:62183/tests/dromaeo/cssquery-yui.html (next: http://localhost:62183/tests/dromaeo/cssquery-dojo.html) 06:16:06 INFO - PROCESS | 2179 | RSS: Main: 205885440 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | __start_tp_report 06:16:06 INFO - PROCESS | 2179 | _x_x_mozilla_page_load 06:16:06 INFO - PROCESS | 2179 | _x_x_mozilla_page_load_details 06:16:06 INFO - PROCESS | 2179 | |i|pagename|runs| 06:16:06 INFO - PROCESS | 2179 | |0;dojo.html;3520.542329497165;3548.0774998500387;3562.323158599865;3573.178169021125;3584.8028358440306;5879.235699359083;5929.4367035131645;5982.670953097578;5989;6015.3082395524525;5983.2820061592665;6055.848603784908;6088.330283668793;6111.205543279368;6116.082587611861;5335.439778823235;5409.540189083933;5422.91865622016;5435.565154787627;5480.780768769245;5471.206675032118;5475.972620136894;5485.807996720116;5503.477169668875;5539.446055394468;5319.654222475527;5334.413214546416;5471.616986810925;5477.5070243678065;5481.671099734009;5386.165144402624;5421.430749771276;5443.646162999432;5449.346078470569;5516.255305533742;5265.7893684252585;5405.756740946627;5412.91880621791;5416.377116631598;5446.537044351235;5823.563232757518;6050.788222412239;6064.818055458343;6144.87710245797;6159;5259.552938000236;6237.095621134956;6276.309605943343;6289.433950944392;6360.491160707133;6352.80941571749;6431.549791514596;6435.549511534195;6446.967765161191;6457.515686323544;6122.540809439265;6131.816045518642;6153.723082461211;6163.907541386883;6170.50635949123;6439.774607888701;6492.577982431127;6543.1166792483355;6559.180102487189;6596.4393026592315;6247.468965138014;6257.43683068526;6259.311475737665;6278.811635650938;6298.685065746694;6206.100115483229;6245.125682404467;6466.450351720063;6473.126127972663;6488.351164883474;6258.718357673915;6300.653464059521;6306.369363063657;6344.968275158594;6360.268569114519;6307.653079080695;6324.588901721466;6356.237251529846;6359.395857393541;6369.426751592287;5072.289879416885;5180.740962951837;5191.351081114861;5205.115130427836;5234.26720259164;3640.2719456108885;4331.765446847633;4575.473820510617;4584.17484852723;4606.101810146989;5431.538319242909;5438.45615438453;5561.249231353796;6178.41305076017;6182.783602573888;5829.630036941316;5930.406959304035;6402.455791257702;6469.676516174172;6530.869382612321;6088.452039316483;6120.44915957566;6134.16106913652;6149.108379285068;6173.56785025044;4709.246520556694;5677.148427735872;5686.2039314496005;5700.857478563069;5701.40135285789;6606.075149479077;6641.933580664228;6660.200775906922;6672.799816005625;6683.198016238082;6300.495960323072;6332.923403021406;6367.172267605367;6374.745010199726;6454.903176452451;6698.196216454056;6700.966495167493;6706.698198580978;6716.1604799400075;6726;6340.746370145327;6367.808965731036;6398.968005159944;6410.45511131559;6423.935760642334;6222.719977601109;6261.311255761953;6271.529635277281;6315.368463153648;6436.774712885027;6266.655333956676;6278.623282602875;6282.780102696383;6300.558960872695;6315.96842015787;6279.937200627935;6288.308286088435;6294.3076261612105;6313.516323664027;6315.463185629089;5040.991801639613;5194.948050519446;5569.359523654832;6108.267007959073;6213.565050446426;6226.221722284715;6245.469135123383;6263.530235232284;6270;6275.90171719938;6274.435300822948;6277.30949595535;6294.244690637152;6295.5907865988565;6298.968505157445 06:16:06 INFO - PROCESS | 2179 | |1;ext.html;513.6686836990144;514.4264145477792;529.6027979015738;537.6693333599835;541.3774159716328;26525.469490610176;39763.40354894675;41762.58237417625;41907.79046104773;42074;42991.57008429915;43756;43945.12109757811;44034.77982610082;44122.7793861031;8243.79390515239;8286.709965151222;9462.952685236563;9770.609175632966;9796.951015244913;9646.324757266993;9782.26633002524;9785.07041831025;9814.362066465692;9830.606775728962;9750.219982401426;9790.069943355405;9792.951035244814;9807.509624518745;9825.557849896772;9689.563969621384;9764.951175244078;9768.95115524425;9792.853107203398;9797.216222702167;9645.903540964571;9753.804923901482;9764.170045546138;9767.218622510181;9777.755556111082;40576;40641.18717625631;40731;40781;40808.38787418191;3245.367153405087;3360.5799275090612;3499.422595271777;3603.1352475405974;3861.584506171318;31235.219119521968;31367.05898823016;31418.21454463634;31594.684053159635;31743;3165.446046941799;3233.804888471487;3289.605247370307;3330.8667653293837;3342.2479942013097;308187;385896;389674.99999999715;390276.04861975793;391685;63916.68041659855;64302;64401.677991609744;64607.03089453662;64862.35137648658;66533;67026.6594668104;67194.66402667956;67582;67668.98496522557;16606.169691515377;16665;17029.48911532656;17032.06323652211;17064.914675426542;12724.91838193764;12770.042246831525;13061.673458163432;13112.213267203999;13183.67040823968;17627.38304159374;18093.819061809478;18143.364982225823;18181.363652272106;18187.727184092248;5534.308211473566;6529;6564.901526477107;6565.80302590923;6636.270010298863;890.5057692980329;967.709687093869;1036.9740756481149;1055.646358469921;1125.7579620381657;30699.693003069682;31008.0697579073;31063.844680776452;31123;31242;969.9709008729608;1031.5358088860044;1035.7565971996576;1127.9774404511863;1180.38030034231;15016.353555901293;16033.759493607606;16044.43844465438;16163.595910102107;16194.595135121715;651262;660777;662066;665840;668388;58255.70872145612;61052.694736526035;61202.38797612056;61210.69394652998;61365.77268454695;1368.4047439363908;1394.877123915258;1400.1808941768975;1401.1382999455261;1401.9275254430572;29729.554056689598;30073.849630751705;30607.693923061375;30751.538726918665;31009;52843.47156528386;53382.4661753393;53540.46459535355;53573.464265356844;53737.731311343196;594248;595750;596432;600383;601551;27082;27875.16374508768;28023.29941751391;28747.8562607194;42364.576354236066;47626;48495;48547.5145248543;48735.512644874514;49081;33069.66930330762;39809.60190398059;41753.37369939514;41764.1647167061;41825.372619410125;40453.79773101233;40493;40770;41309.38035929403;41918.790406047774;38904.027399315244;39510;39747.60252397439;39963.60036399599;41159.58840411557;32402.51396229011;35487.82256088703;35769.56921723206;35985;36120.638793611724;21583.13667453284;24905.62641560342;26370.20889373322;26826.926922922863;27088.32279192957 06:16:06 INFO - PROCESS | 2179 | |2;jquery.html;379.34752226170974;379.80629878761835;388.14220572534697;394.09555071111794;412.69460599156633;17763.733543996852;18889.338873139444;20363.1854725811;20394.796052039474;20623.690644640305;17467.563310917234;18591.977441240728;19572.706409403836;20053.89973050136;20268.493287667814;3824.6749026332795;5048.368953880765;5815.069588865772;6050.636961782285;6103.877922441548;5669.8582535436535;6732.596044237362;6738.629375384352;6741.157355330583;6762.932370676304;6405.327440618715;6582.2101347838325;6646;6648.434883034948;6729.360710732472;5760.53915686744;6571.145751052332;6586.473082153416;6622.966885165568;6756.527043106985;5840;5927.2887253529425;5938.970305148489;5962.97018514909;5976.820695379146;11572.53709851605;12540.745925407478;13580.728385432236;13638.863611363859;13724.794128088086;2174.7607763146043;2277.7722227777253;2362.9291121266388;2370.3718514593647;2444.4622183119686;9806.558704858227;10065.993400659949;10296.94851525745;10477.161827053893;10719.83920241197;1638.6558822647257;1994.6010797840345;2002.7196192533056;2007.6548712362753;2018.777934427212;122090;122581;125919.3704031474;127143;131029.34485327608;11793.646190614296;11877.940610297066;12024.278543287432;12042.759144817055;12188.268703877795;12256.387180640932;14532.564023079325;14946.40214391434;15075;15097.773533397009;8541;8592.269657079094;8741.431806932529;8995.955020224857;9001.684941027033;7041.683124259421;7149.249328820503;8758.167974042455;8796.868046979173;8914.73255802327;4252.29837076885;4684.81260749573;4688.390509233778;4717.113154738132;4739.383880095635;1973.7138114973247;2035.084212104559;2036.0634108310046;2037.3293899002972;2039.2862498125835;854.2013217641525;945.9243260539278;948.2319321349729;958.4105774948496;1013.7465633591602;20346.49133771638;21280;21330.893345533485;21426.892865535883;21461.67807482889;913.8446464101119;920.7836158502746;947.6398968391967;996.1383403356045;1026.6355443817486;10744.433615713291;11028.062614677681;11780.293182409083;11868.465919033664;12155.270683759003;523288;526388;531218;645613;645636;85101.57449212714;132613.3369333147;139319.30340348234;139982;142282;973.59595767757;985.4776968206862;1038.48075962019;1047.3558761361708;1049.4490392543976;18737.063146842876;19300.90349548243;19568.510787230432;19616.60766784685;19656.213751450356;55692.44307556873;57300.56748581319;57415;58078.709606451695;58252.83494330174;58265.70867145637;62894.74210515673;78616.60691696504;81080.78378824204;83373.16626833654;6278.058291256348;7681;7749.457537972288;7802.180771019188;8209.79475513117;11982.940085299517;13195.802062969255;13380;13434.328283585977;13559.389827457591;8104.594770261581;8831.735047948572;9840.950795245977;10589.788204235718;11590.478428470908;10157.288989770645;10577.894221057692;11304.152188585724;11530.654080377602;11585.131115166565;11713;11786.410679466164;11834.408279586158;11863.76272474563;12102.213356131822;7561.546307221584;7608.695652174072;7644.006279183893;7671.462997590115;7788.649510772142;10776.272081198087;10923.289986150874;10962.945185274022;11653.825192622287;11830.349330786888 06:16:06 INFO - PROCESS | 2179 | |3;mootools.html;1376.133036187202;1501.2793858947705;1678.4377233626735;1848.1775609853603;1848.4177484092502;6636.9336306636915;7667.424943129274;7874.645640946157;8553.74338769837;8566.271866891322;6759.932400675992;8255.174482551742;8261.58692065396;8408.453450525727;8441.873371899426;2342.3324352559525;2389.557931782626;2394.0184524345023;2395.520895820834;2396.2332053742807;2389.629607410854;2414.3481260059775;2443.4990826880535;2447.3514518652573;2452.901883924641;2355.9057637694473;2362.433016076138;2369.9289021329387;2375.857448553092;2408.0728919366084;2352.6588644646604;2359.6578496118054;2369.893354799038;2370.5969985102574;2376.797972172376;2384.451576137481;2389.4504264019197;2391.0794344177443;2406.470576473173;2407.518496300747;8400.117987611275;8451.197136272105;8462.069172391031;8471.19523645259;8479.533625650587;5107.412647545506;5304.389995150568;5324.4143144254485;5325.387580428262;5330.946690533123;3486.5990411102794;3548.361294966905;3549.7870127792416;3583.5878873929573;3611.1694310308512;1059.2743970380236;1063.8989296016866;1089.2103225161773;1100.3892839474088;1106.24775152896;10871.891281087166;10914.836277455845;10926.945365273203;10932.99999999992;10949.562017519289;3929.4695216145456;4481.641468682497;4672.5327467253;4745.3593764842;4806.519348065165;7862.52824830512;9517.524123793783;9527.237820974306;9529.332946693665;9532.142107210384;5280.419153893069;5288.04815133272;5295.179247216687;5303.04545181871;5365.812196573179;4355.8475453359615;4397.07661391105;4852.272159176152;4859.125357435695;4877.585405240523;3904.7657140571655;3966.7024973126554;3994.4407782910416;4028.073543085107;4059.69552283574;1298.1951190262098;1314.0210543145226;1316.8946484281234;1316.9868301317056;1317.9341032948314;816.2939057715153;846.0650980666398;908.7591788176138;924.1682485762867;928.6099838068028;4960.330355401975;5315.202719592092;5798.9420105799245;5881.823545293648;6106.786262480792;872.241150199318;904.8643951840398;913.2784700838967;930.3208657679796;946.1342871272708;3848.576026870076;3851.9229615407535;3932;3969.6030396960073;3971.1859068891386;9836.508174591241;10189.643362482277;10240.9759024097;10254.384736915808;10257.07686308221;10048.59805607782;10090.798184036279;10119.645812396531;10172.949135254275;10182.490875456198;7667.961660191775;7763.650635721406;7974.880376794353;7984;8023.879641805378;5519.337679478328;5543.9168412474655;5554.222408862844;5679.716014199191;5709.65742055478;7871.976643036598;9352.532373381167;9367.250619950524;9419.105185007413;9505.42967421957;9086.45481271126;9475.005124462108;9477.194438472807;9516.524173791144;9627;6731.966340168267;6913.965430172817;7179.748708795376;7330.340269375782;7650.31147196755;7771.1840256774485;7986.760397187862;8053.114157442794;8058.959705201437;8072.273495385209;7083.645817708991;7097.25478824716;7304.853902922018;7328.633568321456;7345.669444874887;7050.435965122881;7079.539829911039;7131.928680713127;7169.964150179216;7284.854302914018;6655;6706.396424321834;6779.559328643622;6787.592744435349;6788.660566971533;4457.465104187519;4808.2547205183255;4843.152448321459;4862.507715895679;4945.604351651931;4125.401816736617;4876.122297986255;5000.749962501933;5002;5025.547700706954 06:16:06 INFO - PROCESS | 2179 | |4;prototype.html;313.94035133324667;316.6611725453764;323.37911210475875;324.4711120872977;328.065014708082;4907.582855457291;5598.664080155194;5627.155926611005;5693.572982026349;5748.367679555246;4429.911401771963;4897.461279259288;5348.705821179834;5524.889502209953;5563;4159.667226621863;4200.621944025037;4220.345846393814;4226.429432026668;4262.680298977573;3902.8829135125993;4037.818298176589;4082.7547597982602;4270;4271.252530807096;3515.5605549306338;3919.1181984053646;4065.268251714705;4266.97866510667;4273.166732487166;4251.979524914013;4260.211860805761;4263.509696384909;4265.55211702773;4287;2986.656534498539;3252.658470860573;3273.5744353234163;3545.7517973741847;3737.5141231639986;4652.860414187579;5069.239614057884;5442.6462279951675;5474.7262636868;5571.164325351189;4442.978115033528;4446.666500012479;4936.543719602726;4953.4798846121;4955.860152164986;5299.270875499121;5861.267341582302;5873.500752436048;5896.439838215363;5914.763409463616;3871.296374904505;3969.900752481211;4062.2890994076215;4142.606452387018;4194.433751443577;6159.934443267422;6220.588088363108;6229.595076320024;6233.314335423145;6249.6875156242;4200.5799420058365;4247.702660813775;4260.744355338689;4266.807993640294;4269.402283680287;3233.224026233734;3998.740081894726;4248.534255681785;4291.570842915684;4318.03529394125;4430.335449682573;4724.929126063043;4933.753312334441;4941.555260026615;4972.701637901738;4898.432501599454;5913.201717768132;5936.317323507766;5945.256842894638;5964.463198312173;1105.5412004018242;1183.3609850680537;1393.4356585582855;1395.6301580081285;1400.6078298076352;937.4843835890233;952.8094381123803;965.7589996854009;970.3207754571687;970.5635659224388;5076.949230507722;5250.214926924864;5365.275687782178;5369.4630536946;5381.811636592701;4670;4742.434996451163;5409.755756176023;5605.663660180402;5959.523238140939;4977.726225057657;5308.575313974873;5311;5335.839924802262;5710.771569137271;2740.5752108423226;2749.3539018330675;2785;2849.28767808048;3067.8772849085785;6047.637141771508;6086.726097325631;6113.676802814991;6129.478994285447;6143.32423433422;5273.707941554344;5390.948764990789;5749.597528172988;5962.165296858443;5969.791057312973;5572.916406253828;5580.330360356783;5730.169125476783;6059.091885733677;6148.571314330904;4975.800967961241;5020.866131894003;5363.839084827461;5835.824925252249;5856.853578660568;5035.974820125876;5206.661566998133;5686.299007971181;5731.684757338219;5820.534357251325;4762.809487620457;5165.870853228699;5690.159142578826;6103.6032657877095;6118.571699980958;3451.913702157466;3661.9493083873117;3737.2338670571926;3741.981290093532;4021.778802165792;5522.532692634183;5542.334919809648;5586.106223004463;6031.547633927561;6047.697615119138;5919.792807251725;5924.851878703067;5929.258842644669;5947.821565353046;5960.5827592068135;4448.977755111204;4858.82994095205;5556.444355564411;5604.299462567179;5754.087220689804;5712.285964254468;5732.799352022659;5738.5696072795545;5741.923234503549;5756.539476841926;4858.392700912386;5093.4651861554;5502.313449988597;5815.331236907809;5908.822735317947;5738.53667314832;5829.300483941955;5839.708014599338;5849.766009359748;5853.619514731528 06:16:06 INFO - PROCESS | 2179 | |5;yui.html;706.3925024478947;731.265078596011;792.7859477940956;831.7795784117206;833.8082241084554;14492;15158.166300853449;15285.465008724697;15353.923230383833;15377.538673839788;13238.53665121721;13338.59984200473;13384.732305353888;13587;13625.386857591408;879.9868001979976;896.3770179725094;897.0804924951943;897.9820403591924;898.6001229452896;832.2551316571664;870.5386145342978;878.6968495868947;879.3624622148923;879.5558243087232;936.494293081735;936.7751739582485;938.7043081429362;939.8590211468301;942.3450701762278;908.1599520443597;919.4529255093208;921.2445794448555;921.9723408297762;923.3951761596165;668.6122049211446;676;702.4029574861378;703.4513079797766;707.1867352544564;12289.877101229053;12506.18709783861;12508.81236781449;12520.561780337735;12540.122191446602;11620.418979051014;11804.940975295154;12026.27842329463;12134.27194368332;12399.380030998504;10375.636852710195;10512.842307365396;10658.733531661694;10714.839277410845;10943.124550035978;3583.283343331344;3665.871694490707;3713;3766.1714422826935;3858.720087925269;93238.06761932361;93350;96794;98560.50719746355;99140.50429747805;8568.143185681507;8623.78440538979;8634.136586341316;10388.844167337496;10578.629747958785;20078.799212007983;20395.286164984154;20412;20413.183472660927;20444.182232710824;6898.482613803984;7170.928290717026;7285.708571657075;7555.13115991657;7830.177831327743;4353.434053573079;4367.956320436819;4368.497622773358;4456.442944631921;4517.93828450314;2878.2372671242138;3323.8338083096232;3424.229548351601;3708.035910663247;3864.265789499986;694.1947341084419;696.6342670098239;709.836737550356;712.2450202785064;717.5909731453125;594.4085634793322;655.4788942790398;681.1349586025818;686.5125760709852;690.7547820523743;8973.685920992733;9420.811583768285;9553.832919801422;9555.761105972268;9671.323007389416;627.4980015987284;653.9182602174728;666.8218951415142;673.8820706376365;705.5096707788141;3810.980945095312;4581.908361832745;4582.816687332536;4596.724196548151;4649.930251046237;113904;113943.43028284972;114259;117586;120729.39635301943;79586.60206698929;109315;111520;112564;115271;83978;96338.51830740801;98919;99059.50470247603;101350;8738.737837864874;8964.820703586021;8982.146696063863;8988;8995.505247211466;41726.79136604298;46755;60242.39757602368;63543.99999999815;64126.35873641204;65524.67237663781;79359.60320198363;88067.11932880589;89600;91848.54075729579;11554.48004839801;11578.826317605075;11655.18413711032;11714.824277635671;11808.232464889754;12302.630921072383;12381.690457738268;12666.87333126657;12795.360231988177;12943.288119153536;10708.73228169302;11677.708057298636;11793.115516336138;11872.807762643748;12278.75442491163;11610.303381797119;12095.697607559881;12300;12333.383330833243;12722.554710585086;11762.294262344287;11923.224990375598;12007.159498834997;12112.636620901387;12138.575149869712;9514.524273786421;10129.64546240878;10144.594216231564;10219.335743176669;10293.330933489298;9798.608055677692;10508.264421490423;10536.262461627612;10539.314944528582;10547.947260263649 06:16:06 INFO - PROCESS | 2179 | __end_tp_report 06:16:06 INFO - PROCESS | 2179 | __start_cc_report 06:16:06 INFO - PROCESS | 2179 | _x_x_mozilla_cycle_collect,363 06:16:06 INFO - PROCESS | 2179 | __end_cc_report 06:16:06 INFO - PROCESS | 2179 | __startTimestamp1485267366047__endTimestamp 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | ------- Summary: start ------- 06:16:06 INFO - PROCESS | 2179 | Number of tests: 6 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | [#0] dojo.html Cycles:165 Average:5927.37 Median:6206.10 stddev:672.95 (10.8%) stddev-sans-first:647.99 06:16:06 INFO - PROCESS | 2179 | Values: 3520.5 3548.1 3562.3 3573.2 3584.8 5879.2 5929.4 5982.7 5989.0 6015.3 5983.3 6055.8 6088.3 6111.2 6116.1 5335.4 5409.5 5422.9 5435.6 5480.8 5471.2 5476.0 5485.8 5503.5 5539.4 5319.7 5334.4 5471.6 5477.5 5481.7 5386.2 5421.4 5443.6 5449.3 5516.3 5265.8 5405.8 5412.9 5416.4 5446.5 5823.6 6050.8 6064.8 6144.9 6159.0 5259.6 6237.1 6276.3 6289.4 6360.5 6352.8 6431.5 6435.5 6447.0 6457.5 6122.5 6131.8 6153.7 6163.9 6170.5 6439.8 6492.6 6543.1 6559.2 6596.4 6247.5 6257.4 6259.3 6278.8 6298.7 6206.1 6245.1 6466.5 6473.1 6488.4 6258.7 6300.7 6306.4 6345.0 6360.3 6307.7 6324.6 6356.2 6359.4 6369.4 5072.3 5180.7 5191.4 5205.1 5234.3 3640.3 4331.8 4575.5 4584.2 4606.1 5431.5 5438.5 5561.2 6178.4 6182.8 5829.6 5930.4 6402.5 6469.7 6530.9 6088.5 6120.4 6134.2 6149.1 6173.6 4709.2 5677.1 5686.2 5700.9 5701.4 6606.1 6641.9 6660.2 6672.8 6683.2 6300.5 6332.9 6367.2 6374.7 6454.9 6698.2 6701.0 6706.7 6716.2 6726.0 6340.7 6367.8 6399.0 6410.5 6423.9 6222.7 6261.3 6271.5 6315.4 6436.8 6266.7 6278.6 6282.8 6300.6 6316.0 6279.9 6288.3 6294.3 6313.5 6315.5 5041.0 5194.9 5569.4 6108.3 6213.6 6226.2 6245.5 6263.5 6270.0 6275.9 6274.4 6277.3 6294.2 6295.6 6299.0 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | [#1] ext.html Cycles:180 Average:68983.14 Median:40794.69 stddev:149378.33 (366.2%) stddev-sans-first:149708.92 06:16:06 INFO - PROCESS | 2179 | Values: 513.7 514.4 529.6 537.7 541.4 26525.5 39763.4 41762.6 41907.8 42074.0 42991.6 43756.0 43945.1 44034.8 44122.8 8243.8 8286.7 9463.0 9770.6 9797.0 9646.3 9782.3 9785.1 9814.4 9830.6 9750.2 9790.1 9793.0 9807.5 9825.6 9689.6 9765.0 9769.0 9792.9 9797.2 9645.9 9753.8 9764.2 9767.2 9777.8 40576.0 40641.2 40731.0 40781.0 40808.4 3245.4 3360.6 3499.4 3603.1 3861.6 31235.2 31367.1 31418.2 31594.7 31743.0 3165.4 3233.8 3289.6 3330.9 3342.2 308187.0 385896.0 389675.0 390276.0 391685.0 63916.7 64302.0 64401.7 64607.0 64862.4 66533.0 67026.7 67194.7 67582.0 67669.0 16606.2 16665.0 17029.5 17032.1 17064.9 12724.9 12770.0 13061.7 13112.2 13183.7 17627.4 18093.8 18143.4 18181.4 18187.7 5534.3 6529.0 6564.9 6565.8 6636.3 890.5 967.7 1037.0 1055.6 1125.8 30699.7 31008.1 31063.8 31123.0 31242.0 970.0 1031.5 1035.8 1128.0 1180.4 15016.4 16033.8 16044.4 16163.6 16194.6 651262.0 660777.0 662066.0 665840.0 668388.0 58255.7 61052.7 61202.4 61210.7 61365.8 1368.4 1394.9 1400.2 1401.1 1401.9 29729.6 30073.8 30607.7 30751.5 31009.0 52843.5 53382.5 53540.5 53573.5 53737.7 594248.0 595750.0 596432.0 600383.0 601551.0 27082.0 27875.2 28023.3 28747.9 42364.6 47626.0 48495.0 48547.5 48735.5 49081.0 33069.7 39809.6 41753.4 41764.2 41825.4 40453.8 40493.0 40770.0 41309.4 41918.8 38904.0 39510.0 39747.6 39963.6 41159.6 32402.5 35487.8 35769.6 35985.0 36120.6 21583.1 24905.6 26370.2 26826.9 27088.3 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | [#2] jquery.html Cycles:180 Average:34249.32 Median:2226.27 stddev:96872.05 (4351.3%) stddev-sans-first:97110.42 06:16:06 INFO - PROCESS | 2179 | Values: 379.3 379.8 388.1 394.1 412.7 17763.7 18889.3 20363.2 20394.8 20623.7 17467.6 18592.0 19572.7 20053.9 20268.5 3824.7 5048.4 5815.1 6050.6 6103.9 5669.9 6732.6 6738.6 6741.2 6762.9 6405.3 6582.2 6646.0 6648.4 6729.4 5760.5 6571.1 6586.5 6623.0 6756.5 5840.0 5927.3 5939.0 5963.0 5976.8 11572.5 12540.7 13580.7 13638.9 13724.8 2174.8 2277.8 2362.9 2370.4 2444.5 9806.6 10066.0 10296.9 10477.2 10719.8 1638.7 1994.6 2002.7 2007.7 2018.8 122090.0 122581.0 125919.4 127143.0 131029.3 11793.6 11877.9 12024.3 12042.8 12188.3 12256.4 14532.6 14946.4 15075.0 15097.8 8541.0 8592.3 8741.4 8996.0 9001.7 7041.7 7149.2 8758.2 8796.9 8914.7 4252.3 4684.8 4688.4 4717.1 4739.4 1973.7 2035.1 2036.1 2037.3 2039.3 854.2 945.9 948.2 958.4 1013.7 20346.5 21280.0 21330.9 21426.9 21461.7 913.8 920.8 947.6 996.1 1026.6 10744.4 11028.1 11780.3 11868.5 12155.3 523288.0 526388.0 531218.0 645613.0 645636.0 85101.6 132613.3 139319.3 139982.0 142282.0 973.6 985.5 1038.5 1047.4 1049.4 18737.1 19300.9 19568.5 19616.6 19656.2 55692.4 57300.6 57415.0 58078.7 58252.8 58265.7 62894.7 78616.6 81080.8 83373.2 6278.1 7681.0 7749.5 7802.2 8209.8 11982.9 13195.8 13380.0 13434.3 13559.4 8104.6 8831.7 9841.0 10589.8 11590.5 10157.3 10577.9 11304.2 11530.7 11585.1 11713.0 11786.4 11834.4 11863.8 12102.2 7561.5 7608.7 7644.0 7671.5 7788.6 10776.3 10923.3 10962.9 11653.8 11830.3 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | [#3] mootools.html Cycles:180 Average:5479.45 Median:5193.92 stddev:2958.91 (57.0%) stddev-sans-first:2951.14 06:16:06 INFO - PROCESS | 2179 | Values: 1376.1 1501.3 1678.4 1848.2 1848.4 6636.9 7667.4 7874.6 8553.7 8566.3 6759.9 8255.2 8261.6 8408.5 8441.9 2342.3 2389.6 2394.0 2395.5 2396.2 2389.6 2414.3 2443.5 2447.4 2452.9 2355.9 2362.4 2369.9 2375.9 2408.1 2352.7 2359.7 2369.9 2370.6 2376.8 2384.5 2389.5 2391.1 2406.5 2407.5 8400.1 8451.2 8462.1 8471.2 8479.5 5107.4 5304.4 5324.4 5325.4 5330.9 3486.6 3548.4 3549.8 3583.6 3611.2 1059.3 1063.9 1089.2 1100.4 1106.2 10871.9 10914.8 10926.9 10933.0 10949.6 3929.5 4481.6 4672.5 4745.4 4806.5 7862.5 9517.5 9527.2 9529.3 9532.1 5280.4 5288.0 5295.2 5303.0 5365.8 4355.8 4397.1 4852.3 4859.1 4877.6 3904.8 3966.7 3994.4 4028.1 4059.7 1298.2 1314.0 1316.9 1317.0 1317.9 816.3 846.1 908.8 924.2 928.6 4960.3 5315.2 5798.9 5881.8 6106.8 872.2 904.9 913.3 930.3 946.1 3848.6 3851.9 3932.0 3969.6 3971.2 9836.5 10189.6 10241.0 10254.4 10257.1 10048.6 10090.8 10119.6 10172.9 10182.5 7668.0 7763.7 7974.9 7984.0 8023.9 5519.3 5543.9 5554.2 5679.7 5709.7 7872.0 9352.5 9367.3 9419.1 9505.4 9086.5 9475.0 9477.2 9516.5 9627.0 6732.0 6914.0 7179.7 7330.3 7650.3 7771.2 7986.8 8053.1 8059.0 8072.3 7083.6 7097.3 7304.9 7328.6 7345.7 7050.4 7079.5 7131.9 7170.0 7284.9 6655.0 6706.4 6779.6 6787.6 6788.7 4457.5 4808.3 4843.2 4862.5 4945.6 4125.4 4876.1 5000.7 5002.0 5025.5 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | [#4] prototype.html Cycles:180 Average:4679.80 Median:5261.96 stddev:1442.75 (27.4%) stddev-sans-first:1409.09 06:16:06 INFO - PROCESS | 2179 | Values: 313.9 316.7 323.4 324.5 328.1 4907.6 5598.7 5627.2 5693.6 5748.4 4429.9 4897.5 5348.7 5524.9 5563.0 4159.7 4200.6 4220.3 4226.4 4262.7 3902.9 4037.8 4082.8 4270.0 4271.3 3515.6 3919.1 4065.3 4267.0 4273.2 4252.0 4260.2 4263.5 4265.6 4287.0 2986.7 3252.7 3273.6 3545.8 3737.5 4652.9 5069.2 5442.6 5474.7 5571.2 4443.0 4446.7 4936.5 4953.5 4955.9 5299.3 5861.3 5873.5 5896.4 5914.8 3871.3 3969.9 4062.3 4142.6 4194.4 6159.9 6220.6 6229.6 6233.3 6249.7 4200.6 4247.7 4260.7 4266.8 4269.4 3233.2 3998.7 4248.5 4291.6 4318.0 4430.3 4724.9 4933.8 4941.6 4972.7 4898.4 5913.2 5936.3 5945.3 5964.5 1105.5 1183.4 1393.4 1395.6 1400.6 937.5 952.8 965.8 970.3 970.6 5076.9 5250.2 5365.3 5369.5 5381.8 4670.0 4742.4 5409.8 5605.7 5959.5 4977.7 5308.6 5311.0 5335.8 5710.8 2740.6 2749.4 2785.0 2849.3 3067.9 6047.6 6086.7 6113.7 6129.5 6143.3 5273.7 5390.9 5749.6 5962.2 5969.8 5572.9 5580.3 5730.2 6059.1 6148.6 4975.8 5020.9 5363.8 5835.8 5856.9 5036.0 5206.7 5686.3 5731.7 5820.5 4762.8 5165.9 5690.2 6103.6 6118.6 3451.9 3661.9 3737.2 3742.0 4021.8 5522.5 5542.3 5586.1 6031.5 6047.7 5919.8 5924.9 5929.3 5947.8 5960.6 4449.0 4858.8 5556.4 5604.3 5754.1 5712.3 5732.8 5738.6 5741.9 5756.5 4858.4 5093.5 5502.3 5815.3 5908.8 5738.5 5829.3 5839.7 5849.8 5853.6 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - PROCESS | 2179 | [#5] yui.html Cycles:180 Average:21524.34 Median:4487.19 stddev:33132.88 (738.4%) stddev-sans-first:33188.96 06:16:06 INFO - PROCESS | 2179 | Values: 706.4 731.3 792.8 831.8 833.8 14492.0 15158.2 15285.5 15353.9 15377.5 13238.5 13338.6 13384.7 13587.0 13625.4 880.0 896.4 897.1 898.0 898.6 832.3 870.5 878.7 879.4 879.6 936.5 936.8 938.7 939.9 942.3 908.2 919.5 921.2 922.0 923.4 668.6 676.0 702.4 703.5 707.2 12289.9 12506.2 12508.8 12520.6 12540.1 11620.4 11804.9 12026.3 12134.3 12399.4 10375.6 10512.8 10658.7 10714.8 10943.1 3583.3 3665.9 3713.0 3766.2 3858.7 93238.1 93350.0 96794.0 98560.5 99140.5 8568.1 8623.8 8634.1 10388.8 10578.6 20078.8 20395.3 20412.0 20413.2 20444.2 6898.5 7170.9 7285.7 7555.1 7830.2 4353.4 4368.0 4368.5 4456.4 4517.9 2878.2 3323.8 3424.2 3708.0 3864.3 694.2 696.6 709.8 712.2 717.6 594.4 655.5 681.1 686.5 690.8 8973.7 9420.8 9553.8 9555.8 9671.3 627.5 653.9 666.8 673.9 705.5 3811.0 4581.9 4582.8 4596.7 4649.9 113904.0 113943.4 114259.0 117586.0 120729.4 79586.6 109315.0 111520.0 112564.0 115271.0 83978.0 96338.5 98919.0 99059.5 101350.0 8738.7 8964.8 8982.1 8988.0 8995.5 41726.8 46755.0 60242.4 63544.0 64126.4 65524.7 79359.6 88067.1 89600.0 91848.5 11554.5 11578.8 11655.2 11714.8 11808.2 12302.6 12381.7 12666.9 12795.4 12943.3 10708.7 11677.7 11793.1 11872.8 12278.8 11610.3 12095.7 12300.0 12333.4 12722.6 11762.3 11923.2 12007.2 12112.6 12138.6 9514.5 10129.6 10144.6 10219.3 10293.3 9798.6 10508.3 10536.3 10539.3 10547.9 06:16:06 INFO - PROCESS | 2179 | -------- Summary: end -------- 06:16:06 INFO - PROCESS | 2179 | 06:16:06 INFO - TEST-INFO | 2179: exit 0 06:16:06 INFO - TEST-OK | dromaeo_css | took 1114475ms 06:16:06 INFO - TEST-START | kraken 06:16:06 INFO - operating with platform_type : mac_ 06:16:06 INFO - Initialising browser for kraken test... 06:16:06 INFO - TEST-INFO | started process 2183 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpn7pqeH/profile http://localhost:62183/getInfo.html) 06:16:09 INFO - PROCESS | 2183 | 2017-01-24 06:16:09.224 plugin-container[2185:32119] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 06:16:09 INFO - PROCESS | 2183 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:16:09 INFO - PROCESS | 2183 | 2017-01-24 06:16:09.224 plugin-container[2185:32119] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 06:16:09 INFO - PROCESS | 2183 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:16:09 INFO - PROCESS | 2183 | 2017-01-24 06:16:09.224 plugin-container[2185:32119] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:16:09 INFO - PROCESS | 2183 | __metrics Screen width/height:1600/1200 06:16:09 INFO - PROCESS | 2183 | colorDepth:24 06:16:09 INFO - PROCESS | 2183 | Browser inner width/height: 1024/689 06:16:09 INFO - PROCESS | 2183 | __metrics 06:16:09 ERROR - PROCESS | 2183 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 06:16:10 INFO - TEST-INFO | 2183: exit 0 06:16:10 INFO - Browser initialized. 06:16:10 INFO - Running cycle 1/1 for kraken test... 06:16:10 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpn7pqeH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:12 INFO - PROCESS | 2186 | 2017-01-24 06:16:12.853 plugin-container[2187:32236] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 06:16:12 INFO - PROCESS | 2186 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:16:12 INFO - PROCESS | 2186 | 2017-01-24 06:16:12.853 plugin-container[2187:32236] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 06:16:12 INFO - PROCESS | 2186 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:16:12 INFO - PROCESS | 2186 | 2017-01-24 06:16:12.853 plugin-container[2187:32236] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:16:22 INFO - PROCESS | 2186 | RSS: Main: 178286592 06:16:22 INFO - PROCESS | 2186 | 06:16:25 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62183/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:26 INFO - PROCESS | 2186 | RSS: Main: 190476288 06:16:26 INFO - PROCESS | 2186 | 06:16:29 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62183/tests/kraken/driver.html?testName=audio-dft) 06:16:30 INFO - PROCESS | 2186 | RSS: Main: 198365184 06:16:30 INFO - PROCESS | 2186 | 06:16:33 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62183/tests/kraken/driver.html?testName=audio-fft) 06:16:34 INFO - PROCESS | 2186 | RSS: Main: 200376320 06:16:34 INFO - PROCESS | 2186 | 06:16:36 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62183/tests/kraken/driver.html?testName=audio-oscillator) 06:16:36 INFO - PROCESS | 2186 | RSS: Main: 203005952 06:16:36 INFO - PROCESS | 2186 | 06:16:38 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62183/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:39 INFO - PROCESS | 2186 | RSS: Main: 203182080 06:16:39 INFO - PROCESS | 2186 | 06:16:42 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62183/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:42 INFO - PROCESS | 2186 | RSS: Main: 207376384 06:16:42 INFO - PROCESS | 2186 | 06:16:45 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62183/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:46 INFO - PROCESS | 2186 | RSS: Main: 206581760 06:16:46 INFO - PROCESS | 2186 | 06:16:49 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62183/tests/kraken/driver.html?testName=json-parse-financial) 06:16:49 INFO - PROCESS | 2186 | RSS: Main: 206688256 06:16:49 INFO - PROCESS | 2186 | 06:16:51 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62183/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:52 INFO - PROCESS | 2186 | RSS: Main: 206131200 06:16:52 INFO - PROCESS | 2186 | 06:16:54 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:54 INFO - PROCESS | 2186 | RSS: Main: 206204928 06:16:54 INFO - PROCESS | 2186 | 06:16:56 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:57 INFO - PROCESS | 2186 | RSS: Main: 206163968 06:16:57 INFO - PROCESS | 2186 | 06:17:00 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:01 INFO - PROCESS | 2186 | RSS: Main: 206454784 06:17:01 INFO - PROCESS | 2186 | 06:17:04 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:04 INFO - PROCESS | 2186 | RSS: Main: 206565376 06:17:04 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:62183/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62183/tests/kraken/driver.html?testName=ai-astar) 06:17:06 INFO - PROCESS | 2186 | RSS: Main: 208011264 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | __start_tp_report 06:17:06 INFO - PROCESS | 2186 | _x_x_mozilla_page_load 06:17:06 INFO - PROCESS | 2186 | _x_x_mozilla_page_load_details 06:17:06 INFO - PROCESS | 2186 | |i|pagename|runs| 06:17:06 INFO - PROCESS | 2186 | |0;ai-astar;147;93;172;177;127;160;173;166;160;116 06:17:06 INFO - PROCESS | 2186 | |1;audio-beat-detection;141;112;100;163;150;102;133;152;171;122 06:17:06 INFO - PROCESS | 2186 | |2;audio-dft;195;210;246;275;220;206;253;197;195;202 06:17:06 INFO - PROCESS | 2186 | |3;audio-fft;81;59;58;85;58;59;60;59;79;59 06:17:06 INFO - PROCESS | 2186 | |4;audio-oscillator;84;70;88;70;69;69;89;88;65;93 06:17:06 INFO - PROCESS | 2186 | |5;imaging-gaussian-blur;93;88;89;94;79;132;89;88;120;93 06:17:06 INFO - PROCESS | 2186 | |6;imaging-darkroom;97;121;109;141;97;98;99;98;96;101 06:17:06 INFO - PROCESS | 2186 | |7;imaging-desaturate;88;91;95;131;88;86;90;94;88;85 06:17:06 INFO - PROCESS | 2186 | |8;json-parse-financial;55;56;56;59;59;60;57;60;59;58 06:17:06 INFO - PROCESS | 2186 | |9;json-stringify-tinderbox;75;105;117;103;75;70;70;72;71;70 06:17:06 INFO - PROCESS | 2186 | |10;stanford-crypto-aes;83;83;83;83;82;82;85;80;84;93 06:17:06 INFO - PROCESS | 2186 | |11;stanford-crypto-ccm;155;157;136;141;143;143;146;140;188;131 06:17:06 INFO - PROCESS | 2186 | |12;stanford-crypto-pbkdf2;163;170;164;167;163;203;147;226;214;235 06:17:06 INFO - PROCESS | 2186 | |13;stanford-crypto-sha256-iterative;66;68;65;68;73;82;90;62;66;68 06:17:06 INFO - PROCESS | 2186 | __end_tp_report 06:17:06 INFO - PROCESS | 2186 | __start_cc_report 06:17:06 INFO - PROCESS | 2186 | _x_x_mozilla_cycle_collect,926 06:17:06 INFO - PROCESS | 2186 | __end_cc_report 06:17:06 INFO - PROCESS | 2186 | __startTimestamp1485267426815__endTimestamp 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | ------- Summary: start ------- 06:17:06 INFO - PROCESS | 2186 | Number of tests: 14 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#0] ai-astar Cycles:10 Average:149.10 Median:169.00 stddev:28.15 (16.7%) stddev-sans-first:29.85 06:17:06 INFO - PROCESS | 2186 | Values: 147.0 93.0 172.0 177.0 127.0 160.0 173.0 166.0 160.0 116.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:145.50 stddev:25.04 (17.2%) stddev-sans-first:26.45 06:17:06 INFO - PROCESS | 2186 | Values: 141.0 112.0 100.0 163.0 150.0 102.0 133.0 152.0 171.0 122.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#2] audio-dft Cycles:10 Average:219.90 Median:215.00 stddev:28.26 (13.1%) stddev-sans-first:28.50 06:17:06 INFO - PROCESS | 2186 | Values: 195.0 210.0 246.0 275.0 220.0 206.0 253.0 197.0 195.0 202.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.50 stddev:11.13 (18.7%) stddev-sans-first:10.33 06:17:06 INFO - PROCESS | 2186 | Values: 81.0 59.0 58.0 85.0 58.0 59.0 60.0 59.0 79.0 59.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:86.00 stddev:10.74 (12.5%) stddev-sans-first:11.21 06:17:06 INFO - PROCESS | 2186 | Values: 84.0 70.0 88.0 70.0 69.0 69.0 89.0 88.0 65.0 93.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:89.00 stddev:16.35 (18.4%) stddev-sans-first:17.29 06:17:06 INFO - PROCESS | 2186 | Values: 93.0 88.0 89.0 94.0 79.0 132.0 89.0 88.0 120.0 93.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:97.00 stddev:14.61 (15.1%) stddev-sans-first:15.16 06:17:06 INFO - PROCESS | 2186 | Values: 97.0 121.0 109.0 141.0 97.0 98.0 99.0 98.0 96.0 101.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:89.00 stddev:13.53 (15.2%) stddev-sans-first:14.19 06:17:06 INFO - PROCESS | 2186 | Values: 88.0 91.0 95.0 131.0 88.0 86.0 90.0 94.0 88.0 85.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:59.00 stddev:1.79 (3.0%) stddev-sans-first:1.56 06:17:06 INFO - PROCESS | 2186 | Values: 55.0 56.0 56.0 59.0 59.0 60.0 57.0 60.0 59.0 58.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#9] json-stringify-tinderbox Cycles:10 Average:82.80 Median:70.50 stddev:18.07 (25.6%) stddev-sans-first:18.95 06:17:06 INFO - PROCESS | 2186 | Values: 75.0 105.0 117.0 103.0 75.0 70.0 70.0 72.0 71.0 70.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:3.49 (4.2%) stddev-sans-first:3.69 06:17:06 INFO - PROCESS | 2186 | Values: 83.0 83.0 83.0 83.0 82.0 82.0 85.0 80.0 84.0 93.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:144.50 stddev:16.09 (11.1%) stddev-sans-first:16.87 06:17:06 INFO - PROCESS | 2186 | Values: 155.0 157.0 136.0 141.0 143.0 143.0 146.0 140.0 188.0 131.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:186.50 stddev:31.18 (16.7%) stddev-sans-first:32.02 06:17:06 INFO - PROCESS | 2186 | Values: 163.0 170.0 164.0 167.0 163.0 203.0 147.0 226.0 214.0 235.0 06:17:06 INFO - PROCESS | 2186 | 06:17:06 INFO - PROCESS | 2186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:68.00 stddev:8.69 (12.8%) stddev-sans-first:9.04 06:17:06 INFO - PROCESS | 2186 | Values: 66.0 68.0 65.0 68.0 73.0 82.0 90.0 62.0 66.0 68.0 06:17:06 INFO - PROCESS | 2186 | -------- Summary: end -------- 06:17:06 INFO - PROCESS | 2186 | 06:17:07 INFO - TEST-INFO | 2186: exit 0 06:17:07 INFO - TEST-OK | kraken | took 61196ms 06:17:07 INFO - SUITE-END | took 1175s 06:17:07 INFO - Completed test suite (00:19:35) 06:17:07 INFO - javascript benchmark 06:17:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7347.07797135028, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3520.542329497165, 3548.0774998500387, 3562.323158599865, 3573.178169021125, 3584.8028358440306, 5879.235699359083, 5929.4367035131645, 5982.670953097578, 5989.0, 6015.3082395524525, 5983.2820061592665, 6055.848603784908, 6088.330283668793, 6111.205543279368, 6116.082587611861, 5335.439778823235, 5409.540189083933, 5422.91865622016, 5435.565154787627, 5480.780768769245, 5471.206675032118, 5475.972620136894, 5485.807996720116, 5503.477169668875, 5539.446055394468, 5319.654222475527, 5334.413214546416, 5471.616986810925, 5477.5070243678065, 5481.671099734009, 5386.165144402624, 5421.430749771276, 5443.646162999432, 5449.346078470569, 5516.255305533742, 5265.7893684252585, 5405.756740946627, 5412.91880621791, 5416.377116631598, 5446.537044351235, 5823.563232757518, 6050.788222412239, 6064.818055458343, 6144.87710245797, 6159.0, 5259.552938000236, 6237.095621134956, 6276.309605943343, 6289.433950944392, 6360.491160707133, 6352.80941571749, 6431.549791514596, 6435.549511534195, 6446.967765161191, 6457.515686323544, 6122.540809439265, 6131.816045518642, 6153.723082461211, 6163.907541386883, 6170.50635949123, 6439.774607888701, 6492.577982431127, 6543.1166792483355, 6559.180102487189, 6596.4393026592315, 6247.468965138014, 6257.43683068526, 6259.311475737665, 6278.811635650938, 6298.685065746694, 6206.100115483229, 6245.125682404467, 6466.450351720063, 6473.126127972663, 6488.351164883474, 6258.718357673915, 6300.653464059521, 6306.369363063657, 6344.968275158594, 6360.268569114519, 6307.653079080695, 6324.588901721466, 6356.237251529846, 6359.395857393541, 6369.426751592287, 5072.289879416885, 5180.740962951837, 5191.351081114861, 5205.115130427836, 5234.26720259164, 3640.2719456108885, 4331.765446847633, 4575.473820510617, 4584.17484852723, 4606.101810146989, 5431.538319242909, 5438.45615438453, 5561.249231353796, 6178.41305076017, 6182.783602573888, 5829.630036941316, 5930.406959304035, 6402.455791257702, 6469.676516174172, 6530.869382612321, 6088.452039316483, 6120.44915957566, 6134.16106913652, 6149.108379285068, 6173.56785025044, 4709.246520556694, 5677.148427735872, 5686.2039314496005, 5700.857478563069, 5701.40135285789, 6606.075149479077, 6641.933580664228, 6660.200775906922, 6672.799816005625, 6683.198016238082, 6300.495960323072, 6332.923403021406, 6367.172267605367, 6374.745010199726, 6454.903176452451, 6698.196216454056, 6700.966495167493, 6706.698198580978, 6716.1604799400075, 6726.0, 6340.746370145327, 6367.808965731036, 6398.968005159944, 6410.45511131559, 6423.935760642334, 6222.719977601109, 6261.311255761953, 6271.529635277281, 6315.368463153648, 6436.774712885027, 6266.655333956676, 6278.623282602875, 6282.780102696383, 6300.558960872695, 6315.96842015787, 6279.937200627935, 6288.308286088435, 6294.3076261612105, 6313.516323664027, 6315.463185629089, 5040.991801639613, 5194.948050519446, 5569.359523654832, 6108.267007959073, 6213.565050446426, 6226.221722284715, 6245.469135123383, 6263.530235232284, 6270.0, 6275.90171719938, 6274.435300822948, 6277.30949595535, 6294.244690637152, 6295.5907865988565, 6298.968505157445], "value": 5885.226284030229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.6686836990144, 514.4264145477792, 529.6027979015738, 537.6693333599835, 541.3774159716328, 26525.469490610176, 39763.40354894675, 41762.58237417625, 41907.79046104773, 42074.0, 42991.57008429915, 43756.0, 43945.12109757811, 44034.77982610082, 44122.7793861031, 8243.79390515239, 8286.709965151222, 9462.952685236563, 9770.609175632966, 9796.951015244913, 9646.324757266993, 9782.26633002524, 9785.07041831025, 9814.362066465692, 9830.606775728962, 9750.219982401426, 9790.069943355405, 9792.951035244814, 9807.509624518745, 9825.557849896772, 9689.563969621384, 9764.951175244078, 9768.95115524425, 9792.853107203398, 9797.216222702167, 9645.903540964571, 9753.804923901482, 9764.170045546138, 9767.218622510181, 9777.755556111082, 40576.0, 40641.18717625631, 40731.0, 40781.0, 40808.38787418191, 3245.367153405087, 3360.5799275090612, 3499.422595271777, 3603.1352475405974, 3861.584506171318, 31235.219119521968, 31367.05898823016, 31418.21454463634, 31594.684053159635, 31743.0, 3165.446046941799, 3233.804888471487, 3289.605247370307, 3330.8667653293837, 3342.2479942013097, 308187.0, 385896.0, 389674.99999999715, 390276.04861975793, 391685.0, 63916.68041659855, 64302.0, 64401.677991609744, 64607.03089453662, 64862.35137648658, 66533.0, 67026.6594668104, 67194.66402667956, 67582.0, 67668.98496522557, 16606.169691515377, 16665.0, 17029.48911532656, 17032.06323652211, 17064.914675426542, 12724.91838193764, 12770.042246831525, 13061.673458163432, 13112.213267203999, 13183.67040823968, 17627.38304159374, 18093.819061809478, 18143.364982225823, 18181.363652272106, 18187.727184092248, 5534.308211473566, 6529.0, 6564.901526477107, 6565.80302590923, 6636.270010298863, 890.5057692980329, 967.709687093869, 1036.9740756481149, 1055.646358469921, 1125.7579620381657, 30699.693003069682, 31008.0697579073, 31063.844680776452, 31123.0, 31242.0, 969.9709008729608, 1031.5358088860044, 1035.7565971996576, 1127.9774404511863, 1180.38030034231, 15016.353555901293, 16033.759493607606, 16044.43844465438, 16163.595910102107, 16194.595135121715, 651262.0, 660777.0, 662066.0, 665840.0, 668388.0, 58255.70872145612, 61052.694736526035, 61202.38797612056, 61210.69394652998, 61365.77268454695, 1368.4047439363908, 1394.877123915258, 1400.1808941768975, 1401.1382999455261, 1401.9275254430572, 29729.554056689598, 30073.849630751705, 30607.693923061375, 30751.538726918665, 31009.0, 52843.47156528386, 53382.4661753393, 53540.46459535355, 53573.464265356844, 53737.731311343196, 594248.0, 595750.0, 596432.0, 600383.0, 601551.0, 27082.0, 27875.16374508768, 28023.29941751391, 28747.8562607194, 42364.576354236066, 47626.0, 48495.0, 48547.5145248543, 48735.512644874514, 49081.0, 33069.66930330762, 39809.60190398059, 41753.37369939514, 41764.1647167061, 41825.372619410125, 40453.79773101233, 40493.0, 40770.0, 41309.38035929403, 41918.790406047774, 38904.027399315244, 39510.0, 39747.60252397439, 39963.60036399599, 41159.58840411557, 32402.51396229011, 35487.82256088703, 35769.56921723206, 35985.0, 36120.638793611724, 21583.13667453284, 24905.62641560342, 26370.20889373322, 26826.926922922863, 27088.32279192957], "value": 20267.446658655637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.34752226170974, 379.80629878761835, 388.14220572534697, 394.09555071111794, 412.69460599156633, 17763.733543996852, 18889.338873139444, 20363.1854725811, 20394.796052039474, 20623.690644640305, 17467.563310917234, 18591.977441240728, 19572.706409403836, 20053.89973050136, 20268.493287667814, 3824.6749026332795, 5048.368953880765, 5815.069588865772, 6050.636961782285, 6103.877922441548, 5669.8582535436535, 6732.596044237362, 6738.629375384352, 6741.157355330583, 6762.932370676304, 6405.327440618715, 6582.2101347838325, 6646.0, 6648.434883034948, 6729.360710732472, 5760.53915686744, 6571.145751052332, 6586.473082153416, 6622.966885165568, 6756.527043106985, 5840.0, 5927.2887253529425, 5938.970305148489, 5962.97018514909, 5976.820695379146, 11572.53709851605, 12540.745925407478, 13580.728385432236, 13638.863611363859, 13724.794128088086, 2174.7607763146043, 2277.7722227777253, 2362.9291121266388, 2370.3718514593647, 2444.4622183119686, 9806.558704858227, 10065.993400659949, 10296.94851525745, 10477.161827053893, 10719.83920241197, 1638.6558822647257, 1994.6010797840345, 2002.7196192533056, 2007.6548712362753, 2018.777934427212, 122090.0, 122581.0, 125919.3704031474, 127143.0, 131029.34485327608, 11793.646190614296, 11877.940610297066, 12024.278543287432, 12042.759144817055, 12188.268703877795, 12256.387180640932, 14532.564023079325, 14946.40214391434, 15075.0, 15097.773533397009, 8541.0, 8592.269657079094, 8741.431806932529, 8995.955020224857, 9001.684941027033, 7041.683124259421, 7149.249328820503, 8758.167974042455, 8796.868046979173, 8914.73255802327, 4252.29837076885, 4684.81260749573, 4688.390509233778, 4717.113154738132, 4739.383880095635, 1973.7138114973247, 2035.084212104559, 2036.0634108310046, 2037.3293899002972, 2039.2862498125835, 854.2013217641525, 945.9243260539278, 948.2319321349729, 958.4105774948496, 1013.7465633591602, 20346.49133771638, 21280.0, 21330.893345533485, 21426.892865535883, 21461.67807482889, 913.8446464101119, 920.7836158502746, 947.6398968391967, 996.1383403356045, 1026.6355443817486, 10744.433615713291, 11028.062614677681, 11780.293182409083, 11868.465919033664, 12155.270683759003, 523288.0, 526388.0, 531218.0, 645613.0, 645636.0, 85101.57449212714, 132613.3369333147, 139319.30340348234, 139982.0, 142282.0, 973.59595767757, 985.4776968206862, 1038.48075962019, 1047.3558761361708, 1049.4490392543976, 18737.063146842876, 19300.90349548243, 19568.510787230432, 19616.60766784685, 19656.213751450356, 55692.44307556873, 57300.56748581319, 57415.0, 58078.709606451695, 58252.83494330174, 58265.70867145637, 62894.74210515673, 78616.60691696504, 81080.78378824204, 83373.16626833654, 6278.058291256348, 7681.0, 7749.457537972288, 7802.180771019188, 8209.79475513117, 11982.940085299517, 13195.802062969255, 13380.0, 13434.328283585977, 13559.389827457591, 8104.594770261581, 8831.735047948572, 9840.950795245977, 10589.788204235718, 11590.478428470908, 10157.288989770645, 10577.894221057692, 11304.152188585724, 11530.654080377602, 11585.131115166565, 11713.0, 11786.410679466164, 11834.408279586158, 11863.76272474563, 12102.213356131822, 7561.546307221584, 7608.695652174072, 7644.006279183893, 7671.462997590115, 7788.649510772142, 10776.272081198087, 10923.289986150874, 10962.945185274022, 11653.825192622287, 11830.349330786888], "value": 9513.634173293178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.133036187202, 1501.2793858947705, 1678.4377233626735, 1848.1775609853603, 1848.4177484092502, 6636.9336306636915, 7667.424943129274, 7874.645640946157, 8553.74338769837, 8566.271866891322, 6759.932400675992, 8255.174482551742, 8261.58692065396, 8408.453450525727, 8441.873371899426, 2342.3324352559525, 2389.557931782626, 2394.0184524345023, 2395.520895820834, 2396.2332053742807, 2389.629607410854, 2414.3481260059775, 2443.4990826880535, 2447.3514518652573, 2452.901883924641, 2355.9057637694473, 2362.433016076138, 2369.9289021329387, 2375.857448553092, 2408.0728919366084, 2352.6588644646604, 2359.6578496118054, 2369.893354799038, 2370.5969985102574, 2376.797972172376, 2384.451576137481, 2389.4504264019197, 2391.0794344177443, 2406.470576473173, 2407.518496300747, 8400.117987611275, 8451.197136272105, 8462.069172391031, 8471.19523645259, 8479.533625650587, 5107.412647545506, 5304.389995150568, 5324.4143144254485, 5325.387580428262, 5330.946690533123, 3486.5990411102794, 3548.361294966905, 3549.7870127792416, 3583.5878873929573, 3611.1694310308512, 1059.2743970380236, 1063.8989296016866, 1089.2103225161773, 1100.3892839474088, 1106.24775152896, 10871.891281087166, 10914.836277455845, 10926.945365273203, 10932.99999999992, 10949.562017519289, 3929.4695216145456, 4481.641468682497, 4672.5327467253, 4745.3593764842, 4806.519348065165, 7862.52824830512, 9517.524123793783, 9527.237820974306, 9529.332946693665, 9532.142107210384, 5280.419153893069, 5288.04815133272, 5295.179247216687, 5303.04545181871, 5365.812196573179, 4355.8475453359615, 4397.07661391105, 4852.272159176152, 4859.125357435695, 4877.585405240523, 3904.7657140571655, 3966.7024973126554, 3994.4407782910416, 4028.073543085107, 4059.69552283574, 1298.1951190262098, 1314.0210543145226, 1316.8946484281234, 1316.9868301317056, 1317.9341032948314, 816.2939057715153, 846.0650980666398, 908.7591788176138, 924.1682485762867, 928.6099838068028, 4960.330355401975, 5315.202719592092, 5798.9420105799245, 5881.823545293648, 6106.786262480792, 872.241150199318, 904.8643951840398, 913.2784700838967, 930.3208657679796, 946.1342871272708, 3848.576026870076, 3851.9229615407535, 3932.0, 3969.6030396960073, 3971.1859068891386, 9836.508174591241, 10189.643362482277, 10240.9759024097, 10254.384736915808, 10257.07686308221, 10048.59805607782, 10090.798184036279, 10119.645812396531, 10172.949135254275, 10182.490875456198, 7667.961660191775, 7763.650635721406, 7974.880376794353, 7984.0, 8023.879641805378, 5519.337679478328, 5543.9168412474655, 5554.222408862844, 5679.716014199191, 5709.65742055478, 7871.976643036598, 9352.532373381167, 9367.250619950524, 9419.105185007413, 9505.42967421957, 9086.45481271126, 9475.005124462108, 9477.194438472807, 9516.524173791144, 9627.0, 6731.966340168267, 6913.965430172817, 7179.748708795376, 7330.340269375782, 7650.31147196755, 7771.1840256774485, 7986.760397187862, 8053.114157442794, 8058.959705201437, 8072.273495385209, 7083.645817708991, 7097.25478824716, 7304.853902922018, 7328.633568321456, 7345.669444874887, 7050.435965122881, 7079.539829911039, 7131.928680713127, 7169.964150179216, 7284.854302914018, 6655.0, 6706.396424321834, 6779.559328643622, 6787.592744435349, 6788.660566971533, 4457.465104187519, 4808.2547205183255, 4843.152448321459, 4862.507715895679, 4945.604351651931, 4125.401816736617, 4876.122297986255, 5000.749962501933, 5002.0, 5025.547700706954], "value": 4471.962503433606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.94035133324667, 316.6611725453764, 323.37911210475875, 324.4711120872977, 328.065014708082, 4907.582855457291, 5598.664080155194, 5627.155926611005, 5693.572982026349, 5748.367679555246, 4429.911401771963, 4897.461279259288, 5348.705821179834, 5524.889502209953, 5563.0, 4159.667226621863, 4200.621944025037, 4220.345846393814, 4226.429432026668, 4262.680298977573, 3902.8829135125993, 4037.818298176589, 4082.7547597982602, 4270.0, 4271.252530807096, 3515.5605549306338, 3919.1181984053646, 4065.268251714705, 4266.97866510667, 4273.166732487166, 4251.979524914013, 4260.211860805761, 4263.509696384909, 4265.55211702773, 4287.0, 2986.656534498539, 3252.658470860573, 3273.5744353234163, 3545.7517973741847, 3737.5141231639986, 4652.860414187579, 5069.239614057884, 5442.6462279951675, 5474.7262636868, 5571.164325351189, 4442.978115033528, 4446.666500012479, 4936.543719602726, 4953.4798846121, 4955.860152164986, 5299.270875499121, 5861.267341582302, 5873.500752436048, 5896.439838215363, 5914.763409463616, 3871.296374904505, 3969.900752481211, 4062.2890994076215, 4142.606452387018, 4194.433751443577, 6159.934443267422, 6220.588088363108, 6229.595076320024, 6233.314335423145, 6249.6875156242, 4200.5799420058365, 4247.702660813775, 4260.744355338689, 4266.807993640294, 4269.402283680287, 3233.224026233734, 3998.740081894726, 4248.534255681785, 4291.570842915684, 4318.03529394125, 4430.335449682573, 4724.929126063043, 4933.753312334441, 4941.555260026615, 4972.701637901738, 4898.432501599454, 5913.201717768132, 5936.317323507766, 5945.256842894638, 5964.463198312173, 1105.5412004018242, 1183.3609850680537, 1393.4356585582855, 1395.6301580081285, 1400.6078298076352, 937.4843835890233, 952.8094381123803, 965.7589996854009, 970.3207754571687, 970.5635659224388, 5076.949230507722, 5250.214926924864, 5365.275687782178, 5369.4630536946, 5381.811636592701, 4670.0, 4742.434996451163, 5409.755756176023, 5605.663660180402, 5959.523238140939, 4977.726225057657, 5308.575313974873, 5311.0, 5335.839924802262, 5710.771569137271, 2740.5752108423226, 2749.3539018330675, 2785.0, 2849.28767808048, 3067.8772849085785, 6047.637141771508, 6086.726097325631, 6113.676802814991, 6129.478994285447, 6143.32423433422, 5273.707941554344, 5390.948764990789, 5749.597528172988, 5962.165296858443, 5969.791057312973, 5572.916406253828, 5580.330360356783, 5730.169125476783, 6059.091885733677, 6148.571314330904, 4975.800967961241, 5020.866131894003, 5363.839084827461, 5835.824925252249, 5856.853578660568, 5035.974820125876, 5206.661566998133, 5686.299007971181, 5731.684757338219, 5820.534357251325, 4762.809487620457, 5165.870853228699, 5690.159142578826, 6103.6032657877095, 6118.571699980958, 3451.913702157466, 3661.9493083873117, 3737.2338670571926, 3741.981290093532, 4021.778802165792, 5522.532692634183, 5542.334919809648, 5586.106223004463, 6031.547633927561, 6047.697615119138, 5919.792807251725, 5924.851878703067, 5929.258842644669, 5947.821565353046, 5960.5827592068135, 4448.977755111204, 4858.82994095205, 5556.444355564411, 5604.299462567179, 5754.087220689804, 5712.285964254468, 5732.799352022659, 5738.5696072795545, 5741.923234503549, 5756.539476841926, 4858.392700912386, 5093.4651861554, 5502.313449988597, 5815.331236907809, 5908.822735317947, 5738.53667314832, 5829.300483941955, 5839.708014599338, 5849.766009359748, 5853.619514731528], "value": 4221.061730762265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.3925024478947, 731.265078596011, 792.7859477940956, 831.7795784117206, 833.8082241084554, 14492.0, 15158.166300853449, 15285.465008724697, 15353.923230383833, 15377.538673839788, 13238.53665121721, 13338.59984200473, 13384.732305353888, 13587.0, 13625.386857591408, 879.9868001979976, 896.3770179725094, 897.0804924951943, 897.9820403591924, 898.6001229452896, 832.2551316571664, 870.5386145342978, 878.6968495868947, 879.3624622148923, 879.5558243087232, 936.494293081735, 936.7751739582485, 938.7043081429362, 939.8590211468301, 942.3450701762278, 908.1599520443597, 919.4529255093208, 921.2445794448555, 921.9723408297762, 923.3951761596165, 668.6122049211446, 676.0, 702.4029574861378, 703.4513079797766, 707.1867352544564, 12289.877101229053, 12506.18709783861, 12508.81236781449, 12520.561780337735, 12540.122191446602, 11620.418979051014, 11804.940975295154, 12026.27842329463, 12134.27194368332, 12399.380030998504, 10375.636852710195, 10512.842307365396, 10658.733531661694, 10714.839277410845, 10943.124550035978, 3583.283343331344, 3665.871694490707, 3713.0, 3766.1714422826935, 3858.720087925269, 93238.06761932361, 93350.0, 96794.0, 98560.50719746355, 99140.50429747805, 8568.143185681507, 8623.78440538979, 8634.136586341316, 10388.844167337496, 10578.629747958785, 20078.799212007983, 20395.286164984154, 20412.0, 20413.183472660927, 20444.182232710824, 6898.482613803984, 7170.928290717026, 7285.708571657075, 7555.13115991657, 7830.177831327743, 4353.434053573079, 4367.956320436819, 4368.497622773358, 4456.442944631921, 4517.93828450314, 2878.2372671242138, 3323.8338083096232, 3424.229548351601, 3708.035910663247, 3864.265789499986, 694.1947341084419, 696.6342670098239, 709.836737550356, 712.2450202785064, 717.5909731453125, 594.4085634793322, 655.4788942790398, 681.1349586025818, 686.5125760709852, 690.7547820523743, 8973.685920992733, 9420.811583768285, 9553.832919801422, 9555.761105972268, 9671.323007389416, 627.4980015987284, 653.9182602174728, 666.8218951415142, 673.8820706376365, 705.5096707788141, 3810.980945095312, 4581.908361832745, 4582.816687332536, 4596.724196548151, 4649.930251046237, 113904.0, 113943.43028284972, 114259.0, 117586.0, 120729.39635301943, 79586.60206698929, 109315.0, 111520.0, 112564.0, 115271.0, 83978.0, 96338.51830740801, 98919.0, 99059.50470247603, 101350.0, 8738.737837864874, 8964.820703586021, 8982.146696063863, 8988.0, 8995.505247211466, 41726.79136604298, 46755.0, 60242.39757602368, 63543.99999999815, 64126.35873641204, 65524.67237663781, 79359.60320198363, 88067.11932880589, 89600.0, 91848.54075729579, 11554.48004839801, 11578.826317605075, 11655.18413711032, 11714.824277635671, 11808.232464889754, 12302.630921072383, 12381.690457738268, 12666.87333126657, 12795.360231988177, 12943.288119153536, 10708.73228169302, 11677.708057298636, 11793.115516336138, 11872.807762643748, 12278.75442491163, 11610.303381797119, 12095.697607559881, 12300.0, 12333.383330833243, 12722.554710585086, 11762.294262344287, 11923.224990375598, 12007.159498834997, 12112.636620901387, 12138.575149869712, 9514.524273786421, 10129.64546240878, 10144.594216231564, 10219.335743176669, 10293.330933489298, 9798.608055677692, 10508.264421490423, 10536.262461627612, 10539.314944528582, 10547.947260263649], "value": 7341.994195166569, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 93.0, 172.0, 177.0, 127.0, 160.0, 173.0, 166.0, 160.0, 116.0], "value": 149.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 100.0, 163.0, 150.0, 102.0, 133.0, 152.0, 171.0, 122.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 210.0, 246.0, 275.0, 220.0, 206.0, 253.0, 197.0, 195.0, 202.0], "value": 219.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 85.0, 58.0, 59.0, 60.0, 59.0, 79.0, 59.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 88.0, 70.0, 69.0, 69.0, 89.0, 88.0, 65.0, 93.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 89.0, 94.0, 79.0, 132.0, 89.0, 88.0, 120.0, 93.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 121.0, 109.0, 141.0, 97.0, 98.0, 99.0, 98.0, 96.0, 101.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 95.0, 131.0, 88.0, 86.0, 90.0, 94.0, 88.0, 85.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 59.0, 59.0, 60.0, 57.0, 60.0, 59.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 105.0, 117.0, 103.0, 75.0, 70.0, 70.0, 72.0, 71.0, 70.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 82.0, 85.0, 80.0, 84.0, 93.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 136.0, 141.0, 143.0, 143.0, 146.0, 140.0, 188.0, 131.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 170.0, 164.0, 167.0, 163.0, 203.0, 147.0, 226.0, 214.0, 235.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 68.0, 73.0, 82.0, 90.0, 62.0, 66.0, 68.0], "value": 70.8, "unit": "score"}]}]} 06:17:08 INFO - Return code: 0 06:17:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:17:08 ERROR - # TBPL SUCCESS # 06:17:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:17:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:17:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:17:08 INFO - 2017-01-24 06:17:08.160 screenresolution[2192:32651] starting screenresolution argv=screenresolution get 06:17:08 INFO - 2017-01-24 06:17:08.163 screenresolution[2192:32651] Display 0: 1600x1200x32@60 06:17:08 INFO - 2017-01-24 06:17:08.169 screenresolution[2193:32653] starting screenresolution argv=screenresolution list 06:17:08 INFO - Available Modes on Display 0 06:17:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:17:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:17:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:17:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:17:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:17:08 INFO - Intel Iris: 06:17:08 INFO - Chipset Model: Intel Iris 06:17:08 INFO - Type: GPU 06:17:08 INFO - Bus: Built-In 06:17:08 INFO - VRAM (Dynamic, Max): 1536 MB 06:17:08 INFO - Vendor: Intel (0x8086) 06:17:08 INFO - Device ID: 0x0a2e 06:17:08 INFO - Revision ID: 0x0009 06:17:08 INFO - Displays: 06:17:08 INFO - Display: 06:17:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:17:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:17:08 INFO - Display Serial Number: 1600x1200 60 06:17:08 INFO - Main Display: Yes 06:17:08 INFO - Mirror: Off 06:17:08 INFO - Online: Yes 06:17:08 INFO - Rotation: Supported 06:17:08 INFO - Return code: 0 06:17:08 INFO - Running post-action listener: _resource_record_post_action 06:17:08 INFO - [mozharness: 2017-01-24 14:17:08.408026Z] Finished run-tests step (success) 06:17:08 INFO - Running post-run listener: _resource_record_post_run 06:17:08 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1748992; Write bytes: 503642112; Read time: 18; Write time: 1757 06:17:08 INFO - TinderboxPrint: CPU usage
54.3% 06:17:08 INFO - TinderboxPrint: I/O read bytes / time
1,748,992 / 18 06:17:08 INFO - TinderboxPrint: I/O write bytes / time
503,642,112 / 1,757 06:17:08 INFO - TinderboxPrint: CPU idle
2,192.5 (45.7%) 06:17:08 INFO - TinderboxPrint: CPU system
971.2 (20.3%) 06:17:08 INFO - TinderboxPrint: CPU user
1,629.9 (34.0%) 06:17:08 INFO - TinderboxPrint: Swap in / out
192,847,872 / 0 06:17:08 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 182905344; Write bytes: 175456256; Read time: 16730; Write time: 346 06:17:08 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1748992; Write bytes: 311506944; Read time: 18; Write time: 1361 06:17:08 INFO - Running post-run listener: _upload_blobber_files 06:17:08 INFO - Blob upload gear active. 06:17:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:09 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:10 INFO - (blobuploader) - INFO - Done attempting. 06:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:11 INFO - (blobuploader) - INFO - Done attempting. 06:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:14 INFO - (blobuploader) - INFO - Done attempting. 06:17:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:14 INFO - Return code: 0 06:17:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b51de5dd2a83a9fd78a6c4db2528afc1ad3d7b0644f8d88d9b8e31c243e39c9eaecdcb3cde82e89e6fc38f30bd933b663ec646c0d69f8dec358e113d2cebae33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd3b999abd420f8b20924803baa15729d522958ea9d1e4c83475d956c2e7bd9c4b1ff33d445ca1a02da3b2a0c0a0f46efb36de6690100673d175c36be4933bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37c7e2b091e4e32642532bff74884fdf66e1022aed8f29956f9c8e7d0ef823636e0ca5f502813ba520ea1a926fbad6c3007a61b94dc92c7dfc4a52e0d6935f6c"} 06:17:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:14 INFO - Contents: 06:17:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b51de5dd2a83a9fd78a6c4db2528afc1ad3d7b0644f8d88d9b8e31c243e39c9eaecdcb3cde82e89e6fc38f30bd933b663ec646c0d69f8dec358e113d2cebae33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd3b999abd420f8b20924803baa15729d522958ea9d1e4c83475d956c2e7bd9c4b1ff33d445ca1a02da3b2a0c0a0f46efb36de6690100673d175c36be4933bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37c7e2b091e4e32642532bff74884fdf66e1022aed8f29956f9c8e7d0ef823636e0ca5f502813ba520ea1a926fbad6c3007a61b94dc92c7dfc4a52e0d6935f6c"} 06:17:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:14 INFO - Copying logs to upload dir... 06:17:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.391794 ========= master_lag: 3.60 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 06:17:17.801958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-01-24 06:17:17.806446) ========= 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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b51de5dd2a83a9fd78a6c4db2528afc1ad3d7b0644f8d88d9b8e31c243e39c9eaecdcb3cde82e89e6fc38f30bd933b663ec646c0d69f8dec358e113d2cebae33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd3b999abd420f8b20924803baa15729d522958ea9d1e4c83475d956c2e7bd9c4b1ff33d445ca1a02da3b2a0c0a0f46efb36de6690100673d175c36be4933bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37c7e2b091e4e32642532bff74884fdf66e1022aed8f29956f9c8e7d0ef823636e0ca5f502813ba520ea1a926fbad6c3007a61b94dc92c7dfc4a52e0d6935f6c"} build_url:https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/IlsQtwL4SD2z1lk57rpGlw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b51de5dd2a83a9fd78a6c4db2528afc1ad3d7b0644f8d88d9b8e31c243e39c9eaecdcb3cde82e89e6fc38f30bd933b663ec646c0d69f8dec358e113d2cebae33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd3b999abd420f8b20924803baa15729d522958ea9d1e4c83475d956c2e7bd9c4b1ff33d445ca1a02da3b2a0c0a0f46efb36de6690100673d175c36be4933bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37c7e2b091e4e32642532bff74884fdf66e1022aed8f29956f9c8e7d0ef823636e0ca5f502813ba520ea1a926fbad6c3007a61b94dc92c7dfc4a52e0d6935f6c"}' ========= master_lag: 2.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-01-24 06:17:20.138991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 06:17:20.139396) ========= 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.8Q42zp0P1t/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.6aT3YaqX1Z/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005336 ========= master_lag: 0.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 06:17:20.512147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 06:17:20.512488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 06:17:20.523496) ========= ========= Total master_lag: 7.20 =========