builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0090 starttime: 1475736457.73 results: success (0) buildid: 20161005205259 builduid: 95448df6f8c74b69ad01bf77d9260fac revision: ad3b71ecafeb0b0366750eb3a771224e05a194ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:37.729995) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:37.730403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:37.730677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:37.783080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-05 23:47:37.783397) ========= 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.mWdKhA7aRX/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.Azzz6JHaad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-05 23:47:37-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2016-10-05 23:47:37 (13.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141489 ========= master_lag: 4.86 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-05 23:47:42.780508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 23:47:42.780841) ========= 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.mWdKhA7aRX/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.Azzz6JHaad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.028913 ========= master_lag: 1.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 23:47:44.196628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 23:47:44.200001) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad3b71ecafeb0b0366750eb3a771224e05a194ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ad3b71ecafeb0b0366750eb3a771224e05a194ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mWdKhA7aRX/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.Azzz6JHaad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-05 23:47:44,609 truncating revision to first 12 chars 2016-10-05 23:47:44,609 Setting DEBUG logging. 2016-10-05 23:47:44,609 attempt 1/10 2016-10-05 23:47:44,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad3b71ecafeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 23:47:45,060 unpacking tar archive at: fx-team-ad3b71ecafeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723311 ========= master_lag: 0.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 23:47:45.280477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:45.280786) ========= script_repo_revision: ad3b71ecafeb0b0366750eb3a771224e05a194ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:45.281199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:45.281468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 23:47:45.303274) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-05 23:47:45.303659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mWdKhA7aRX/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.Azzz6JHaad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:47:45 INFO - MultiFileLogger online at 20161005 23:47:45 in /builds/slave/test 23:47:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:47:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:47:45 INFO - {'append_to_log': False, 23:47:45 INFO - 'base_work_dir': '/builds/slave/test', 23:47:45 INFO - 'blob_upload_branch': 'Fx-Team', 23:47:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:47:45 INFO - 'branch': 'Fx-Team', 23:47:45 INFO - 'buildbot_json_path': 'buildprops.json', 23:47:45 INFO - 'config_files': ('talos/mac_config.py',), 23:47:45 INFO - 'default_actions': ('clobber', 23:47:45 INFO - 'read-buildbot-config', 23:47:45 INFO - 'download-and-extract', 23:47:45 INFO - 'populate-webroot', 23:47:45 INFO - 'create-virtualenv', 23:47:45 INFO - 'install', 23:47:45 INFO - 'run-tests'), 23:47:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:47:45 INFO - 'download_minidump_stackwalk': True, 23:47:45 INFO - 'download_symbols': 'ondemand', 23:47:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:47:45 INFO - 'tooltool.py': '/tools/tooltool.py', 23:47:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:47:45 INFO - '/tools/misc-python/virtualenv.py')}, 23:47:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:47:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:47:45 INFO - 'installer_path': 'installer.exe', 23:47:45 INFO - 'log_level': 'info', 23:47:45 INFO - 'log_name': 'talos', 23:47:45 INFO - 'log_to_console': True, 23:47:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:47:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:47:45 INFO - 'opt_config_files': (), 23:47:45 INFO - 'pip_index': False, 23:47:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:47:45 INFO - 'cmd': ('bash', 23:47:45 INFO - '-c', 23:47:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:47:45 INFO - 'enabled': True, 23:47:45 INFO - 'halt_on_failure': False, 23:47:45 INFO - 'name': 'check_screen_resolution'},), 23:47:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:47:45 INFO - 'cmd': ('bash', 23:47:45 INFO - '-c', 23:47:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:47:45 INFO - 'enabled': True, 23:47:45 INFO - 'halt_on_failure': False, 23:47:45 INFO - 'name': 'check_screen_resolution'},), 23:47:45 INFO - 'run_cmd_checks_enabled': True, 23:47:45 INFO - 'sps_profile': False, 23:47:45 INFO - 'sps_profile_interval': 0, 23:47:45 INFO - 'suite': 'dromaeojs-e10s', 23:47:45 INFO - 'system_bits': '32', 23:47:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:47:45 INFO - 'title': 't-yosemite-r7-0090', 23:47:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:47:45 INFO - 'use_talos_json': True, 23:47:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:47:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:47:45 INFO - 'work_dir': 'build'} 23:47:45 INFO - [mozharness: 2016-10-06 06:47:45.508098Z] Running clobber step. 23:47:45 INFO - Running pre-action listener: _resource_record_pre_action 23:47:45 INFO - Running main action method: clobber 23:47:45 INFO - rmtree: /builds/slave/test/build 23:47:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:47:48 INFO - Running post-action listener: _resource_record_post_action 23:47:48 INFO - [mozharness: 2016-10-06 06:47:48.132580Z] Finished clobber step (success) 23:47:48 INFO - [mozharness: 2016-10-06 06:47:48.132723Z] Running read-buildbot-config step. 23:47:48 INFO - Running pre-action listener: _resource_record_pre_action 23:47:48 INFO - Running main action method: read_buildbot_config 23:47:48 INFO - Using buildbot properties: 23:47:48 INFO - { 23:47:48 INFO - "project": "", 23:47:48 INFO - "product": "firefox", 23:47:48 INFO - "script_repo_revision": "production", 23:47:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:47:48 INFO - "repository": "", 23:47:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:47:48 INFO - "buildid": "20161005205259", 23:47:48 INFO - "pgo_build": "False", 23:47:48 INFO - "basedir": "/builds/slave/test", 23:47:48 INFO - "buildnumber": 35, 23:47:48 INFO - "slavename": "t-yosemite-r7-0090", 23:47:48 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 23:47:48 INFO - "platform": "yosemite_r7", 23:47:48 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 23:47:48 INFO - "branch": "fx-team", 23:47:48 INFO - "repo_path": "integration/fx-team", 23:47:48 INFO - "revision": "ad3b71ecafeb0b0366750eb3a771224e05a194ee", 23:47:48 INFO - "stage_platform": "macosx64", 23:47:48 INFO - "builduid": "95448df6f8c74b69ad01bf77d9260fac", 23:47:48 INFO - "slavebuilddir": "test" 23:47:48 INFO - } 23:47:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 23:47:48 INFO - Running post-action listener: _resource_record_post_action 23:47:48 INFO - [mozharness: 2016-10-06 06:47:48.136052Z] Finished read-buildbot-config step (success) 23:47:48 INFO - [mozharness: 2016-10-06 06:47:48.136156Z] Running download-and-extract step. 23:47:48 INFO - Running pre-action listener: _resource_record_pre_action 23:47:48 INFO - Running main action method: download_and_extract 23:47:48 INFO - mkdir: /builds/slave/test/build/tests 23:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:47:48 INFO - trying https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 23:47:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 23:47:49 INFO - Downloaded 1199 bytes. 23:47:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:47:49 INFO - Using the following test package requirements: 23:47:49 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:47:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 23:47:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 23:47:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'jsshell-mac.zip'], 23:47:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 23:47:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:47:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 23:47:49 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 23:47:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 23:47:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:47:49 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 23:47:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:47:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:47:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:47:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:47:50 INFO - Http code: 200 23:47:50 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 23:47:50 INFO - x-amz-cf-id: uEA8H2sES3wqs1u_cvZRKZOyQNfrViEzHmfhu9SI-mYAVf3Y7uDGGw== 23:47:50 INFO - x-amz-version-id: 78Q1lo3t8BujKL9fGubSZv0odVkGhr5J 23:47:50 INFO - Expected file size: 16477060 23:47:50 INFO - Obtained file size: 16477060 23:47:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:47:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:47:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:47:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:47:57 INFO - Http code: 200 23:47:57 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 23:47:57 INFO - x-amz-cf-id: tVlKs22iy2znC1d9t7qO4Rv3qMwSABSkpLYXPIjBpebOZXWTEllKKQ== 23:47:57 INFO - x-amz-version-id: 78Q1lo3t8BujKL9fGubSZv0odVkGhr5J 23:47:57 INFO - Expected file size: 16477060 23:47:57 INFO - Obtained file size: 16477060 23:48:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 23:48:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:48:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 23:48:04 INFO - Http code: 200 23:48:04 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 23:48:04 INFO - x-amz-cf-id: Ue02JMnPA3n4H88hGqEsWAATD7V7Aw-4WSYYZDgz4kSR-nb_O-CC2w== 23:48:04 INFO - x-amz-version-id: lWSAZYQgzO8VyVuQpAIzkpCi_TofhDVr 23:48:05 INFO - Expected file size: 14409006 23:48:05 INFO - Obtained file size: 14409006 23:48:05 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')]} 23:48:05 INFO - trying https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:48:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 23:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 23:48:08 INFO - Downloaded 111661292 bytes. 23:48:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:48:08 INFO - mkdir: /builds/slave/test/properties 23:48:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:48:08 INFO - Writing to file /builds/slave/test/properties/build_url 23:48:08 INFO - Contents: 23:48:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:48:08 INFO - Running post-action listener: _resource_record_post_action 23:48:08 INFO - Running post-action listener: set_extra_try_arguments 23:48:08 INFO - [mozharness: 2016-10-06 06:48:08.965027Z] Finished download-and-extract step (success) 23:48:08 INFO - [mozharness: 2016-10-06 06:48:08.965132Z] Running populate-webroot step. 23:48:08 INFO - Running pre-action listener: _resource_record_pre_action 23:48:08 INFO - Running main action method: populate_webroot 23:48:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:48:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:48:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:48:08 INFO - '--tppagecycles', 23:48:08 INFO - '7'], 23:48:08 INFO - 'tests': ['tsvgm']}}, 23:48:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:48:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:48:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:48:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:48:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:48:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:48:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['damp', 'tps']}, 23:48:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'tests': ['damp', 'tps']}, 23:48:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['dromaeo_dom']}, 23:48:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:48:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['basic_compositor_video']}, 23:48:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:48:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['a11yr', 23:48:08 INFO - 'ts_paint', 23:48:08 INFO - 'tpaint', 23:48:08 INFO - 'sessionrestore', 23:48:08 INFO - 'sessionrestore_no_auto_restore', 23:48:08 INFO - 'tabpaint']}, 23:48:08 INFO - 'other-e10s': {'tests': ['a11yr', 23:48:08 INFO - 'ts_paint', 23:48:08 INFO - 'tpaint', 23:48:08 INFO - 'sessionrestore', 23:48:08 INFO - 'sessionrestore_no_auto_restore', 23:48:08 INFO - 'tabpaint']}, 23:48:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:48:08 INFO - 'ts_paint', 23:48:08 INFO - 'tpaint', 23:48:08 INFO - 'sessionrestore', 23:48:08 INFO - 'sessionrestore_no_auto_restore', 23:48:08 INFO - 'tabpaint']}, 23:48:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:48:08 INFO - 'ts_paint', 23:48:08 INFO - 'tpaint', 23:48:08 INFO - 'sessionrestore', 23:48:08 INFO - 'sessionrestore_no_auto_restore', 23:48:08 INFO - 'tabpaint']}, 23:48:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['a11yr', 23:48:08 INFO - 'ts_paint', 23:48:08 INFO - 'tpaint', 23:48:08 INFO - 'sessionrestore', 23:48:08 INFO - 'sessionrestore_no_auto_restore', 23:48:08 INFO - 'tabpaint']}, 23:48:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['a11yr', 23:48:08 INFO - 'ts_paint', 23:48:08 INFO - 'tpaint', 23:48:08 INFO - 'sessionrestore', 23:48:08 INFO - 'sessionrestore_no_auto_restore', 23:48:08 INFO - 'tabpaint']}, 23:48:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['tsvgx', 23:48:08 INFO - 'tsvgr_opacity', 23:48:08 INFO - 'tart', 23:48:08 INFO - 'tscrollx', 23:48:08 INFO - 'cart']}, 23:48:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:48:08 INFO - 'tsvgr_opacity', 23:48:08 INFO - 'tart', 23:48:08 INFO - 'tscrollx', 23:48:08 INFO - 'cart']}, 23:48:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'talos_options': ['--disable-e10s'], 23:48:08 INFO - 'tests': ['tp5o']}, 23:48:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'tests': ['tp5o']}, 23:48:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'talos_options': ['--disable-e10s', 23:48:08 INFO - '--xperf_path', 23:48:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:48:08 INFO - 'tests': ['tp5n']}, 23:48:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:08 INFO - 'talos_options': ['--xperf_path', 23:48:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:48:08 INFO - 'tests': ['tp5n']}}, 23:48:08 INFO - 'talos.zip': {'path': '', 23:48:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:48:08 INFO - Running post-action listener: _resource_record_post_action 23:48:08 INFO - [mozharness: 2016-10-06 06:48:08.983273Z] Finished populate-webroot step (success) 23:48:08 INFO - [mozharness: 2016-10-06 06:48:08.983406Z] Running create-virtualenv step. 23:48:08 INFO - Running pre-action listener: _resource_record_pre_action 23:48:08 INFO - Running main action method: create_virtualenv 23:48:08 INFO - Creating virtualenv /builds/slave/test/build/venv 23:48:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:48:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:48:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:48:09 INFO - Using real prefix '/tools/python27' 23:48:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:48:09 INFO - Installing distribute.............................................................................................................................................................................................done. 23:48:12 INFO - Installing pip.................done. 23:48:12 INFO - Return code: 0 23:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:48:12 INFO - Reading from file tmpfile_stdout 23:48:12 INFO - Output received: 23:48:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:48:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:13 INFO - 'HOME': '/Users/cltbld', 23:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:13 INFO - 'LOGNAME': 'cltbld', 23:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:13 INFO - 'MOZ_NO_REMOTE': '1', 23:48:13 INFO - 'NO_EM_RESTART': '1', 23:48:13 INFO - 'PAGER': '/bin/cat', 23:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:13 INFO - 'PWD': '/builds/slave/test', 23:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:13 INFO - 'SHELL': '/bin/bash', 23:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:13 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:13 INFO - 'USER': 'cltbld', 23:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:13 INFO - 'XPC_FLAGS': '0x0', 23:48:13 INFO - 'XPC_SERVICE_NAME': '0', 23:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:13 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 23:48:13 INFO - Cleaning up... 23:48:13 INFO - Return code: 0 23:48:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:14 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:14 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 23:48:14 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 23:48:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:14 INFO - 'HOME': '/Users/cltbld', 23:48:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:14 INFO - 'LOGNAME': 'cltbld', 23:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:14 INFO - 'MOZ_NO_REMOTE': '1', 23:48:14 INFO - 'NO_EM_RESTART': '1', 23:48:14 INFO - 'PAGER': '/bin/cat', 23:48:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:14 INFO - 'PWD': '/builds/slave/test', 23:48:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:14 INFO - 'SHELL': '/bin/bash', 23:48:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:14 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:14 INFO - 'USER': 'cltbld', 23:48:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:14 INFO - 'XPC_FLAGS': '0x0', 23:48:14 INFO - 'XPC_SERVICE_NAME': '0', 23:48:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:14 INFO - Downloading/unpacking psutil>=3.1.1 23:48:14 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 23:48:14 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 23:48:14 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 23:48:14 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 23:48:14 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 23:48:14 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 23:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:48:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:48:18 INFO - Installing collected packages: psutil 23:48:18 INFO - Running setup.py install for psutil 23:48:18 INFO - building 'psutil._psutil_osx' extension 23:48:18 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 23:48:19 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 23:48:19 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 23:48:19 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 23:48:19 INFO - building 'psutil._psutil_posix' extension 23:48:19 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 23:48:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:48:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:48:19 INFO - ^ 23:48:19 INFO - 1 warning generated. 23:48:19 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 23:48:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:48:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:48:19 INFO - Successfully installed psutil 23:48:19 INFO - Cleaning up... 23:48:19 INFO - Return code: 0 23:48:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:19 INFO - 'HOME': '/Users/cltbld', 23:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:19 INFO - 'LOGNAME': 'cltbld', 23:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:19 INFO - 'MOZ_NO_REMOTE': '1', 23:48:19 INFO - 'NO_EM_RESTART': '1', 23:48:19 INFO - 'PAGER': '/bin/cat', 23:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:19 INFO - 'PWD': '/builds/slave/test', 23:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:19 INFO - 'SHELL': '/bin/bash', 23:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:19 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:19 INFO - 'USER': 'cltbld', 23:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:19 INFO - 'XPC_FLAGS': '0x0', 23:48:19 INFO - 'XPC_SERVICE_NAME': '0', 23:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:48:19 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 23:48:19 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 23:48:19 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 23:48:19 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 23:48:19 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 23:48:19 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 23:48:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:48:22 INFO - Installing collected packages: mozsystemmonitor 23:48:22 INFO - Running setup.py install for mozsystemmonitor 23:48:22 INFO - Successfully installed mozsystemmonitor 23:48:22 INFO - Cleaning up... 23:48:22 INFO - Return code: 0 23:48:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:22 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:22 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 23:48:22 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 23:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:22 INFO - 'HOME': '/Users/cltbld', 23:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:22 INFO - 'LOGNAME': 'cltbld', 23:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:22 INFO - 'MOZ_NO_REMOTE': '1', 23:48:22 INFO - 'NO_EM_RESTART': '1', 23:48:22 INFO - 'PAGER': '/bin/cat', 23:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:22 INFO - 'PWD': '/builds/slave/test', 23:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:22 INFO - 'SHELL': '/bin/bash', 23:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:22 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:22 INFO - 'USER': 'cltbld', 23:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:22 INFO - 'XPC_FLAGS': '0x0', 23:48:22 INFO - 'XPC_SERVICE_NAME': '0', 23:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:23 INFO - Downloading/unpacking jsonschema==2.5.1 23:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:48:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:48:25 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 23:48:25 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 23:48:25 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 23:48:25 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 23:48:25 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 23:48:25 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 23:48:25 INFO - Downloading functools32-3.2.3-2.tar.gz 23:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:48:25 INFO - warning: no files found matching '*.txt' 23:48:25 INFO - no previously-included directories found matching 'build' 23:48:25 INFO - no previously-included directories found matching 'dist' 23:48:25 INFO - no previously-included directories found matching '.git*' 23:48:25 INFO - Installing collected packages: jsonschema, functools32 23:48:25 INFO - Running setup.py install for functools32 23:48:26 INFO - warning: no files found matching '*.txt' 23:48:26 INFO - no previously-included directories found matching 'build' 23:48:26 INFO - no previously-included directories found matching 'dist' 23:48:26 INFO - no previously-included directories found matching '.git*' 23:48:26 INFO - Successfully installed jsonschema functools32 23:48:26 INFO - Cleaning up... 23:48:26 INFO - Return code: 0 23:48:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:26 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:26 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 23:48:26 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 23:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:26 INFO - 'HOME': '/Users/cltbld', 23:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:26 INFO - 'LOGNAME': 'cltbld', 23:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:26 INFO - 'MOZ_NO_REMOTE': '1', 23:48:26 INFO - 'NO_EM_RESTART': '1', 23:48:26 INFO - 'PAGER': '/bin/cat', 23:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:26 INFO - 'PWD': '/builds/slave/test', 23:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:26 INFO - 'SHELL': '/bin/bash', 23:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:26 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:26 INFO - 'USER': 'cltbld', 23:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:26 INFO - 'XPC_FLAGS': '0x0', 23:48:26 INFO - 'XPC_SERVICE_NAME': '0', 23:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:48:26 INFO - Cleaning up... 23:48:26 INFO - Return code: 0 23:48:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:26 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:26 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 23:48:26 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 23:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:26 INFO - 'HOME': '/Users/cltbld', 23:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:26 INFO - 'LOGNAME': 'cltbld', 23:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:26 INFO - 'MOZ_NO_REMOTE': '1', 23:48:26 INFO - 'NO_EM_RESTART': '1', 23:48:26 INFO - 'PAGER': '/bin/cat', 23:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:26 INFO - 'PWD': '/builds/slave/test', 23:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:26 INFO - 'SHELL': '/bin/bash', 23:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:26 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:26 INFO - 'USER': 'cltbld', 23:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:26 INFO - 'XPC_FLAGS': '0x0', 23:48:26 INFO - 'XPC_SERVICE_NAME': '0', 23:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:26 INFO - Downloading/unpacking blobuploader==1.2.4 23:48:26 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 23:48:26 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 23:48:26 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 23:48:26 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 23:48:26 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 23:48:26 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 23:48:29 INFO - Downloading blobuploader-1.2.4.tar.gz 23:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:48:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:48:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:30 INFO - Downloading docopt-0.6.1.tar.gz 23:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:48:30 INFO - Installing collected packages: blobuploader, requests, docopt 23:48:30 INFO - Running setup.py install for blobuploader 23:48:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:48:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:48:30 INFO - Running setup.py install for requests 23:48:31 INFO - Running setup.py install for docopt 23:48:31 INFO - Successfully installed blobuploader requests docopt 23:48:31 INFO - Cleaning up... 23:48:31 INFO - Return code: 0 23:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:31 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:31 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 23:48:31 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 23:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:31 INFO - 'HOME': '/Users/cltbld', 23:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:31 INFO - 'LOGNAME': 'cltbld', 23:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:31 INFO - 'MOZ_NO_REMOTE': '1', 23:48:31 INFO - 'NO_EM_RESTART': '1', 23:48:31 INFO - 'PAGER': '/bin/cat', 23:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:31 INFO - 'PWD': '/builds/slave/test', 23:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:31 INFO - 'SHELL': '/bin/bash', 23:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:31 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:31 INFO - 'USER': 'cltbld', 23:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:31 INFO - 'XPC_FLAGS': '0x0', 23:48:31 INFO - 'XPC_SERVICE_NAME': '0', 23:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:48:31 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-m3tvyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:48:31 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-S8GaOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:48:31 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3xlYby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:48:31 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-mMAzZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jRiJBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-huv_lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-qhI4lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-eek_8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-uZekCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-CjT3no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-pqq4Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-cOm4VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-4VOtgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:48:32 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-30w9Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:33 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-GbPXgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:48:33 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hlsKjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:48:33 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-C74jef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:48:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:48:33 INFO - Running setup.py install for manifestparser 23:48:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:48:33 INFO - Running setup.py install for mozcrash 23:48:33 INFO - Running setup.py install for mozdebug 23:48:33 INFO - Running setup.py install for mozdevice 23:48:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:48:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:48:33 INFO - Running setup.py install for mozfile 23:48:34 INFO - Running setup.py install for mozhttpd 23:48:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Running setup.py install for mozinfo 23:48:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Running setup.py install for mozInstall 23:48:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Running setup.py install for mozleak 23:48:34 INFO - Running setup.py install for mozlog 23:48:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:48:34 INFO - Running setup.py install for moznetwork 23:48:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:48:35 INFO - Running setup.py install for mozprocess 23:48:35 INFO - Running setup.py install for mozprofile 23:48:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:48:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:48:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:48:35 INFO - Running setup.py install for mozrunner 23:48:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:48:35 INFO - Running setup.py install for mozscreenshot 23:48:35 INFO - Running setup.py install for moztest 23:48:35 INFO - Running setup.py install for mozversion 23:48:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:48:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:48:35 INFO - Cleaning up... 23:48:35 INFO - Return code: 0 23:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48:35 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')]} 23:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:35 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')]} 23:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:35 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:35 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 23:48:35 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 23:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:35 INFO - 'HOME': '/Users/cltbld', 23:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:35 INFO - 'LOGNAME': 'cltbld', 23:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:35 INFO - 'MOZ_NO_REMOTE': '1', 23:48:35 INFO - 'NO_EM_RESTART': '1', 23:48:35 INFO - 'PAGER': '/bin/cat', 23:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:35 INFO - 'PWD': '/builds/slave/test', 23:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:35 INFO - 'SHELL': '/bin/bash', 23:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:35 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:35 INFO - 'USER': 'cltbld', 23:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:35 INFO - 'XPC_FLAGS': '0x0', 23:48:35 INFO - 'XPC_SERVICE_NAME': '0', 23:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jaCdD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:48:36 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-1XNRcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-7QgctL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:48:36 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-SBGS7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:48:36 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Jdpmu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:48:36 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-FLQ3yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:48:36 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-yv_VyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:48:36 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)) 23:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:48:36 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Ze5z7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-igCvjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-V9I1tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-UQ6QxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-KH2py_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-7TOB6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-_V1l0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-b0cmWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:37 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)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-meDO_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:48:37 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Dn5tzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:48:38 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)) 23:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:48:38 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)) 23:48:38 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)) 23:48:38 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)) 23:48:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:48:38 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 23:48:38 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 23:48:38 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 23:48:38 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 23:48:38 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 23:48:38 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 23:48:40 INFO - Downloading blessings-1.6.tar.gz 23:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:48:40 INFO - Installing collected packages: blessings 23:48:40 INFO - Running setup.py install for blessings 23:48:40 INFO - Successfully installed blessings 23:48:40 INFO - Cleaning up... 23:48:40 INFO - Return code: 0 23:48:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:48:41 INFO - Reading from file tmpfile_stdout 23:48:41 INFO - Current package versions: 23:48:41 INFO - blessings == 1.6 23:48:41 INFO - blobuploader == 1.2.4 23:48:41 INFO - docopt == 0.6.1 23:48:41 INFO - functools32 == 3.2.3-2 23:48:41 INFO - jsonschema == 2.5.1 23:48:41 INFO - manifestparser == 1.1 23:48:41 INFO - mozInstall == 1.12 23:48:41 INFO - mozcrash == 0.17 23:48:41 INFO - mozdebug == 0.1 23:48:41 INFO - mozdevice == 0.48 23:48:41 INFO - mozfile == 1.2 23:48:41 INFO - mozhttpd == 0.7 23:48:41 INFO - mozinfo == 0.9 23:48:41 INFO - mozleak == 0.1 23:48:41 INFO - mozlog == 3.4 23:48:41 INFO - moznetwork == 0.27 23:48:41 INFO - mozprocess == 0.23 23:48:41 INFO - mozprofile == 0.28 23:48:41 INFO - mozrunner == 6.12 23:48:41 INFO - mozscreenshot == 0.1 23:48:41 INFO - mozsystemmonitor == 0.3 23:48:41 INFO - moztest == 0.7 23:48:41 INFO - mozversion == 1.4 23:48:41 INFO - psutil == 3.1.1 23:48:41 INFO - requests == 1.2.3 23:48:41 INFO - wsgiref == 0.1.2 23:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:41 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:41 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 23:48:41 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 23:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:41 INFO - 'HOME': '/Users/cltbld', 23:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:41 INFO - 'LOGNAME': 'cltbld', 23:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:41 INFO - 'MOZ_NO_REMOTE': '1', 23:48:41 INFO - 'NO_EM_RESTART': '1', 23:48:41 INFO - 'PAGER': '/bin/cat', 23:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:41 INFO - 'PWD': '/builds/slave/test', 23:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:41 INFO - 'SHELL': '/bin/bash', 23:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:41 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:41 INFO - 'USER': 'cltbld', 23:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:41 INFO - 'XPC_FLAGS': '0x0', 23:48:41 INFO - 'XPC_SERVICE_NAME': '0', 23:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 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)) 23:48:41 INFO - Cleaning up... 23:48:41 INFO - Return code: 0 23:48:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:41 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 0x109a1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1d72cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, '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.mWdKhA7aRX/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.Azzz6JHaad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 23:48:41 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 23:48:41 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 23:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:41 INFO - 'HOME': '/Users/cltbld', 23:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:41 INFO - 'LOGNAME': 'cltbld', 23:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:41 INFO - 'MOZ_NO_REMOTE': '1', 23:48:41 INFO - 'NO_EM_RESTART': '1', 23:48:41 INFO - 'PAGER': '/bin/cat', 23:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:41 INFO - 'PWD': '/builds/slave/test', 23:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:41 INFO - 'SHELL': '/bin/bash', 23:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:48:41 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:41 INFO - 'USER': 'cltbld', 23:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:41 INFO - 'XPC_FLAGS': '0x0', 23:48:41 INFO - 'XPC_SERVICE_NAME': '0', 23:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:48:41 INFO - Cleaning up... 23:48:41 INFO - Return code: 0 23:48:41 INFO - Running post-action listener: _resource_record_post_action 23:48:41 INFO - Running post-action listener: _start_resource_monitoring 23:48:41 INFO - Starting resource monitoring. 23:48:41 INFO - [mozharness: 2016-10-06 06:48:41.644624Z] Finished create-virtualenv step (success) 23:48:41 INFO - [mozharness: 2016-10-06 06:48:41.645449Z] Running install step. 23:48:41 INFO - Running pre-action listener: _resource_record_pre_action 23:48:41 INFO - Running main action method: install 23:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:48:41 INFO - Reading from file tmpfile_stdout 23:48:41 INFO - Detecting whether we're running mozinstall >=1.0... 23:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:48:42 INFO - Reading from file tmpfile_stdout 23:48:42 INFO - Output received: 23:48:42 INFO - Usage: mozinstall [options] installer 23:48:42 INFO - Options: 23:48:42 INFO - -h, --help show this help message and exit 23:48:42 INFO - -d DEST, --destination=DEST 23:48:42 INFO - Directory to install application into. [default: 23:48:42 INFO - "/builds/slave/test"] 23:48:42 INFO - --app=APP Application being installed. [default: firefox] 23:48:42 INFO - mkdir: /builds/slave/test/build/application 23:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:49:16 INFO - Reading from file tmpfile_stdout 23:49:16 INFO - Output received: 23:49:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:49:16 INFO - Running post-action listener: _resource_record_post_action 23:49:16 INFO - [mozharness: 2016-10-06 06:49:16.795377Z] Finished install step (success) 23:49:16 INFO - [mozharness: 2016-10-06 06:49:16.795555Z] Running run-tests step. 23:49:16 INFO - Running pre-action listener: _resource_record_pre_action 23:49:16 INFO - Running main action method: run_tests 23:49:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:49:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:49:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:49:16 INFO - 2016-10-05 23:49:16.810 screenresolution[1638:7833] starting screenresolution argv=screenresolution get 23:49:16 INFO - 2016-10-05 23:49:16.812 screenresolution[1638:7833] Display 0: 1600x1200x32@60 23:49:16 INFO - 2016-10-05 23:49:16.818 screenresolution[1639:7835] starting screenresolution argv=screenresolution list 23:49:16 INFO - Available Modes on Display 0 23:49:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:49:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:49:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:49:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:49:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:49:17 INFO - Intel Iris: 23:49:17 INFO - Chipset Model: Intel Iris 23:49:17 INFO - Type: GPU 23:49:17 INFO - Bus: Built-In 23:49:17 INFO - VRAM (Dynamic, Max): 1536 MB 23:49:17 INFO - Vendor: Intel (0x8086) 23:49:17 INFO - Device ID: 0x0a2e 23:49:17 INFO - Revision ID: 0x0009 23:49:17 INFO - Displays: 23:49:17 INFO - Display: 23:49:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:49:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:49:17 INFO - Display Serial Number: 1600x1200 60 23:49:17 INFO - Main Display: Yes 23:49:17 INFO - Mirror: Off 23:49:17 INFO - Online: Yes 23:49:17 INFO - Rotation: Supported 23:49:17 INFO - Return code: 0 23:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:49:17 INFO - Python 2.7.3 23:49:17 INFO - Return code: 0 23:49:17 INFO - grabbing minidump binary from tooltool 23:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:49:17 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 0x109830d30>, '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 0x109656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109828b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:49:17 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 23:49:17 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 23:49:17 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 23:49:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:49:17 INFO - Return code: 0 23:49:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:49:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:49:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:49:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:49:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 23:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 23:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mWdKhA7aRX/Render', 23:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:49:17 INFO - 'HOME': '/Users/cltbld', 23:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:49:17 INFO - 'LOGNAME': 'cltbld', 23:49:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:49:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:17 INFO - 'MOZ_NO_REMOTE': '1', 23:49:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:49:17 INFO - 'NO_EM_RESTART': '1', 23:49:17 INFO - 'PAGER': '/bin/cat', 23:49:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:17 INFO - 'PWD': '/builds/slave/test', 23:49:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:49:17 INFO - 'SHELL': '/bin/bash', 23:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Azzz6JHaad/Listeners', 23:49:17 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 23:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:49:17 INFO - 'USER': 'cltbld', 23:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:17 INFO - 'XPC_FLAGS': '0x0', 23:49:17 INFO - 'XPC_SERVICE_NAME': '0', 23:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:49:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 23:49:17 INFO - mozversion application_buildid: 20161005205259 23:49:17 INFO - mozversion application_changeset: ad3b71ecafeb0b0366750eb3a771224e05a194ee 23:49:17 INFO - mozversion application_display_name: Nightly 23:49:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:49:17 INFO - mozversion application_name: Firefox 23:49:17 INFO - mozversion application_remotingname: firefox 23:49:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:49:17 INFO - mozversion application_vendor: Mozilla 23:49:17 INFO - mozversion application_version: 52.0a1 23:49:17 INFO - mozversion platform_buildid: 20161005205259 23:49:17 INFO - mozversion platform_changeset: ad3b71ecafeb0b0366750eb3a771224e05a194ee 23:49:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:49:17 INFO - mozversion platform_version: 52.0a1 23:49:17 INFO - using testdate: 1475736557 23:49:17 INFO - actual date: 1475736557 23:49:17 INFO - starting webserver on 'localhost:49277' 23:49:17 INFO - SUITE-START | Running 2 tests 23:49:17 INFO - TEST-START | dromaeo_css 23:49:17 INFO - operating with platform_type : mac_ 23:49:17 INFO - Initialising browser for dromaeo_css test... 23:49:17 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpqrMh0b/profile http://localhost:49277/getInfo.html) 23:49:20 INFO - PROCESS | 1649 | 2016-10-05 23:49:20.302 plugin-container[1651:8005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 23:49:20 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:20 INFO - PROCESS | 1649 | 2016-10-05 23:49:20.304 plugin-container[1651:8005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 23:49:20 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:20 INFO - PROCESS | 1649 | 2016-10-05 23:49:20.305 plugin-container[1651:8005] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:49:20 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 23:49:20 INFO - PROCESS | 1649 | colorDepth:24 23:49:20 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 23:49:20 INFO - PROCESS | 1649 | __metrics 23:49:20 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:49:21 INFO - TEST-INFO | 1649: exit 0 23:49:21 INFO - Browser initialized. 23:49:21 INFO - Running cycle 1/1 for dromaeo_css test... 23:49:21 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpqrMh0b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:23 INFO - PROCESS | 1652 | 2016-10-05 23:49:23.812 plugin-container[1653:8128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.tsm.portname' 23:49:23 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:23 INFO - PROCESS | 1652 | 2016-10-05 23:49:23.815 plugin-container[1653:8128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 23:49:23 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:23 INFO - PROCESS | 1652 | 2016-10-05 23:49:23.815 plugin-container[1653:8128] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:49:33 INFO - PROCESS | 1652 | RSS: Main: 239792128 23:49:33 INFO - PROCESS | 1652 | 23:50:23 INFO - PROCESS | 1652 | 1475736623082 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:52:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 23:52:38 INFO - PROCESS | 1652 | RSS: Main: 253562880 23:52:38 INFO - PROCESS | 1652 | 23:55:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 23:55:41 INFO - PROCESS | 1652 | RSS: Main: 265416704 23:55:41 INFO - PROCESS | 1652 | 23:58:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 23:58:43 INFO - PROCESS | 1652 | RSS: Main: 269824000 23:58:43 INFO - PROCESS | 1652 | 00:01:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 00:01:45 INFO - PROCESS | 1652 | RSS: Main: 272883712 00:01:45 INFO - PROCESS | 1652 | 00:04:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 00:04:49 INFO - PROCESS | 1652 | RSS: Main: 279289856 00:04:49 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 00:07:52 INFO - PROCESS | 1652 | RSS: Main: 278708224 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | __start_tp_report 00:07:52 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 00:07:52 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 00:07:52 INFO - PROCESS | 1652 | |i|pagename|runs| 00:07:52 INFO - PROCESS | 1652 | |0;dojo.html;3319.369319829232;3349.3636209120264;3362.8991130266095;3375.054984604312;3398.3882901077795;5002.449730529639;5213.921791173136;5544.63959842611;5591.580631452647;5637.718114094294;4437.711548749337;5560.388357280696;5632.718364081789;5699.74351154198;5707.086866101425;4965.428975667808;5018.247262910556;5073.061483625541;5100.183970564711;5114.565261952738;4941.827036053739;5084.491550844923;5125.948740512585;5150.922736158961;5168.689878607277;5053.5957123430035;5100.617453690951;5194.142966410575;5246.213068039787;5267.209918512215;5095.745212739385;5122.615803814691;5145.665531740425;5185.637005409585;5222.50386213313;5061.2661164131;5105.897882042338;5111.463296353866;5119.0273847968765;5128.153854613985;5405.216243644689;5437.864053398657;5628.04323265046;5628.605997580171;5639.68981706006;6018.909716354258;6047.820674968383;6126.54820943507;6132.967444181115;6172.197614310111;6181.381861813783;6188.535859810532;6197.938020619781;6198.690065496708;6221.035739460345;5787.07406814916;5799.33307669615;5803.941960580382;5805.448482394166;5818.3308919474375;4506.850753058015;4990.525900039491;5978.491828194565;6084.606322208845;6116.33577150815;5113.488651134931;6002.0996850472775;6035.66803825785;6069.635821850703;6115.296740874767;5112.616553758483;6083.6349819011;6171.907421388682;6193.84515387119;6207.81376558704;6015.1278064681255;6062.818115456544;6067.7269522871575;6092.5430592705725;6095.969520152371;4961.454240033593;6096.0855871619615;6131.468419844996;6134.04922237054;6163.630182189083;4500.167469018242;4935.925961110514;4942.851714448572;4950;4998.150314446553;3757.248550289953;4305.418768466279;4305.945043464371;4393.846215382447;4409;5703.372629010805;5782.826515204551;5786.768529258782;5794.710264486843;5864.530837532987;5220.347456567929;5979.850503737354;6188.2883468400805;6225.968870155711;6229;4737.502562230916;5570.637908535932;5617.915731264035;5650.378458369576;5671.064274394761;5352.4915133062295;5360.839174824761;5361.169018802092;5371.597130215171;5375.0324941510125;6177.62934223948;6199.380061993765;6218.751249950133;6313.684315784284;6314.905276420765;6181.783637572664;6204.875902482016;6212.81361559154;6216.751329946932;6226;6102.398363691488;6243.531735119975;6299.338569450142;6304.275008374096;6340.4927605792345;6033.245844269466;6118.082287656709;6136.662483563447;6140.662263575367;6145;6125.784909797739;6138.754449821957;6145.231846019247;6146.801373732079;6159.6612186330185;6083.057126145454;6084.69576521181;6086.352357320099;6096.829073522031;6123.877522449615;5342.465753424626;6041.18444010053;6049.3950604939155;6093.451589356801;6097.695115244309;5678;5716.942830571641;5763.193152958673;5777.39337369587;5865.178874957424;6045.939540604538;6052.485538729081;6068.757249710139;6078.3921607838865;6090.482309003784;5911.822645320647;5914.378990205966;5940.524758019435;5959.851003724942;5979.312379076462 00:07:52 INFO - PROCESS | 1652 | |1;ext.html;515.9303494028306;529.4863981937522;537.1968906484806;540.2166858055817;562.454419213363;38876;40414.98962525938;40449;40455.393169102485;40515;41867;41900.58099419005;42362.940926476775;42382.788086059525;42478.362824557655;9781;9955.800883982316;9963.202943764518;9971.950140249288;10000.099991000809;9795.95102024489;9888.802223955516;9910.801783964316;9911.058449447291;9916.851247231298;8450.57747112645;9911.653092141776;9915.702528924108;9927.553260103312;9932.006799320083;7915.4063445241545;8939.748435219075;9088.136627020422;9845.261605379625;9896.752581185456;9227.44635321883;9797.510124493818;9818.116369526706;9833.704988850346;9848.35985660937;39809;40001.99995000148;40226.798866005774;40232;40292.19415611701;3382.441897086978;3422.9828850855833;3563.625819288989;3570.357335679577;3713.4032366082574;25056.749432505807;30562.38875222483;30806.691933080605;30931.536026959613;30980.507826365276;3201.3117179806454;3247.318063206729;3255.6744325567493;3258.5438038674606;3352.6982571568433;368483;368923.3107668916;372503;496134;496886.5155674235;56193.71903140458;56545.43454565484;56668;56717.43282567204;56824.431755681915;58502;59035;59250;59272.11091833626;59275;15192.544223673087;15370.462033828986;15472.303746331441;15723;15763.527094187193;12132.5146994121;12188.51245950152;12188.57339993096;12192.512299508098;12234.75530489403;14410.135391876522;14770.59679330462;14792.408303667948;14821.92589037048;14977.1013739176;6079.878402431927;6200.968995154995;6245.344238854946;6296.5592408531875;6306.558540902093;740.8666440040737;954.5609019850947;960.9855852162223;1032.6592224565875;1120.2718233148355;25981.610275845876;28733.71266287352;29146.979855704947;29260.561091583644;29513.11460656141;910.0762725833284;1017.6031347774374;1041.1878734587035;1086.5545126498098;1117.1230583991528;15249.542513724606;15373.077615343114;15415.997960132556;15583.454579089677;15655.138967356905;168241.15879420526;168445.15777421035;168812;169110;169172;55573.722131389084;55920.44079559152;56067.15899261514;56067.71966140143;56307;1301.1672529581076;1322.6891680455085;1338.0098726942188;1346.347695040768;1347.2253454263641;28387.858060709565;29379;29518;30077.84961075268;30152.396952060397;47513;47692.284615730096;47735.04529909313;47867.28199076947;47885;580488;585724.0713796404;588521;589802;593502;22748.63508189514;25811.354716132246;38585.42121868118;38944.41583376195;38970.6102938967;45235;45928.77035614801;46655;46936.53063469322;47014.76492617652;32553.348933020734;35376.11559711028;36959;38446;39896.80309590717;37763.62236377711;37948;38265.80867095758;39150.412743808294;39335.21329573335;31216;31974;36101.638983609824;37045;37530.06174845651;33655.83172084124;33740.66259337375;34406.31187376288;34479.827600861834;34560.65439345675;24324.90537925833;24575.262742117764;24664.630030549913;25200.621990669788;26042.479150416508 00:07:52 INFO - PROCESS | 1652 | |2;jquery.html;323.7183650224305;344.5710090936784;375.3169231997765;379.8006046825418;398.9980050099749;18884.62230755386;19407.32074377397;20494.69257961128;20658.863762493056;20731.274405395776;19935.60128797423;20114.396568102944;20314.89842550789;20700.275490357802;20740.859252741095;5645.604807663465;5735.053716136832;5955;5958.314793798703;5959.791407300745;5157.381114266274;5973.970130149343;6083.908741368883;6114.2357205349335;6132;5111.591072714174;5670.886582268352;5992.221011268529;6100.969495152518;6110.297315808694;6026.578139530213;6057.909131363033;6066.302375226861;6080.847978800543;6094.207752992127;5663.66018038919;5784.595078344518;5806.332271788756;5864.560157988125;5890.558208134365;13131.540396086186;13338.73322533544;13342.533011344556;22706.659400109012;23862.164824231244;2070.968935465969;2237.6196046672103;2265.909363625453;2806.0459443789005;2838.9365411263466;8340.457870238415;9689.563969621384;9714.368566043255;10266.486675666261;10415.531301091394;1792.8386445219992;1842.2538871756826;1873.3256027830107;1901.8193271639173;1916.3963351544219;119826;122897.38551307276;124952.75047249503;128149.7185028147;129950.99999999905;11029.889701102886;11429.828552571718;11463.541458341573;11474.311541307548;11670.183087183985;14264.928675356558;14270.785938210935;14270.785938210935;14273.64315892111;14300.213488258038;7117.145942486831;8153.836923261501;8420.663173472993;8475.957620211859;8584.484930904166;7003.8599228015155;8224.671013159406;8308.916910830814;8446.408751387467;8496.830063398698;4369.213541562549;4430.977845110754;4466.330050492452;4533.637309015271;4563.771811409482;1918.6834172361405;1927.9710804337947;1965.6265309591417;1966.4887129346473;1976.4564744695324;819.5328662662345;845.3152946113545;937.6436953957589;943.165298710646;970.8203982263304;17697.292108315523;21185.78814211838;21316.04077816502;21410.357689269345;21653.242136525147;923.8682613798044;924.3852837862746;924.3991405586422;939.9812003759887;945.5744914788373;10656.733581660366;10740;10747.78504429907;11161.330320180816;11162.274452160584;514394;515901;516865;623755;627460;127946.84504972013;134370.3281483606;135840;136153.3192334032;140288.2985585086;888.2583043158905;1000.4197565412044;1009.9394036357842;1011.8229309870743;1012.6455740490769;18334.908325458287;19162.808371916104;19206.519837004187;19327.806721933164;19345.4196374109;45692;52504.474955251484;54061.72969135129;56166.719166403906;56251.71874140603;81674;81960.59019704863;82237;82540;86422.13577864392;7712.267334603203;7887.329576986021;7985.718536150048;8043.396745244013;8049.919500804917;10802.89197108019;10883.78232435331;11133.494963633442;12066.50124069479;12453.816887395684;10379.273450858367;10592.89407105919;10603.469826508797;10991.285566438157;11076.280041797258;9983.351082179635;10080.69757907264;10684.57261709554;10907.563697452013;10950.72623184395;10842.512086955949;11111.499982500645;11265.887341126483;11410.774898894635;11431.199816012799;6159.23009623797;7330.083739532559;7928.127905930228;7937.603119844101;8110.391720621095;10700.143988480748;10730.141588672732;10914.290571112851;11128.942750438695;11179 00:07:52 INFO - PROCESS | 1652 | |3;mootools.html;1380.1236215003473;1514.0310201471061;1721.2770636332748;1858.0802502761135;1870.700687889937;8089.555074470916;8366.456180348288;8519.275861551769;9108.40795348302;9138.177564019237;8708.303335733142;8896.510691911943;8957.641694332218;9009.459432434058;9104.95447522763;2021.909014094362;2337.181986304788;2371.0041782451412;2371.0989823866907;2374.287713685896;1964.5383334916282;2016.3144530859504;2078.812906838384;2294.621387471065;2303.389601755536;2331.230693871027;2365.597848365782;2378.5599664062115;2379.393254720044;2383.094424118832;2331.603627383349;2345.026813872241;2350.8589484630893;2355.4817940053163;2364.361622361961;2348.5772560939026;2350.083467447697;2354.2466410748566;2357.3399448154546;2364.207990323244;9002.954985225097;9035.45787252767;9118.908810911873;9159.267258619295;9221;5237.4500677428705;5303.920441193385;5351.117065684158;5356.571474282087;5357.08929481989;3473.2358881046384;3558.2527669189503;3659.5242618459697;3685.668289853926;3699.3896007158787;1045.5119546294634;1073.9677809665723;1085.4843949124104;1092.2845536173738;1108.728361551425;11961.64115076549;11980.161388702794;12015.459304331325;12123;12124.636260912186;4556.3393307970155;4703.905921881543;4812.759362031885;4816.879578010507;4821.855344339676;10143.543540540693;10224.028717271847;10235.181185505142;10235.334703244265;10251.58993640261;4642.373279607277;4678.017616300547;5250.7374631268285;5303.7348132593215;5321.441248668912;3839.520059992501;4388.210122178039;4674.392328997209;4890.706557606555;4930.359053323045;3902.941455878164;3925.784081875467;3974.602539746002;3977.781222032816;3982.7012974027066;1218.2933898338943;1220.20686553739;1223.6084452974962;1232.5994051933158;1236.1347057060093;804.3645520039221;903.4263242840843;915.9084091590788;924.8335299645994;950.496236994394;5880.970595146997;5901.675407852609;5927.318358388754;5986.371430999682;6174.8147555573405;429.8194758201563;448.614191795056;451.37709960254637;452.4321975920199;454.4818906446653;3914.921701565953;3923.313420151462;3987.322155233617;4004.379321205218;4011.859584914514;8839.60221790021;10769.730756731144;10826.242163048511;10859.457027148612;10989.945050274857;10626.203034772423;10714.357138571711;10730.570777168981;10871.619493317696;10984.395858227714;7916.722914697958;8300.70947516834;8321.500709957421;8385.568185226339;8408.033076196194;5975.34271230173;6018.458338749533;6020.397960203944;6040.305364882919;6192.566520343533;10040.64857729976;10113.393196408239;10178.541965611417;10212.795744085226;10224.1820654346;8218.876716849132;9919.355241909252;10235.84646230322;10436.37381757097;10441.164706823587;6318.178636777189;7345.853082938204;7420.5176663516695;7450.627468626439;7613.390928725578;8369.246767790928;8420.578971051546;8570.314374850122;8580.65677372898;8583.570821459027;7379.631018448948;7519.473636845369;7527.661255243636;7598.278163574451;7636.8472630548185;7324.157721862054;7386.15059268191;7409.184989651027;7475.925240747741;7537.698492060256;6914.204866440424;6974.825629359307;7086.822829429306;7087.503874728925;7101.680424380812;4932.235503496964;5074.06129865976;5125.718085505333;5131.025105229995;5139;5061.620378471555;5134.743262836918;5184.403793563789;5212.296339994053;5251.2123181523075 00:07:52 INFO - PROCESS | 1652 | |4;prototype.html;246.44303873246457;300.93981203759245;308.9660137384888;314.44500456693925;315.138097303874;4322.719023263486;4601.723896566208;5096.413912400075;5442.727863606819;5522.901297506946;4943.728094954776;5276.577873770098;5425.399507145392;5495.725213739307;5525.392206857243;4036.2532931407636;4134.400511925769;4161.604647558477;4193.161367726451;4204.495460544739;3597.866671998312;3711.5546134463902;4152.335626299792;4193.412922190881;4196.622303992655;3729.403295472725;4079.6124368184974;4111.48606424197;4115.74469786715;4135.317672584035;3908.6482216600357;4070.61329173728;4112.527059388179;4116.897077573055;4122.969257685579;2997.6252968378953;3537.893863184109;3557.7331700122336;3559.75081744278;3581.83881725323;4418.270985287424;4855;5287.603429742746;5322.7072511011875;5357.491038351351;4688;4688.038952014829;4690.554397332248;4694.413198350207;4711.929321060153;5252.2384254282915;5273.736313184326;5746.569007324468;5757.856053598652;5759.222504961818;3536.0982949347754;3803.353429916893;3806.3409440435325;3885.941710874339;3910.9804450977563;5052.520010598987;6083.479130217445;6090.756369745205;6106.511479081662;6119.420139218562;3834.367329390675;3916.8433262669746;3950.0322421006463;3956.9604303956594;3964.72246942717;3751.643593858579;3996.540397854226;4006.959930400717;4032.798360082043;4039.565954086257;4083.4079058536345;4463.928657122332;4682.484926658065;4693.647976401783;4693.6949098308505;5421.322334708161;5560.7219639017885;5829;5875.882482350329;6036.921170203228;1057.9576816927238;1071.7106381277013;1081.3944191252924;1349.197227649547;1363.3864760857655;769.4882902869529;845.5518575155055;878.7232021913077;880.6482050053265;927.2257664849791;4952.885600739877;5015.724135172528;5347.946520534822;5471.316085489314;5472.097103977799;5133.460986596354;5822.477401172315;5929.37741537141;5972.28189730117;6019.428154325332;4996.027363718582;5110.514501122388;5472.616916815785;5486;5557.221988921554;2739.7671197948;2909.6944820793933;2927.282815710122;3036.5748795168693;3199.77601567888;5457.653209120037;6269.404406581368;6274.498040156776;6305.716242769086;6324.525660575475;5372.382176049804;5884;6176.104464852661;6221.9377806222265;6227.221597300338;5511.53151982078;5535.612507124462;6235.563510554218;6308.684565771693;6318.6524741138755;5094.077560278639;5988.431099045583;6032.366601506778;6034.7284372202475;6056.939430605637;4817.397825271841;5125.56484184429;5250.317458730341;5346.893062138658;5952.136940143741;5684.687342196219;6199.907001395073;6214.316425193316;6264.968675156595;6268.717907694256;3703.1482758966126;3948.8025598719373;3969.6824254060184;3983.103801644607;3984.940225896556;5805.738741756547;5989.011813050798;6004.309504406874;6025.638461692312;6042.5770196087615;5775;5809.302883653989;5852.4147585241135;5863.501602363847;5865.677387743715;5822.563307752021;5898.793542226002;5928.79249226275;5930.52555795544;5932.644041357532;5012.423571289349;5374.516293533601;5505.494999775013;5697.7720891165545;5858.121281807763;5109.386873575195;5641.971790141187;5838.854028649148;5846.298444186725;5952.369054876435;5462.2856457609205;5761.625494342854;5780.768769249183;5794;5808.7095645218415 00:07:52 INFO - PROCESS | 1652 | |5;yui.html;592.4667798980917;608.9421504957028;609.3875654966757;668.218184723873;722.8951801988715;14229.786553201697;14962.775558366606;15188.316525756354;15316;15370.00094993826;11699.473523691433;12100.818487722669;14664.560063198121;14666.56000319992;14670.339834707436;826.42976346321;853.6756032707563;854.0050840770526;856.6915910272297;857.1642648417774;673.2695025896908;695.6938946863364;703.806453225362;834.6953362022879;852.0542198160038;889.5641135843423;902.4269588811087;902.5081330674798;905.2079430498314;909.963601455941;740.474263273074;899.4153800029967;902.5532361481077;903.6204793986476;906.954652267384;665.4044630056121;667.7128834601119;667.7996601019674;668.8595394967062;669.8124525132971;13956.162630242117;14000.859991400159;14008.299585020708;14100.506482273071;14158;14223.786643200361;14368.13791172533;14389.712205755826;14435.783463248059;14696.13425382051;11891.345975971319;11895.107866910017;11950.701232469171;11978.825258725139;12074.879251207463;3765.1151979284846;3828;3830.8659196927974;3853.171568112841;3950.6246906543834;116037;116812;117310;118931.4053429736;120440;11053.778924421467;11128.33230006186;11186.776264474827;11191.439851231655;11192.10463162945;22855.428614284443;22870;22872.08511659515;22905.656415153786;23000;7769.494982826098;7801.141874393812;7819.452638315263;8022.679092836338;8087.757367278991;4258.68059895509;4276.978615106905;4361.171377438277;4421.845235416745;4423.292273236267;3584.0860580551794;3708.9443658345144;3714.33142034431;3715.8142092895246;3720.553533575934;654.0777503719733;655.9406558408232;657.7040331850686;669.327326037339;686.2759788423261;539.1508374310476;546.6801920876252;620.8572028433396;644.1947565543071;678.9490788190807;8221.506709597443;9033.367664263438;9055.18503334703;9180.219681327162;9437.669681561112;657.7204688007578;663.7278715726529;667.1360588038502;669.7957123077508;675.7263308360122;4232.746035237896;4594.264917613166;4629.70304880467;4640.5823475886655;4734.952650473451;94460;97133;100941;163076;171673;107074;143947;144126;144917;150126;100063;110879.44560277148;120140.39929800294;124381.37809311076;126432.78186917822;8593.8710919335;8874.51190184546;8972.506512141896;8984.326175536991;9196.54017299119;68313.65843170752;69419;69909.50452477254;70453.64773176101;71521;70206.29793701998;89084.55457722669;89430;104502;109352;10330.070293673605;12963.22220666763;13211.537596184087;13310;13364.331783410596;12868.935655321664;14069.507567235098;14728.484503042771;14866.628334291729;15032.398704051715;11267.492962816857;13697.657558561115;13739.862601373858;13743.450261989408;13925;12473.5010599575;12749.725027497176;13750.312484375941;14276.57170284893;14499.057561258907;13246.536371226961;13555.932220338835;13579.86420135786;13829.170249785046;13956.651083722989;10237.488125593542;10322.819258200441;11056.944715276371;11089.33463992163;11712.134995451652;9079.046700096394;10233.897661023593;10298.3820970742;10364.119049880845;11572.479238434122 00:07:52 INFO - PROCESS | 1652 | __end_tp_report 00:07:52 INFO - PROCESS | 1652 | __start_cc_report 00:07:52 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,356 00:07:52 INFO - PROCESS | 1652 | __end_cc_report 00:07:52 INFO - PROCESS | 1652 | __startTimestamp1475737672328__endTimestamp 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | ------- Summary: start ------- 00:07:52 INFO - PROCESS | 1652 | Number of tests: 6 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5610.37 Median:5803.94 stddev:661.60 (11.4%) stddev-sans-first:638.75 00:07:52 INFO - PROCESS | 1652 | Values: 3319.4 3349.4 3362.9 3375.1 3398.4 5002.4 5213.9 5544.6 5591.6 5637.7 4437.7 5560.4 5632.7 5699.7 5707.1 4965.4 5018.2 5073.1 5100.2 5114.6 4941.8 5084.5 5125.9 5150.9 5168.7 5053.6 5100.6 5194.1 5246.2 5267.2 5095.7 5122.6 5145.7 5185.6 5222.5 5061.3 5105.9 5111.5 5119.0 5128.2 5405.2 5437.9 5628.0 5628.6 5639.7 6018.9 6047.8 6126.5 6133.0 6172.2 6181.4 6188.5 6197.9 6198.7 6221.0 5787.1 5799.3 5803.9 5805.4 5818.3 4506.9 4990.5 5978.5 6084.6 6116.3 5113.5 6002.1 6035.7 6069.6 6115.3 5112.6 6083.6 6171.9 6193.8 6207.8 6015.1 6062.8 6067.7 6092.5 6096.0 4961.5 6096.1 6131.5 6134.0 6163.6 4500.2 4935.9 4942.9 4950.0 4998.2 3757.2 4305.4 4305.9 4393.8 4409.0 5703.4 5782.8 5786.8 5794.7 5864.5 5220.3 5979.9 6188.3 6226.0 6229.0 4737.5 5570.6 5617.9 5650.4 5671.1 5352.5 5360.8 5361.2 5371.6 5375.0 6177.6 6199.4 6218.8 6313.7 6314.9 6181.8 6204.9 6212.8 6216.8 6226.0 6102.4 6243.5 6299.3 6304.3 6340.5 6033.2 6118.1 6136.7 6140.7 6145.0 6125.8 6138.8 6145.2 6146.8 6159.7 6083.1 6084.7 6086.4 6096.8 6123.9 5342.5 6041.2 6049.4 6093.5 6097.7 5678.0 5716.9 5763.2 5777.4 5865.2 6045.9 6052.5 6068.8 6078.4 6090.5 5911.8 5914.4 5940.5 5959.9 5979.3 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:54943.48 Median:38910.21 stddev:115312.14 (296.4%) stddev-sans-first:115563.21 00:07:52 INFO - PROCESS | 1652 | Values: 515.9 529.5 537.2 540.2 562.5 38876.0 40415.0 40449.0 40455.4 40515.0 41867.0 41900.6 42362.9 42382.8 42478.4 9781.0 9955.8 9963.2 9972.0 10000.1 9796.0 9888.8 9910.8 9911.1 9916.9 8450.6 9911.7 9915.7 9927.6 9932.0 7915.4 8939.7 9088.1 9845.3 9896.8 9227.4 9797.5 9818.1 9833.7 9848.4 39809.0 40002.0 40226.8 40232.0 40292.2 3382.4 3423.0 3563.6 3570.4 3713.4 25056.7 30562.4 30806.7 30931.5 30980.5 3201.3 3247.3 3255.7 3258.5 3352.7 368483.0 368923.3 372503.0 496134.0 496886.5 56193.7 56545.4 56668.0 56717.4 56824.4 58502.0 59035.0 59250.0 59272.1 59275.0 15192.5 15370.5 15472.3 15723.0 15763.5 12132.5 12188.5 12188.6 12192.5 12234.8 14410.1 14770.6 14792.4 14821.9 14977.1 6079.9 6201.0 6245.3 6296.6 6306.6 740.9 954.6 961.0 1032.7 1120.3 25981.6 28733.7 29147.0 29260.6 29513.1 910.1 1017.6 1041.2 1086.6 1117.1 15249.5 15373.1 15416.0 15583.5 15655.1 168241.2 168445.2 168812.0 169110.0 169172.0 55573.7 55920.4 56067.2 56067.7 56307.0 1301.2 1322.7 1338.0 1346.3 1347.2 28387.9 29379.0 29518.0 30077.8 30152.4 47513.0 47692.3 47735.0 47867.3 47885.0 580488.0 585724.1 588521.0 589802.0 593502.0 22748.6 25811.4 38585.4 38944.4 38970.6 45235.0 45928.8 46655.0 46936.5 47014.8 32553.3 35376.1 36959.0 38446.0 39896.8 37763.6 37948.0 38265.8 39150.4 39335.2 31216.0 31974.0 36101.6 37045.0 37530.1 33655.8 33740.7 34406.3 34479.8 34560.7 24324.9 24575.3 24664.6 25200.6 26042.5 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34143.96 Median:12486.28 stddev:94737.41 (758.7%) stddev-sans-first:94969.14 00:07:52 INFO - PROCESS | 1652 | Values: 323.7 344.6 375.3 379.8 399.0 18884.6 19407.3 20494.7 20658.9 20731.3 19935.6 20114.4 20314.9 20700.3 20740.9 5645.6 5735.1 5955.0 5958.3 5959.8 5157.4 5974.0 6083.9 6114.2 6132.0 5111.6 5670.9 5992.2 6101.0 6110.3 6026.6 6057.9 6066.3 6080.8 6094.2 5663.7 5784.6 5806.3 5864.6 5890.6 13131.5 13338.7 13342.5 22706.7 23862.2 2071.0 2237.6 2265.9 2806.0 2838.9 8340.5 9689.6 9714.4 10266.5 10415.5 1792.8 1842.3 1873.3 1901.8 1916.4 119826.0 122897.4 124952.8 128149.7 129951.0 11029.9 11429.8 11463.5 11474.3 11670.2 14264.9 14270.8 14270.8 14273.6 14300.2 7117.1 8153.8 8420.7 8476.0 8584.5 7003.9 8224.7 8308.9 8446.4 8496.8 4369.2 4431.0 4466.3 4533.6 4563.8 1918.7 1928.0 1965.6 1966.5 1976.5 819.5 845.3 937.6 943.2 970.8 17697.3 21185.8 21316.0 21410.4 21653.2 923.9 924.4 924.4 940.0 945.6 10656.7 10740.0 10747.8 11161.3 11162.3 514394.0 515901.0 516865.0 623755.0 627460.0 127946.8 134370.3 135840.0 136153.3 140288.3 888.3 1000.4 1009.9 1011.8 1012.6 18334.9 19162.8 19206.5 19327.8 19345.4 45692.0 52504.5 54061.7 56166.7 56251.7 81674.0 81960.6 82237.0 82540.0 86422.1 7712.3 7887.3 7985.7 8043.4 8049.9 10802.9 10883.8 11133.5 12066.5 12453.8 10379.3 10592.9 10603.5 10991.3 11076.3 9983.4 10080.7 10684.6 10907.6 10950.7 10842.5 11111.5 11265.9 11410.8 11431.2 6159.2 7330.1 7928.1 7937.6 8110.4 10700.1 10730.1 10914.3 11128.9 11179.0 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5735.13 Median:4658.38 stddev:3275.97 (70.3%) stddev-sans-first:3268.81 00:07:52 INFO - PROCESS | 1652 | Values: 1380.1 1514.0 1721.3 1858.1 1870.7 8089.6 8366.5 8519.3 9108.4 9138.2 8708.3 8896.5 8957.6 9009.5 9105.0 2021.9 2337.2 2371.0 2371.1 2374.3 1964.5 2016.3 2078.8 2294.6 2303.4 2331.2 2365.6 2378.6 2379.4 2383.1 2331.6 2345.0 2350.9 2355.5 2364.4 2348.6 2350.1 2354.2 2357.3 2364.2 9003.0 9035.5 9118.9 9159.3 9221.0 5237.5 5303.9 5351.1 5356.6 5357.1 3473.2 3558.3 3659.5 3685.7 3699.4 1045.5 1074.0 1085.5 1092.3 1108.7 11961.6 11980.2 12015.5 12123.0 12124.6 4556.3 4703.9 4812.8 4816.9 4821.9 10143.5 10224.0 10235.2 10235.3 10251.6 4642.4 4678.0 5250.7 5303.7 5321.4 3839.5 4388.2 4674.4 4890.7 4930.4 3902.9 3925.8 3974.6 3977.8 3982.7 1218.3 1220.2 1223.6 1232.6 1236.1 804.4 903.4 915.9 924.8 950.5 5881.0 5901.7 5927.3 5986.4 6174.8 429.8 448.6 451.4 452.4 454.5 3914.9 3923.3 3987.3 4004.4 4011.9 8839.6 10769.7 10826.2 10859.5 10989.9 10626.2 10714.4 10730.6 10871.6 10984.4 7916.7 8300.7 8321.5 8385.6 8408.0 5975.3 6018.5 6020.4 6040.3 6192.6 10040.6 10113.4 10178.5 10212.8 10224.2 8218.9 9919.4 10235.8 10436.4 10441.2 6318.2 7345.9 7420.5 7450.6 7613.4 8369.2 8420.6 8570.3 8580.7 8583.6 7379.6 7519.5 7527.7 7598.3 7636.8 7324.2 7386.2 7409.2 7475.9 7537.7 6914.2 6974.8 7086.8 7087.5 7101.7 4932.2 5074.1 5125.7 5131.0 5139.0 5061.6 5134.7 5184.4 5212.3 5251.2 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4684.91 Median:5282.09 stddev:1486.69 (28.1%) stddev-sans-first:1453.06 00:07:52 INFO - PROCESS | 1652 | Values: 246.4 300.9 309.0 314.4 315.1 4322.7 4601.7 5096.4 5442.7 5522.9 4943.7 5276.6 5425.4 5495.7 5525.4 4036.3 4134.4 4161.6 4193.2 4204.5 3597.9 3711.6 4152.3 4193.4 4196.6 3729.4 4079.6 4111.5 4115.7 4135.3 3908.6 4070.6 4112.5 4116.9 4123.0 2997.6 3537.9 3557.7 3559.8 3581.8 4418.3 4855.0 5287.6 5322.7 5357.5 4688.0 4688.0 4690.6 4694.4 4711.9 5252.2 5273.7 5746.6 5757.9 5759.2 3536.1 3803.4 3806.3 3885.9 3911.0 5052.5 6083.5 6090.8 6106.5 6119.4 3834.4 3916.8 3950.0 3957.0 3964.7 3751.6 3996.5 4007.0 4032.8 4039.6 4083.4 4463.9 4682.5 4693.6 4693.7 5421.3 5560.7 5829.0 5875.9 6036.9 1058.0 1071.7 1081.4 1349.2 1363.4 769.5 845.6 878.7 880.6 927.2 4952.9 5015.7 5347.9 5471.3 5472.1 5133.5 5822.5 5929.4 5972.3 6019.4 4996.0 5110.5 5472.6 5486.0 5557.2 2739.8 2909.7 2927.3 3036.6 3199.8 5457.7 6269.4 6274.5 6305.7 6324.5 5372.4 5884.0 6176.1 6221.9 6227.2 5511.5 5535.6 6235.6 6308.7 6318.7 5094.1 5988.4 6032.4 6034.7 6056.9 4817.4 5125.6 5250.3 5346.9 5952.1 5684.7 6199.9 6214.3 6265.0 6268.7 3703.1 3948.8 3969.7 3983.1 3984.9 5805.7 5989.0 6004.3 6025.6 6042.6 5775.0 5809.3 5852.4 5863.5 5865.7 5822.6 5898.8 5928.8 5930.5 5932.6 5012.4 5374.5 5505.5 5697.8 5858.1 5109.4 5642.0 5838.9 5846.3 5952.4 5462.3 5761.6 5780.8 5794.0 5808.7 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25020.79 Median:3711.64 stddev:40219.64 (1083.6%) stddev-sans-first:40290.65 00:07:52 INFO - PROCESS | 1652 | Values: 592.5 608.9 609.4 668.2 722.9 14229.8 14962.8 15188.3 15316.0 15370.0 11699.5 12100.8 14664.6 14666.6 14670.3 826.4 853.7 854.0 856.7 857.2 673.3 695.7 703.8 834.7 852.1 889.6 902.4 902.5 905.2 910.0 740.5 899.4 902.6 903.6 907.0 665.4 667.7 667.8 668.9 669.8 13956.2 14000.9 14008.3 14100.5 14158.0 14223.8 14368.1 14389.7 14435.8 14696.1 11891.3 11895.1 11950.7 11978.8 12074.9 3765.1 3828.0 3830.9 3853.2 3950.6 116037.0 116812.0 117310.0 118931.4 120440.0 11053.8 11128.3 11186.8 11191.4 11192.1 22855.4 22870.0 22872.1 22905.7 23000.0 7769.5 7801.1 7819.5 8022.7 8087.8 4258.7 4277.0 4361.2 4421.8 4423.3 3584.1 3708.9 3714.3 3715.8 3720.6 654.1 655.9 657.7 669.3 686.3 539.2 546.7 620.9 644.2 678.9 8221.5 9033.4 9055.2 9180.2 9437.7 657.7 663.7 667.1 669.8 675.7 4232.7 4594.3 4629.7 4640.6 4735.0 94460.0 97133.0 100941.0 163076.0 171673.0 107074.0 143947.0 144126.0 144917.0 150126.0 100063.0 110879.4 120140.4 124381.4 126432.8 8593.9 8874.5 8972.5 8984.3 9196.5 68313.7 69419.0 69909.5 70453.6 71521.0 70206.3 89084.6 89430.0 104502.0 109352.0 10330.1 12963.2 13211.5 13310.0 13364.3 12868.9 14069.5 14728.5 14866.6 15032.4 11267.5 13697.7 13739.9 13743.5 13925.0 12473.5 12749.7 13750.3 14276.6 14499.1 13246.5 13555.9 13579.9 13829.2 13956.7 10237.5 10322.8 11056.9 11089.3 11712.1 9079.0 10233.9 10298.4 10364.1 11572.5 00:07:52 INFO - PROCESS | 1652 | -------- Summary: end -------- 00:07:52 INFO - PROCESS | 1652 | 00:07:52 INFO - TEST-INFO | 1652: exit 0 00:07:52 INFO - TEST-OK | dromaeo_css | took 1115545ms 00:07:52 INFO - TEST-START | kraken 00:07:52 INFO - operating with platform_type : mac_ 00:07:52 INFO - Initialising browser for kraken test... 00:07:52 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpET18jg/profile http://localhost:49277/getInfo.html) 00:07:55 INFO - PROCESS | 1664 | 2016-10-06 00:07:55.569 plugin-container[1665:10734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.tsm.portname' 00:07:55 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:07:55 INFO - PROCESS | 1664 | 2016-10-06 00:07:55.572 plugin-container[1665:10734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.CFPasteboardClient' 00:07:55 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:07:55 INFO - PROCESS | 1664 | 2016-10-06 00:07:55.572 plugin-container[1665:10734] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:07:55 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 00:07:55 INFO - PROCESS | 1664 | colorDepth:24 00:07:55 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 00:07:55 INFO - PROCESS | 1664 | __metrics 00:07:55 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 00:07:56 INFO - TEST-INFO | 1664: exit 0 00:07:56 INFO - Browser initialized. 00:07:56 INFO - Running cycle 1/1 for kraken test... 00:07:56 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpET18jg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:07:58 INFO - PROCESS | 1666 | 2016-10-06 00:07:58.793 plugin-container[1667:10846] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1f, name = 'com.apple.tsm.portname' 00:07:58 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:07:58 INFO - PROCESS | 1666 | 2016-10-06 00:07:58.795 plugin-container[1667:10846] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 00:07:58 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:07:58 INFO - PROCESS | 1666 | 2016-10-06 00:07:58.795 plugin-container[1667:10846] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:08:08 INFO - PROCESS | 1666 | RSS: Main: 239931392 00:08:08 INFO - PROCESS | 1666 | 00:08:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 00:08:12 INFO - PROCESS | 1666 | RSS: Main: 253476864 00:08:12 INFO - PROCESS | 1666 | 00:08:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 00:08:15 INFO - PROCESS | 1666 | RSS: Main: 260939776 00:08:15 INFO - PROCESS | 1666 | 00:08:18 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 00:08:19 INFO - PROCESS | 1666 | RSS: Main: 261877760 00:08:19 INFO - PROCESS | 1666 | 00:08:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 00:08:22 INFO - PROCESS | 1666 | RSS: Main: 264179712 00:08:22 INFO - PROCESS | 1666 | 00:08:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:08:24 INFO - PROCESS | 1666 | RSS: Main: 264536064 00:08:24 INFO - PROCESS | 1666 | 00:08:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 00:08:28 INFO - PROCESS | 1666 | RSS: Main: 265355264 00:08:28 INFO - PROCESS | 1666 | 00:08:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 00:08:31 INFO - PROCESS | 1666 | RSS: Main: 265641984 00:08:31 INFO - PROCESS | 1666 | 00:08:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 00:08:35 INFO - PROCESS | 1666 | RSS: Main: 265969664 00:08:35 INFO - PROCESS | 1666 | 00:08:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:08:37 INFO - PROCESS | 1666 | RSS: Main: 265674752 00:08:37 INFO - PROCESS | 1666 | 00:08:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:08:40 INFO - PROCESS | 1666 | RSS: Main: 265949184 00:08:40 INFO - PROCESS | 1666 | 00:08:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:08:42 INFO - PROCESS | 1666 | RSS: Main: 265789440 00:08:42 INFO - PROCESS | 1666 | 00:08:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:08:46 INFO - PROCESS | 1666 | RSS: Main: 265699328 00:08:46 INFO - PROCESS | 1666 | 00:08:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:08:50 INFO - PROCESS | 1666 | RSS: Main: 266031104 00:08:50 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 00:08:52 INFO - PROCESS | 1666 | RSS: Main: 267763712 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | __start_tp_report 00:08:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 00:08:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 00:08:52 INFO - PROCESS | 1666 | |i|pagename|runs| 00:08:52 INFO - PROCESS | 1666 | |0;ai-astar;117;123;119;118;117;118;117;118;117;117 00:08:52 INFO - PROCESS | 1666 | |1;audio-beat-detection;152;116;113;152;116;120;115;115;146;116 00:08:52 INFO - PROCESS | 1666 | |2;audio-dft;196;199;208;212;199;200;199;194;196;196 00:08:52 INFO - PROCESS | 1666 | |3;audio-fft;107;83;86;104;65;58;60;60;81;59 00:08:52 INFO - PROCESS | 1666 | |4;audio-oscillator;84;71;88;84;72;71;88;69;70;87 00:08:52 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;93;87;89;85;101;114;88;95;88;86 00:08:52 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;95;94;131;116;94;153;153;104;152 00:08:52 INFO - PROCESS | 1666 | |7;imaging-desaturate;91;94;82;90;92;94;74;145;146;90 00:08:52 INFO - PROCESS | 1666 | |8;json-parse-financial;54;52;56;56;58;58;57;57;71;57 00:08:52 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;69;83;76;77;69;70;69;72;70 00:08:52 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;92;89;94;90;89;93;111;90;84;90 00:08:52 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;148;152;145;146;145;144;149;159;181;148 00:08:52 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;226;183;173;197;245;217;236;185;174;181 00:08:52 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;72;71;69;68;74;69;70;71;72 00:08:52 INFO - PROCESS | 1666 | __end_tp_report 00:08:52 INFO - PROCESS | 1666 | __start_cc_report 00:08:52 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,923 00:08:52 INFO - PROCESS | 1666 | __end_cc_report 00:08:52 INFO - PROCESS | 1666 | __startTimestamp1475737732415__endTimestamp 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | ------- Summary: start ------- 00:08:52 INFO - PROCESS | 1666 | Number of tests: 14 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:118.10 Median:118.00 stddev:1.85 (1.6%) stddev-sans-first:1.92 00:08:52 INFO - PROCESS | 1666 | Values: 117.0 123.0 119.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:118.00 stddev:16.66 (14.1%) stddev-sans-first:14.81 00:08:52 INFO - PROCESS | 1666 | Values: 152.0 116.0 113.0 152.0 116.0 120.0 115.0 115.0 146.0 116.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:199.90 Median:199.00 stddev:5.72 (2.9%) stddev-sans-first:5.89 00:08:52 INFO - PROCESS | 1666 | Values: 196.0 199.0 208.0 212.0 199.0 200.0 199.0 194.0 196.0 196.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:76.30 Median:62.50 stddev:18.75 (30.0%) stddev-sans-first:16.27 00:08:52 INFO - PROCESS | 1666 | Values: 107.0 83.0 86.0 104.0 65.0 58.0 60.0 60.0 81.0 59.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:84.00 stddev:8.37 (10.0%) stddev-sans-first:8.63 00:08:52 INFO - PROCESS | 1666 | Values: 84.0 71.0 88.0 84.0 72.0 71.0 88.0 69.0 70.0 87.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:88.00 stddev:8.96 (10.2%) stddev-sans-first:9.50 00:08:52 INFO - PROCESS | 1666 | Values: 93.0 87.0 89.0 85.0 101.0 114.0 88.0 95.0 88.0 86.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:118.70 Median:123.50 stddev:26.20 (21.2%) stddev-sans-first:26.35 00:08:52 INFO - PROCESS | 1666 | Values: 95.0 95.0 94.0 131.0 116.0 94.0 153.0 153.0 104.0 152.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:90.50 stddev:24.85 (27.5%) stddev-sans-first:26.15 00:08:52 INFO - PROCESS | 1666 | Values: 91.0 94.0 82.0 90.0 92.0 94.0 74.0 145.0 146.0 90.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:5.06 (8.9%) stddev-sans-first:5.20 00:08:52 INFO - PROCESS | 1666 | Values: 54.0 52.0 56.0 56.0 58.0 58.0 57.0 57.0 71.0 57.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.00 stddev:5.38 (7.6%) stddev-sans-first:4.89 00:08:52 INFO - PROCESS | 1666 | Values: 64.0 69.0 83.0 76.0 77.0 69.0 70.0 69.0 72.0 70.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:90.00 stddev:7.15 (7.9%) stddev-sans-first:7.58 00:08:52 INFO - PROCESS | 1666 | Values: 92.0 89.0 94.0 90.0 89.0 93.0 111.0 90.0 84.0 90.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:148.50 stddev:11.20 (7.5%) stddev-sans-first:11.79 00:08:52 INFO - PROCESS | 1666 | Values: 148.0 152.0 145.0 146.0 145.0 144.0 149.0 159.0 181.0 148.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.70 Median:207.00 stddev:26.97 (13.0%) stddev-sans-first:27.13 00:08:52 INFO - PROCESS | 1666 | Values: 226.0 183.0 173.0 197.0 245.0 217.0 236.0 185.0 174.0 181.0 00:08:52 INFO - PROCESS | 1666 | 00:08:52 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.84 (2.6%) stddev-sans-first:1.87 00:08:52 INFO - PROCESS | 1666 | Values: 69.0 72.0 71.0 69.0 68.0 74.0 69.0 70.0 71.0 72.0 00:08:52 INFO - PROCESS | 1666 | -------- Summary: end -------- 00:08:52 INFO - PROCESS | 1666 | 00:08:53 INFO - TEST-INFO | 1666: exit 0 00:08:53 INFO - TEST-OK | kraken | took 60378ms 00:08:53 INFO - SUITE-END | took 1175s 00:08:53 INFO - Completed test suite (00:19:36) 00:08:53 INFO - javascript benchmark 00:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.6521498759985, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.369319829232, 3349.3636209120264, 3362.8991130266095, 3375.054984604312, 3398.3882901077795, 5002.449730529639, 5213.921791173136, 5544.63959842611, 5591.580631452647, 5637.718114094294, 4437.711548749337, 5560.388357280696, 5632.718364081789, 5699.74351154198, 5707.086866101425, 4965.428975667808, 5018.247262910556, 5073.061483625541, 5100.183970564711, 5114.565261952738, 4941.827036053739, 5084.491550844923, 5125.948740512585, 5150.922736158961, 5168.689878607277, 5053.5957123430035, 5100.617453690951, 5194.142966410575, 5246.213068039787, 5267.209918512215, 5095.745212739385, 5122.615803814691, 5145.665531740425, 5185.637005409585, 5222.50386213313, 5061.2661164131, 5105.897882042338, 5111.463296353866, 5119.0273847968765, 5128.153854613985, 5405.216243644689, 5437.864053398657, 5628.04323265046, 5628.605997580171, 5639.68981706006, 6018.909716354258, 6047.820674968383, 6126.54820943507, 6132.967444181115, 6172.197614310111, 6181.381861813783, 6188.535859810532, 6197.938020619781, 6198.690065496708, 6221.035739460345, 5787.07406814916, 5799.33307669615, 5803.941960580382, 5805.448482394166, 5818.3308919474375, 4506.850753058015, 4990.525900039491, 5978.491828194565, 6084.606322208845, 6116.33577150815, 5113.488651134931, 6002.0996850472775, 6035.66803825785, 6069.635821850703, 6115.296740874767, 5112.616553758483, 6083.6349819011, 6171.907421388682, 6193.84515387119, 6207.81376558704, 6015.1278064681255, 6062.818115456544, 6067.7269522871575, 6092.5430592705725, 6095.969520152371, 4961.454240033593, 6096.0855871619615, 6131.468419844996, 6134.04922237054, 6163.630182189083, 4500.167469018242, 4935.925961110514, 4942.851714448572, 4950.0, 4998.150314446553, 3757.248550289953, 4305.418768466279, 4305.945043464371, 4393.846215382447, 4409.0, 5703.372629010805, 5782.826515204551, 5786.768529258782, 5794.710264486843, 5864.530837532987, 5220.347456567929, 5979.850503737354, 6188.2883468400805, 6225.968870155711, 6229.0, 4737.502562230916, 5570.637908535932, 5617.915731264035, 5650.378458369576, 5671.064274394761, 5352.4915133062295, 5360.839174824761, 5361.169018802092, 5371.597130215171, 5375.0324941510125, 6177.62934223948, 6199.380061993765, 6218.751249950133, 6313.684315784284, 6314.905276420765, 6181.783637572664, 6204.875902482016, 6212.81361559154, 6216.751329946932, 6226.0, 6102.398363691488, 6243.531735119975, 6299.338569450142, 6304.275008374096, 6340.4927605792345, 6033.245844269466, 6118.082287656709, 6136.662483563447, 6140.662263575367, 6145.0, 6125.784909797739, 6138.754449821957, 6145.231846019247, 6146.801373732079, 6159.6612186330185, 6083.057126145454, 6084.69576521181, 6086.352357320099, 6096.829073522031, 6123.877522449615, 5342.465753424626, 6041.18444010053, 6049.3950604939155, 6093.451589356801, 6097.695115244309, 5678.0, 5716.942830571641, 5763.193152958673, 5777.39337369587, 5865.178874957424, 6045.939540604538, 6052.485538729081, 6068.757249710139, 6078.3921607838865, 6090.482309003784, 5911.822645320647, 5914.378990205966, 5940.524758019435, 5959.851003724942, 5979.312379076462], "value": 5570.447150544553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.9303494028306, 529.4863981937522, 537.1968906484806, 540.2166858055817, 562.454419213363, 38876.0, 40414.98962525938, 40449.0, 40455.393169102485, 40515.0, 41867.0, 41900.58099419005, 42362.940926476775, 42382.788086059525, 42478.362824557655, 9781.0, 9955.800883982316, 9963.202943764518, 9971.950140249288, 10000.099991000809, 9795.95102024489, 9888.802223955516, 9910.801783964316, 9911.058449447291, 9916.851247231298, 8450.57747112645, 9911.653092141776, 9915.702528924108, 9927.553260103312, 9932.006799320083, 7915.4063445241545, 8939.748435219075, 9088.136627020422, 9845.261605379625, 9896.752581185456, 9227.44635321883, 9797.510124493818, 9818.116369526706, 9833.704988850346, 9848.35985660937, 39809.0, 40001.99995000148, 40226.798866005774, 40232.0, 40292.19415611701, 3382.441897086978, 3422.9828850855833, 3563.625819288989, 3570.357335679577, 3713.4032366082574, 25056.749432505807, 30562.38875222483, 30806.691933080605, 30931.536026959613, 30980.507826365276, 3201.3117179806454, 3247.318063206729, 3255.6744325567493, 3258.5438038674606, 3352.6982571568433, 368483.0, 368923.3107668916, 372503.0, 496134.0, 496886.5155674235, 56193.71903140458, 56545.43454565484, 56668.0, 56717.43282567204, 56824.431755681915, 58502.0, 59035.0, 59250.0, 59272.11091833626, 59275.0, 15192.544223673087, 15370.462033828986, 15472.303746331441, 15723.0, 15763.527094187193, 12132.5146994121, 12188.51245950152, 12188.57339993096, 12192.512299508098, 12234.75530489403, 14410.135391876522, 14770.59679330462, 14792.408303667948, 14821.92589037048, 14977.1013739176, 6079.878402431927, 6200.968995154995, 6245.344238854946, 6296.5592408531875, 6306.558540902093, 740.8666440040737, 954.5609019850947, 960.9855852162223, 1032.6592224565875, 1120.2718233148355, 25981.610275845876, 28733.71266287352, 29146.979855704947, 29260.561091583644, 29513.11460656141, 910.0762725833284, 1017.6031347774374, 1041.1878734587035, 1086.5545126498098, 1117.1230583991528, 15249.542513724606, 15373.077615343114, 15415.997960132556, 15583.454579089677, 15655.138967356905, 168241.15879420526, 168445.15777421035, 168812.0, 169110.0, 169172.0, 55573.722131389084, 55920.44079559152, 56067.15899261514, 56067.71966140143, 56307.0, 1301.1672529581076, 1322.6891680455085, 1338.0098726942188, 1346.347695040768, 1347.2253454263641, 28387.858060709565, 29379.0, 29518.0, 30077.84961075268, 30152.396952060397, 47513.0, 47692.284615730096, 47735.04529909313, 47867.28199076947, 47885.0, 580488.0, 585724.0713796404, 588521.0, 589802.0, 593502.0, 22748.63508189514, 25811.354716132246, 38585.42121868118, 38944.41583376195, 38970.6102938967, 45235.0, 45928.77035614801, 46655.0, 46936.53063469322, 47014.76492617652, 32553.348933020734, 35376.11559711028, 36959.0, 38446.0, 39896.80309590717, 37763.62236377711, 37948.0, 38265.80867095758, 39150.412743808294, 39335.21329573335, 31216.0, 31974.0, 36101.638983609824, 37045.0, 37530.06174845651, 33655.83172084124, 33740.66259337375, 34406.31187376288, 34479.827600861834, 34560.65439345675, 24324.90537925833, 24575.262742117764, 24664.630030549913, 25200.621990669788, 26042.479150416508], "value": 18806.06438161773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.7183650224305, 344.5710090936784, 375.3169231997765, 379.8006046825418, 398.9980050099749, 18884.62230755386, 19407.32074377397, 20494.69257961128, 20658.863762493056, 20731.274405395776, 19935.60128797423, 20114.396568102944, 20314.89842550789, 20700.275490357802, 20740.859252741095, 5645.604807663465, 5735.053716136832, 5955.0, 5958.314793798703, 5959.791407300745, 5157.381114266274, 5973.970130149343, 6083.908741368883, 6114.2357205349335, 6132.0, 5111.591072714174, 5670.886582268352, 5992.221011268529, 6100.969495152518, 6110.297315808694, 6026.578139530213, 6057.909131363033, 6066.302375226861, 6080.847978800543, 6094.207752992127, 5663.66018038919, 5784.595078344518, 5806.332271788756, 5864.560157988125, 5890.558208134365, 13131.540396086186, 13338.73322533544, 13342.533011344556, 22706.659400109012, 23862.164824231244, 2070.968935465969, 2237.6196046672103, 2265.909363625453, 2806.0459443789005, 2838.9365411263466, 8340.457870238415, 9689.563969621384, 9714.368566043255, 10266.486675666261, 10415.531301091394, 1792.8386445219992, 1842.2538871756826, 1873.3256027830107, 1901.8193271639173, 1916.3963351544219, 119826.0, 122897.38551307276, 124952.75047249503, 128149.7185028147, 129950.99999999905, 11029.889701102886, 11429.828552571718, 11463.541458341573, 11474.311541307548, 11670.183087183985, 14264.928675356558, 14270.785938210935, 14270.785938210935, 14273.64315892111, 14300.213488258038, 7117.145942486831, 8153.836923261501, 8420.663173472993, 8475.957620211859, 8584.484930904166, 7003.8599228015155, 8224.671013159406, 8308.916910830814, 8446.408751387467, 8496.830063398698, 4369.213541562549, 4430.977845110754, 4466.330050492452, 4533.637309015271, 4563.771811409482, 1918.6834172361405, 1927.9710804337947, 1965.6265309591417, 1966.4887129346473, 1976.4564744695324, 819.5328662662345, 845.3152946113545, 937.6436953957589, 943.165298710646, 970.8203982263304, 17697.292108315523, 21185.78814211838, 21316.04077816502, 21410.357689269345, 21653.242136525147, 923.8682613798044, 924.3852837862746, 924.3991405586422, 939.9812003759887, 945.5744914788373, 10656.733581660366, 10740.0, 10747.78504429907, 11161.330320180816, 11162.274452160584, 514394.0, 515901.0, 516865.0, 623755.0, 627460.0, 127946.84504972013, 134370.3281483606, 135840.0, 136153.3192334032, 140288.2985585086, 888.2583043158905, 1000.4197565412044, 1009.9394036357842, 1011.8229309870743, 1012.6455740490769, 18334.908325458287, 19162.808371916104, 19206.519837004187, 19327.806721933164, 19345.4196374109, 45692.0, 52504.474955251484, 54061.72969135129, 56166.719166403906, 56251.71874140603, 81674.0, 81960.59019704863, 82237.0, 82540.0, 86422.13577864392, 7712.267334603203, 7887.329576986021, 7985.718536150048, 8043.396745244013, 8049.919500804917, 10802.89197108019, 10883.78232435331, 11133.494963633442, 12066.50124069479, 12453.816887395684, 10379.273450858367, 10592.89407105919, 10603.469826508797, 10991.285566438157, 11076.280041797258, 9983.351082179635, 10080.69757907264, 10684.57261709554, 10907.563697452013, 10950.72623184395, 10842.512086955949, 11111.499982500645, 11265.887341126483, 11410.774898894635, 11431.199816012799, 6159.23009623797, 7330.083739532559, 7928.127905930228, 7937.603119844101, 8110.391720621095, 10700.143988480748, 10730.141588672732, 10914.290571112851, 11128.942750438695, 11179.0], "value": 9392.803425672284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.1236215003473, 1514.0310201471061, 1721.2770636332748, 1858.0802502761135, 1870.700687889937, 8089.555074470916, 8366.456180348288, 8519.275861551769, 9108.40795348302, 9138.177564019237, 8708.303335733142, 8896.510691911943, 8957.641694332218, 9009.459432434058, 9104.95447522763, 2021.909014094362, 2337.181986304788, 2371.0041782451412, 2371.0989823866907, 2374.287713685896, 1964.5383334916282, 2016.3144530859504, 2078.812906838384, 2294.621387471065, 2303.389601755536, 2331.230693871027, 2365.597848365782, 2378.5599664062115, 2379.393254720044, 2383.094424118832, 2331.603627383349, 2345.026813872241, 2350.8589484630893, 2355.4817940053163, 2364.361622361961, 2348.5772560939026, 2350.083467447697, 2354.2466410748566, 2357.3399448154546, 2364.207990323244, 9002.954985225097, 9035.45787252767, 9118.908810911873, 9159.267258619295, 9221.0, 5237.4500677428705, 5303.920441193385, 5351.117065684158, 5356.571474282087, 5357.08929481989, 3473.2358881046384, 3558.2527669189503, 3659.5242618459697, 3685.668289853926, 3699.3896007158787, 1045.5119546294634, 1073.9677809665723, 1085.4843949124104, 1092.2845536173738, 1108.728361551425, 11961.64115076549, 11980.161388702794, 12015.459304331325, 12123.0, 12124.636260912186, 4556.3393307970155, 4703.905921881543, 4812.759362031885, 4816.879578010507, 4821.855344339676, 10143.543540540693, 10224.028717271847, 10235.181185505142, 10235.334703244265, 10251.58993640261, 4642.373279607277, 4678.017616300547, 5250.7374631268285, 5303.7348132593215, 5321.441248668912, 3839.520059992501, 4388.210122178039, 4674.392328997209, 4890.706557606555, 4930.359053323045, 3902.941455878164, 3925.784081875467, 3974.602539746002, 3977.781222032816, 3982.7012974027066, 1218.2933898338943, 1220.20686553739, 1223.6084452974962, 1232.5994051933158, 1236.1347057060093, 804.3645520039221, 903.4263242840843, 915.9084091590788, 924.8335299645994, 950.496236994394, 5880.970595146997, 5901.675407852609, 5927.318358388754, 5986.371430999682, 6174.8147555573405, 429.8194758201563, 448.614191795056, 451.37709960254637, 452.4321975920199, 454.4818906446653, 3914.921701565953, 3923.313420151462, 3987.322155233617, 4004.379321205218, 4011.859584914514, 8839.60221790021, 10769.730756731144, 10826.242163048511, 10859.457027148612, 10989.945050274857, 10626.203034772423, 10714.357138571711, 10730.570777168981, 10871.619493317696, 10984.395858227714, 7916.722914697958, 8300.70947516834, 8321.500709957421, 8385.568185226339, 8408.033076196194, 5975.34271230173, 6018.458338749533, 6020.397960203944, 6040.305364882919, 6192.566520343533, 10040.64857729976, 10113.393196408239, 10178.541965611417, 10212.795744085226, 10224.1820654346, 8218.876716849132, 9919.355241909252, 10235.84646230322, 10436.37381757097, 10441.164706823587, 6318.178636777189, 7345.853082938204, 7420.5176663516695, 7450.627468626439, 7613.390928725578, 8369.246767790928, 8420.578971051546, 8570.314374850122, 8580.65677372898, 8583.570821459027, 7379.631018448948, 7519.473636845369, 7527.661255243636, 7598.278163574451, 7636.8472630548185, 7324.157721862054, 7386.15059268191, 7409.184989651027, 7475.925240747741, 7537.698492060256, 6914.204866440424, 6974.825629359307, 7086.822829429306, 7087.503874728925, 7101.680424380812, 4932.235503496964, 5074.06129865976, 5125.718085505333, 5131.025105229995, 5139.0, 5061.620378471555, 5134.743262836918, 5184.403793563789, 5212.296339994053, 5251.2123181523075], "value": 4507.436899917873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [246.44303873246457, 300.93981203759245, 308.9660137384888, 314.44500456693925, 315.138097303874, 4322.719023263486, 4601.723896566208, 5096.413912400075, 5442.727863606819, 5522.901297506946, 4943.728094954776, 5276.577873770098, 5425.399507145392, 5495.725213739307, 5525.392206857243, 4036.2532931407636, 4134.400511925769, 4161.604647558477, 4193.161367726451, 4204.495460544739, 3597.866671998312, 3711.5546134463902, 4152.335626299792, 4193.412922190881, 4196.622303992655, 3729.403295472725, 4079.6124368184974, 4111.48606424197, 4115.74469786715, 4135.317672584035, 3908.6482216600357, 4070.61329173728, 4112.527059388179, 4116.897077573055, 4122.969257685579, 2997.6252968378953, 3537.893863184109, 3557.7331700122336, 3559.75081744278, 3581.83881725323, 4418.270985287424, 4855.0, 5287.603429742746, 5322.7072511011875, 5357.491038351351, 4688.0, 4688.038952014829, 4690.554397332248, 4694.413198350207, 4711.929321060153, 5252.2384254282915, 5273.736313184326, 5746.569007324468, 5757.856053598652, 5759.222504961818, 3536.0982949347754, 3803.353429916893, 3806.3409440435325, 3885.941710874339, 3910.9804450977563, 5052.520010598987, 6083.479130217445, 6090.756369745205, 6106.511479081662, 6119.420139218562, 3834.367329390675, 3916.8433262669746, 3950.0322421006463, 3956.9604303956594, 3964.72246942717, 3751.643593858579, 3996.540397854226, 4006.959930400717, 4032.798360082043, 4039.565954086257, 4083.4079058536345, 4463.928657122332, 4682.484926658065, 4693.647976401783, 4693.6949098308505, 5421.322334708161, 5560.7219639017885, 5829.0, 5875.882482350329, 6036.921170203228, 1057.9576816927238, 1071.7106381277013, 1081.3944191252924, 1349.197227649547, 1363.3864760857655, 769.4882902869529, 845.5518575155055, 878.7232021913077, 880.6482050053265, 927.2257664849791, 4952.885600739877, 5015.724135172528, 5347.946520534822, 5471.316085489314, 5472.097103977799, 5133.460986596354, 5822.477401172315, 5929.37741537141, 5972.28189730117, 6019.428154325332, 4996.027363718582, 5110.514501122388, 5472.616916815785, 5486.0, 5557.221988921554, 2739.7671197948, 2909.6944820793933, 2927.282815710122, 3036.5748795168693, 3199.77601567888, 5457.653209120037, 6269.404406581368, 6274.498040156776, 6305.716242769086, 6324.525660575475, 5372.382176049804, 5884.0, 6176.104464852661, 6221.9377806222265, 6227.221597300338, 5511.53151982078, 5535.612507124462, 6235.563510554218, 6308.684565771693, 6318.6524741138755, 5094.077560278639, 5988.431099045583, 6032.366601506778, 6034.7284372202475, 6056.939430605637, 4817.397825271841, 5125.56484184429, 5250.317458730341, 5346.893062138658, 5952.136940143741, 5684.687342196219, 6199.907001395073, 6214.316425193316, 6264.968675156595, 6268.717907694256, 3703.1482758966126, 3948.8025598719373, 3969.6824254060184, 3983.103801644607, 3984.940225896556, 5805.738741756547, 5989.011813050798, 6004.309504406874, 6025.638461692312, 6042.5770196087615, 5775.0, 5809.302883653989, 5852.4147585241135, 5863.501602363847, 5865.677387743715, 5822.563307752021, 5898.793542226002, 5928.79249226275, 5930.52555795544, 5932.644041357532, 5012.423571289349, 5374.516293533601, 5505.494999775013, 5697.7720891165545, 5858.121281807763, 5109.386873575195, 5641.971790141187, 5838.854028649148, 5846.298444186725, 5952.369054876435, 5462.2856457609205, 5761.625494342854, 5780.768769249183, 5794.0, 5808.7095645218415], "value": 4192.293759714967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4667798980917, 608.9421504957028, 609.3875654966757, 668.218184723873, 722.8951801988715, 14229.786553201697, 14962.775558366606, 15188.316525756354, 15316.0, 15370.00094993826, 11699.473523691433, 12100.818487722669, 14664.560063198121, 14666.56000319992, 14670.339834707436, 826.42976346321, 853.6756032707563, 854.0050840770526, 856.6915910272297, 857.1642648417774, 673.2695025896908, 695.6938946863364, 703.806453225362, 834.6953362022879, 852.0542198160038, 889.5641135843423, 902.4269588811087, 902.5081330674798, 905.2079430498314, 909.963601455941, 740.474263273074, 899.4153800029967, 902.5532361481077, 903.6204793986476, 906.954652267384, 665.4044630056121, 667.7128834601119, 667.7996601019674, 668.8595394967062, 669.8124525132971, 13956.162630242117, 14000.859991400159, 14008.299585020708, 14100.506482273071, 14158.0, 14223.786643200361, 14368.13791172533, 14389.712205755826, 14435.783463248059, 14696.13425382051, 11891.345975971319, 11895.107866910017, 11950.701232469171, 11978.825258725139, 12074.879251207463, 3765.1151979284846, 3828.0, 3830.8659196927974, 3853.171568112841, 3950.6246906543834, 116037.0, 116812.0, 117310.0, 118931.4053429736, 120440.0, 11053.778924421467, 11128.33230006186, 11186.776264474827, 11191.439851231655, 11192.10463162945, 22855.428614284443, 22870.0, 22872.08511659515, 22905.656415153786, 23000.0, 7769.494982826098, 7801.141874393812, 7819.452638315263, 8022.679092836338, 8087.757367278991, 4258.68059895509, 4276.978615106905, 4361.171377438277, 4421.845235416745, 4423.292273236267, 3584.0860580551794, 3708.9443658345144, 3714.33142034431, 3715.8142092895246, 3720.553533575934, 654.0777503719733, 655.9406558408232, 657.7040331850686, 669.327326037339, 686.2759788423261, 539.1508374310476, 546.6801920876252, 620.8572028433396, 644.1947565543071, 678.9490788190807, 8221.506709597443, 9033.367664263438, 9055.18503334703, 9180.219681327162, 9437.669681561112, 657.7204688007578, 663.7278715726529, 667.1360588038502, 669.7957123077508, 675.7263308360122, 4232.746035237896, 4594.264917613166, 4629.70304880467, 4640.5823475886655, 4734.952650473451, 94460.0, 97133.0, 100941.0, 163076.0, 171673.0, 107074.0, 143947.0, 144126.0, 144917.0, 150126.0, 100063.0, 110879.44560277148, 120140.39929800294, 124381.37809311076, 126432.78186917822, 8593.8710919335, 8874.51190184546, 8972.506512141896, 8984.326175536991, 9196.54017299119, 68313.65843170752, 69419.0, 69909.50452477254, 70453.64773176101, 71521.0, 70206.29793701998, 89084.55457722669, 89430.0, 104502.0, 109352.0, 10330.070293673605, 12963.22220666763, 13211.537596184087, 13310.0, 13364.331783410596, 12868.935655321664, 14069.507567235098, 14728.484503042771, 14866.628334291729, 15032.398704051715, 11267.492962816857, 13697.657558561115, 13739.862601373858, 13743.450261989408, 13925.0, 12473.5010599575, 12749.725027497176, 13750.312484375941, 14276.57170284893, 14499.057561258907, 13246.536371226961, 13555.932220338835, 13579.86420135786, 13829.170249785046, 13956.651083722989, 10237.488125593542, 10322.819258200441, 11056.944715276371, 11089.33463992163, 11712.134995451652, 9079.046700096394, 10233.897661023593, 10298.3820970742, 10364.119049880845, 11572.479238434122], "value": 7742.803525925043, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 123.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 113.0, 152.0, 116.0, 120.0, 115.0, 115.0, 146.0, 116.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 208.0, 212.0, 199.0, 200.0, 199.0, 194.0, 196.0, 196.0], "value": 199.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 83.0, 86.0, 104.0, 65.0, 58.0, 60.0, 60.0, 81.0, 59.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 88.0, 84.0, 72.0, 71.0, 88.0, 69.0, 70.0, 87.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 87.0, 89.0, 85.0, 101.0, 114.0, 88.0, 95.0, 88.0, 86.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 131.0, 116.0, 94.0, 153.0, 153.0, 104.0, 152.0], "value": 118.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 82.0, 90.0, 92.0, 94.0, 74.0, 145.0, 146.0, 90.0], "value": 99.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 56.0, 56.0, 58.0, 58.0, 57.0, 57.0, 71.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 83.0, 76.0, 77.0, 69.0, 70.0, 69.0, 72.0, 70.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 94.0, 90.0, 89.0, 93.0, 111.0, 90.0, 84.0, 90.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 145.0, 146.0, 145.0, 144.0, 149.0, 159.0, 181.0, 148.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 183.0, 173.0, 197.0, 245.0, 217.0, 236.0, 185.0, 174.0, 181.0], "value": 201.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 71.0, 69.0, 68.0, 74.0, 69.0, 70.0, 71.0, 72.0], "value": 70.5, "unit": "score"}]}]} 00:08:53 INFO - Return code: 0 00:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:08:53 ERROR - # TBPL SUCCESS # 00:08:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:08:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:08:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:08:53 INFO - 2016-10-06 00:08:53.746 screenresolution[1671:11232] starting screenresolution argv=screenresolution get 00:08:53 INFO - 2016-10-06 00:08:53.749 screenresolution[1671:11232] Display 0: 1600x1200x32@60 00:08:53 INFO - 2016-10-06 00:08:53.755 screenresolution[1672:11235] starting screenresolution argv=screenresolution list 00:08:53 INFO - Available Modes on Display 0 00:08:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:08:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:08:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:08:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:08:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:08:53 INFO - Intel Iris: 00:08:53 INFO - Chipset Model: Intel Iris 00:08:53 INFO - Type: GPU 00:08:53 INFO - Bus: Built-In 00:08:53 INFO - VRAM (Dynamic, Max): 1536 MB 00:08:53 INFO - Vendor: Intel (0x8086) 00:08:53 INFO - Device ID: 0x0a2e 00:08:53 INFO - Revision ID: 0x0009 00:08:53 INFO - Displays: 00:08:53 INFO - Display: 00:08:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:08:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:08:53 INFO - Display Serial Number: 1600x1200 60 00:08:53 INFO - Main Display: Yes 00:08:53 INFO - Mirror: Off 00:08:53 INFO - Online: Yes 00:08:53 INFO - Rotation: Supported 00:08:53 INFO - Return code: 0 00:08:53 INFO - Running post-action listener: _resource_record_post_action 00:08:53 INFO - [mozharness: 2016-10-06 07:08:53.995816Z] Finished run-tests step (success) 00:08:53 INFO - Running post-run listener: _resource_record_post_run 00:08:54 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 43018752; Write bytes: 720212480; Read time: 484; Write time: 2353 00:08:54 INFO - TinderboxPrint: CPU usage
54.5% 00:08:54 INFO - TinderboxPrint: I/O read bytes / time
43,018,752 / 484 00:08:54 INFO - TinderboxPrint: I/O write bytes / time
720,212,480 / 2,353 00:08:54 INFO - TinderboxPrint: CPU idle
2,205.3 (45.5%) 00:08:54 INFO - TinderboxPrint: CPU system
979.4 (20.2%) 00:08:54 INFO - TinderboxPrint: CPU user
1,661.0 (34.3%) 00:08:54 INFO - TinderboxPrint: Swap in / out
447,856,640 / 0 00:08:54 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408562176; Write bytes: 410183168; Read time: 32129; Write time: 811 00:08:54 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 39102976; Write bytes: 308554752; Read time: 454; Write time: 1535 00:08:54 INFO - Running post-run listener: _upload_blobber_files 00:08:54 INFO - Blob upload gear active. 00:08:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:08:54 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 00:08:54 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:08:54 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:08:54 INFO - (blobuploader) - INFO - Open directory for files ... 00:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:08:55 INFO - (blobuploader) - INFO - Done attempting. 00:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:08:56 INFO - (blobuploader) - INFO - Done attempting. 00:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:08:59 INFO - (blobuploader) - INFO - Done attempting. 00:08:59 INFO - (blobuploader) - INFO - Iteration through files over. 00:08:59 INFO - Return code: 0 00:08:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:08:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:08:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc2d72a5ebb3c5acf399ecf33c55b5a37644903204d09e37499088f93b4a2784811897f0834ec58974211ba29aa19da9b36ab9315fa4da465107c58fddd2e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f9ee972a0123e969aefc62b93fea1bffd2f949b23d505e292024f351a1dab094e072e825e324afd72467b59df34d458367d8d80fad503c9c0c13506acbbd08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca1c7695b81581d222e725293569f90308c14d8d4f0d0ca22c993e720022592c23b123c9d02e2b84eafde107ec4c3578e036eb00777fa8a8450258c0d8b34e11"} 00:08:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:08:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:08:59 INFO - Contents: 00:08:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc2d72a5ebb3c5acf399ecf33c55b5a37644903204d09e37499088f93b4a2784811897f0834ec58974211ba29aa19da9b36ab9315fa4da465107c58fddd2e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f9ee972a0123e969aefc62b93fea1bffd2f949b23d505e292024f351a1dab094e072e825e324afd72467b59df34d458367d8d80fad503c9c0c13506acbbd08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca1c7695b81581d222e725293569f90308c14d8d4f0d0ca22c993e720022592c23b123c9d02e2b84eafde107ec4c3578e036eb00777fa8a8450258c0d8b34e11"} 00:08:59 INFO - Running post-run listener: copy_logs_to_upload_dir 00:08:59 INFO - Copying logs to upload dir... 00:08:59 INFO - mkdir: /builds/slave/test/build/upload/logs 00:08:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.606268 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 00:08:59.966028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 00:08:59.970248) ========= 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.mWdKhA7aRX/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.Azzz6JHaad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/Fx-Team/sha512/7cc2d72a5ebb3c5acf399ecf33c55b5a37644903204d09e37499088f93b4a2784811897f0834ec58974211ba29aa19da9b36ab9315fa4da465107c58fddd2e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f9ee972a0123e969aefc62b93fea1bffd2f949b23d505e292024f351a1dab094e072e825e324afd72467b59df34d458367d8d80fad503c9c0c13506acbbd08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca1c7695b81581d222e725293569f90308c14d8d4f0d0ca22c993e720022592c23b123c9d02e2b84eafde107ec4c3578e036eb00777fa8a8450258c0d8b34e11"} build_url:https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/ciGanXUdTIqty43qWIbiAQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc2d72a5ebb3c5acf399ecf33c55b5a37644903204d09e37499088f93b4a2784811897f0834ec58974211ba29aa19da9b36ab9315fa4da465107c58fddd2e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f9ee972a0123e969aefc62b93fea1bffd2f949b23d505e292024f351a1dab094e072e825e324afd72467b59df34d458367d8d80fad503c9c0c13506acbbd08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca1c7695b81581d222e725293569f90308c14d8d4f0d0ca22c993e720022592c23b123c9d02e2b84eafde107ec4c3578e036eb00777fa8a8450258c0d8b34e11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 00:09:00.005071) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:09:00.005358) ========= 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.mWdKhA7aRX/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.Azzz6JHaad/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005677 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:09:00.054402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 00:09:00.054698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 00:09:00.057224) ========= ========= Total master_lag: 6.72 =========