builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1476405176.23 results: success (0) buildid: 20161013161835 builduid: b3f7773dc43848f3b09b624bc3e7f313 revision: 6e0972198333bb988e80b598e7eca13396e3183b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.227879) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.228403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.228681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.320533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.320979) ========= 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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-13 17:32:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.04M=0.001s 2016-10-13 17:32:56 (8.04 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.456440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.456758) ========= 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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.022684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:56.505232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 17:32:56.505598) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6e0972198333bb988e80b598e7eca13396e3183b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6e0972198333bb988e80b598e7eca13396e3183b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-13 17:32:56,587 truncating revision to first 12 chars 2016-10-13 17:32:56,587 Setting DEBUG logging. 2016-10-13 17:32:56,587 attempt 1/10 2016-10-13 17:32:56,587 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6e0972198333?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 17:32:58,212 unpacking tar archive at: autoland-6e0972198333/testing/mozharness/ program finished with exit code 0 elapsedTime=1.874193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 17:32:58.402799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:58.403467) ========= script_repo_revision: 6e0972198333bb988e80b598e7eca13396e3183b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:58.404087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:58.404504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 17:32:58.423077) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-13 17:32:58.423433) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:32:58 INFO - MultiFileLogger online at 20161013 17:32:58 in /builds/slave/test 17:32:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:32:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:58 INFO - {'append_to_log': False, 17:32:58 INFO - 'base_work_dir': '/builds/slave/test', 17:32:58 INFO - 'blob_upload_branch': 'Autoland', 17:32:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:58 INFO - 'branch': 'Autoland', 17:32:58 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:58 INFO - 'config_files': ('talos/mac_config.py',), 17:32:58 INFO - 'default_actions': ('clobber', 17:32:58 INFO - 'read-buildbot-config', 17:32:58 INFO - 'download-and-extract', 17:32:58 INFO - 'populate-webroot', 17:32:58 INFO - 'create-virtualenv', 17:32:58 INFO - 'install', 17:32:58 INFO - 'run-tests'), 17:32:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:58 INFO - 'download_minidump_stackwalk': True, 17:32:58 INFO - 'download_symbols': 'ondemand', 17:32:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:58 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:58 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:58 INFO - 'installer_path': 'installer.exe', 17:32:58 INFO - 'log_level': 'info', 17:32:58 INFO - 'log_name': 'talos', 17:32:58 INFO - 'log_to_console': True, 17:32:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:32:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:32:58 INFO - 'opt_config_files': (), 17:32:58 INFO - 'pip_index': False, 17:32:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:32:58 INFO - 'cmd': ('bash', 17:32:58 INFO - '-c', 17:32:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:32:58 INFO - 'enabled': True, 17:32:58 INFO - 'halt_on_failure': False, 17:32:58 INFO - 'name': 'check_screen_resolution'},), 17:32:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:32:58 INFO - 'cmd': ('bash', 17:32:58 INFO - '-c', 17:32:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:32:58 INFO - 'enabled': True, 17:32:58 INFO - 'halt_on_failure': False, 17:32:58 INFO - 'name': 'check_screen_resolution'},), 17:32:58 INFO - 'run_cmd_checks_enabled': True, 17:32:58 INFO - 'sps_profile': False, 17:32:58 INFO - 'sps_profile_interval': 0, 17:32:58 INFO - 'suite': 'dromaeojs', 17:32:58 INFO - 'system_bits': '32', 17:32:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:58 INFO - 'title': 't-yosemite-r7-0375', 17:32:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:58 INFO - 'use_talos_json': True, 17:32:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:58 INFO - 'work_dir': 'build'} 17:32:58 INFO - [mozharness: 2016-10-14 00:32:58.621469Z] Running clobber step. 17:32:58 INFO - Running pre-action listener: _resource_record_pre_action 17:32:58 INFO - Running main action method: clobber 17:32:58 INFO - rmtree: /builds/slave/test/build 17:32:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:33:00 INFO - Running post-action listener: _resource_record_post_action 17:33:00 INFO - [mozharness: 2016-10-14 00:33:00.657392Z] Finished clobber step (success) 17:33:00 INFO - [mozharness: 2016-10-14 00:33:00.657508Z] Running read-buildbot-config step. 17:33:00 INFO - Running pre-action listener: _resource_record_pre_action 17:33:00 INFO - Running main action method: read_buildbot_config 17:33:00 INFO - Using buildbot properties: 17:33:00 INFO - { 17:33:00 INFO - "project": "", 17:33:00 INFO - "product": "firefox", 17:33:00 INFO - "script_repo_revision": "production", 17:33:00 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 17:33:00 INFO - "repository": "", 17:33:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 17:33:00 INFO - "buildid": "20161013161835", 17:33:00 INFO - "pgo_build": "False", 17:33:00 INFO - "basedir": "/builds/slave/test", 17:33:00 INFO - "buildnumber": 438, 17:33:00 INFO - "slavename": "t-yosemite-r7-0375", 17:33:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:33:00 INFO - "platform": "yosemite_r7", 17:33:00 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:33:00 INFO - "branch": "autoland", 17:33:00 INFO - "repo_path": "integration/autoland", 17:33:00 INFO - "revision": "6e0972198333bb988e80b598e7eca13396e3183b", 17:33:00 INFO - "stage_platform": "macosx64", 17:33:00 INFO - "builduid": "b3f7773dc43848f3b09b624bc3e7f313", 17:33:00 INFO - "slavebuilddir": "test" 17:33:00 INFO - } 17:33:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 17:33:00 INFO - Running post-action listener: _resource_record_post_action 17:33:00 INFO - [mozharness: 2016-10-14 00:33:00.660901Z] Finished read-buildbot-config step (success) 17:33:00 INFO - [mozharness: 2016-10-14 00:33:00.661002Z] Running download-and-extract step. 17:33:00 INFO - Running pre-action listener: _resource_record_pre_action 17:33:00 INFO - Running main action method: download_and_extract 17:33:00 INFO - mkdir: /builds/slave/test/build/tests 17:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:00 INFO - trying https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 17:33:00 INFO - Downloading https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/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 17:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/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 17:33:01 INFO - Downloaded 1199 bytes. 17:33:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:33:01 INFO - Using the following test package requirements: 17:33:01 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:33:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 17:33:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 17:33:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'jsshell-mac.zip'], 17:33:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 17:33:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:33:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 17:33:01 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 17:33:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 17:33:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:33:01 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 17:33:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:33:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:33:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:33:01 INFO - Fetch https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:33:01 INFO - Http code: 200 17:33:01 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 17:33:01 INFO - x-amz-cf-id: UnOaHAwh7koOEcI3XCoOZPCzaY6BNmMKjTkolEyAPMFakFc50HxHow== 17:33:01 INFO - x-amz-version-id: xrtHa9UkfDp.YYUB6.HDTATUbEGs71A7 17:33:02 INFO - Expected file size: 16515363 17:33:02 INFO - Obtained file size: 16515363 17:33:08 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 17:33:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:33:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:33:08 INFO - Fetch https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:33:09 INFO - Http code: 200 17:33:09 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 17:33:09 INFO - x-amz-cf-id: NlVrzmv-GT1XyrVS8-1NcuuOw-HMT6siSrlKTsF292440M6X0YwLqw== 17:33:09 INFO - x-amz-version-id: xrtHa9UkfDp.YYUB6.HDTATUbEGs71A7 17:33:09 INFO - Expected file size: 16515363 17:33:09 INFO - Obtained file size: 16515363 17:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 17:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 17:33:17 INFO - Http code: 200 17:33:17 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 17:33:17 INFO - x-amz-cf-id: EToCXYRkgJRAl9fdJzbgofxKbS-fbkF2loXDYCGwqc60SatGdbmGvQ== 17:33:17 INFO - x-amz-version-id: rOoaX4zshOmPXBYSL0TsYqm4shjzF5RE 17:33:17 INFO - Expected file size: 14409006 17:33:17 INFO - Obtained file size: 14409006 17:33: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')]} 17:33:17 INFO - trying https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 17:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/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 17:33:20 INFO - Downloaded 111667691 bytes. 17:33:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:33:20 INFO - mkdir: /builds/slave/test/properties 17:33:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:33:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:33:20 INFO - Contents: 17:33:20 INFO - build_url:https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:33:21 INFO - Running post-action listener: _resource_record_post_action 17:33:21 INFO - Running post-action listener: set_extra_try_arguments 17:33:21 INFO - [mozharness: 2016-10-14 00:33:21.355027Z] Finished download-and-extract step (success) 17:33:21 INFO - [mozharness: 2016-10-14 00:33:21.355166Z] Running populate-webroot step. 17:33:21 INFO - Running pre-action listener: _resource_record_pre_action 17:33:21 INFO - Running main action method: populate_webroot 17:33:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:33:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:33:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:33:21 INFO - '--tppagecycles', 17:33:21 INFO - '7'], 17:33:21 INFO - 'tests': ['tsvgm']}}, 17:33:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:33:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:33:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:33:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:33:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:33:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:33:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['damp', 'tps']}, 17:33:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'tests': ['damp', 'tps']}, 17:33:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['dromaeo_dom']}, 17:33:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:33:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['basic_compositor_video']}, 17:33:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:33:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['a11yr', 17:33:21 INFO - 'ts_paint', 17:33:21 INFO - 'tpaint', 17:33:21 INFO - 'sessionrestore', 17:33:21 INFO - 'sessionrestore_no_auto_restore', 17:33:21 INFO - 'tabpaint']}, 17:33:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tsvgx', 17:33:21 INFO - 'tsvgr_opacity', 17:33:21 INFO - 'tart', 17:33:21 INFO - 'tscrollx', 17:33:21 INFO - 'cart']}, 17:33:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:33:21 INFO - 'tsvgr_opacity', 17:33:21 INFO - 'tart', 17:33:21 INFO - 'tscrollx', 17:33:21 INFO - 'cart']}, 17:33:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s'], 17:33:21 INFO - 'tests': ['tp5o']}, 17:33:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'tests': ['tp5o']}, 17:33:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'talos_options': ['--disable-e10s', 17:33:21 INFO - '--xperf_path', 17:33:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:21 INFO - 'tests': ['tp5n']}, 17:33:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:33:21 INFO - 'talos_options': ['--xperf_path', 17:33:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:21 INFO - 'tests': ['tp5n']}}, 17:33:21 INFO - 'talos.zip': {'path': '', 17:33:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:33:21 INFO - Running post-action listener: _resource_record_post_action 17:33:21 INFO - [mozharness: 2016-10-14 00:33:21.374483Z] Finished populate-webroot step (success) 17:33:21 INFO - [mozharness: 2016-10-14 00:33:21.374620Z] Running create-virtualenv step. 17:33:21 INFO - Running pre-action listener: _resource_record_pre_action 17:33:21 INFO - Running main action method: create_virtualenv 17:33:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:33:21 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 17:33:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:33:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:33:21 INFO - Using real prefix '/tools/python27' 17:33:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:33:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:33:25 INFO - Installing pip.................done. 17:33:25 INFO - Return code: 0 17:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:33:25 INFO - Reading from file tmpfile_stdout 17:33:25 INFO - Output received: 17:33:25 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) 17:33:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:33:25 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')]} 17:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 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')]} 17:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:25 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 17:33:25 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 17:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:25 INFO - 'HOME': '/Users/cltbld', 17:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:25 INFO - 'LOGNAME': 'cltbld', 17:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:25 INFO - 'MOZ_NO_REMOTE': '1', 17:33:25 INFO - 'NO_EM_RESTART': '1', 17:33:25 INFO - 'PAGER': '/bin/cat', 17:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:25 INFO - 'PWD': '/builds/slave/test', 17:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:25 INFO - 'SHELL': '/bin/bash', 17:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:25 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:25 INFO - 'USER': 'cltbld', 17:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:25 INFO - 'XPC_FLAGS': '0x0', 17:33:25 INFO - 'XPC_SERVICE_NAME': '0', 17:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:25 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 17:33:25 INFO - Cleaning up... 17:33:25 INFO - Return code: 0 17:33:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:33:25 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')]} 17:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 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')]} 17:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:25 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 17:33:25 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 17:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:25 INFO - 'HOME': '/Users/cltbld', 17:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:25 INFO - 'LOGNAME': 'cltbld', 17:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:25 INFO - 'MOZ_NO_REMOTE': '1', 17:33:25 INFO - 'NO_EM_RESTART': '1', 17:33:25 INFO - 'PAGER': '/bin/cat', 17:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:25 INFO - 'PWD': '/builds/slave/test', 17:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:25 INFO - 'SHELL': '/bin/bash', 17:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:25 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:25 INFO - 'USER': 'cltbld', 17:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:25 INFO - 'XPC_FLAGS': '0x0', 17:33:25 INFO - 'XPC_SERVICE_NAME': '0', 17:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:25 INFO - Downloading/unpacking psutil>=3.1.1 17:33: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 17:33: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 17:33: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 17:33: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 17:33: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 17:33: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 17:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:33:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:33:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:33:29 INFO - Installing collected packages: psutil 17:33:29 INFO - Running setup.py install for psutil 17:33:29 INFO - building 'psutil._psutil_osx' extension 17:33:29 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 17:33:29 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 17:33:29 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 17:33:29 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 17:33:29 INFO - building 'psutil._psutil_posix' extension 17:33:29 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 17:33:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:33:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:33:29 INFO - ^ 17:33:29 INFO - 1 warning generated. 17:33:29 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 17:33:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:33:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:33:30 INFO - Successfully installed psutil 17:33:30 INFO - Cleaning up... 17:33:30 INFO - Return code: 0 17:33:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:33:30 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')]} 17:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:30 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')]} 17:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:30 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:30 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 17:33:30 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 17:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:30 INFO - 'HOME': '/Users/cltbld', 17:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:30 INFO - 'LOGNAME': 'cltbld', 17:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:30 INFO - 'MOZ_NO_REMOTE': '1', 17:33:30 INFO - 'NO_EM_RESTART': '1', 17:33:30 INFO - 'PAGER': '/bin/cat', 17:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:30 INFO - 'PWD': '/builds/slave/test', 17:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:30 INFO - 'SHELL': '/bin/bash', 17:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:30 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:30 INFO - 'USER': 'cltbld', 17:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:30 INFO - 'XPC_FLAGS': '0x0', 17:33:30 INFO - 'XPC_SERVICE_NAME': '0', 17:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:33:30 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 17:33:30 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 17:33:30 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 17:33:30 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 17:33:30 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 17:33:30 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 17:33:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:33:32 INFO - Installing collected packages: mozsystemmonitor 17:33:32 INFO - Running setup.py install for mozsystemmonitor 17:33:33 INFO - Successfully installed mozsystemmonitor 17:33:33 INFO - Cleaning up... 17:33:33 INFO - Return code: 0 17:33:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:33:33 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')]} 17:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:33 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')]} 17:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:33 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:33 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 17:33:33 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 17:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:33 INFO - 'HOME': '/Users/cltbld', 17:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:33 INFO - 'LOGNAME': 'cltbld', 17:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:33 INFO - 'MOZ_NO_REMOTE': '1', 17:33:33 INFO - 'NO_EM_RESTART': '1', 17:33:33 INFO - 'PAGER': '/bin/cat', 17:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:33 INFO - 'PWD': '/builds/slave/test', 17:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:33 INFO - 'SHELL': '/bin/bash', 17:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:33 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:33 INFO - 'USER': 'cltbld', 17:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:33 INFO - 'XPC_FLAGS': '0x0', 17:33:33 INFO - 'XPC_SERVICE_NAME': '0', 17:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:33 INFO - Downloading/unpacking jsonschema==2.5.1 17:33:33 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 17:33:33 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 17:33:33 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 17:33:33 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 17:33:33 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 17:33:33 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 17:33:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:33:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:33:35 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 17:33:35 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 17:33:35 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 17:33:35 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 17:33:35 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 17:33:35 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 17:33:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:33:36 INFO - warning: no files found matching '*.txt' 17:33:36 INFO - no previously-included directories found matching 'build' 17:33:36 INFO - no previously-included directories found matching 'dist' 17:33:36 INFO - no previously-included directories found matching '.git*' 17:33:36 INFO - Installing collected packages: jsonschema, functools32 17:33:36 INFO - Running setup.py install for functools32 17:33:36 INFO - warning: no files found matching '*.txt' 17:33:36 INFO - no previously-included directories found matching 'build' 17:33:36 INFO - no previously-included directories found matching 'dist' 17:33:36 INFO - no previously-included directories found matching '.git*' 17:33:36 INFO - Successfully installed jsonschema functools32 17:33:36 INFO - Cleaning up... 17:33:36 INFO - Return code: 0 17:33:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:33:36 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')]} 17:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:36 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')]} 17:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:36 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:36 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 17:33:36 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 17:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:36 INFO - 'HOME': '/Users/cltbld', 17:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:36 INFO - 'LOGNAME': 'cltbld', 17:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:36 INFO - 'MOZ_NO_REMOTE': '1', 17:33:36 INFO - 'NO_EM_RESTART': '1', 17:33:36 INFO - 'PAGER': '/bin/cat', 17:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:36 INFO - 'PWD': '/builds/slave/test', 17:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:36 INFO - 'SHELL': '/bin/bash', 17:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:36 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:36 INFO - 'USER': 'cltbld', 17:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:36 INFO - 'XPC_FLAGS': '0x0', 17:33:36 INFO - 'XPC_SERVICE_NAME': '0', 17:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:33:36 INFO - Cleaning up... 17:33:36 INFO - Return code: 0 17:33:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:33:36 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')]} 17:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:36 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')]} 17:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:36 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:36 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 17:33:36 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 17:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:36 INFO - 'HOME': '/Users/cltbld', 17:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:36 INFO - 'LOGNAME': 'cltbld', 17:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:36 INFO - 'MOZ_NO_REMOTE': '1', 17:33:36 INFO - 'NO_EM_RESTART': '1', 17:33:36 INFO - 'PAGER': '/bin/cat', 17:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:36 INFO - 'PWD': '/builds/slave/test', 17:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:36 INFO - 'SHELL': '/bin/bash', 17:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:37 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:37 INFO - 'USER': 'cltbld', 17:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:37 INFO - 'XPC_FLAGS': '0x0', 17:33:37 INFO - 'XPC_SERVICE_NAME': '0', 17:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 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 17:33:37 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 17:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 17:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:33:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:33:39 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 17:33:39 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 17:33:39 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 17:33:39 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 17:33:39 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 17:33:39 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 17:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:40 INFO - Downloading docopt-0.6.1.tar.gz 17:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 17:33:40 INFO - Running setup.py install for blobuploader 17:33:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:33:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:33:41 INFO - Running setup.py install for requests 17:33:41 INFO - Running setup.py install for docopt 17:33:41 INFO - Successfully installed blobuploader requests docopt 17:33:41 INFO - Cleaning up... 17:33:41 INFO - Return code: 0 17:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33: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')]} 17:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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')]} 17:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:41 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:41 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 17:33:41 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 17:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:41 INFO - 'HOME': '/Users/cltbld', 17:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:41 INFO - 'LOGNAME': 'cltbld', 17:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:41 INFO - 'MOZ_NO_REMOTE': '1', 17:33:41 INFO - 'NO_EM_RESTART': '1', 17:33:41 INFO - 'PAGER': '/bin/cat', 17:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:41 INFO - 'PWD': '/builds/slave/test', 17:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:41 INFO - 'SHELL': '/bin/bash', 17:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:41 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:41 INFO - 'USER': 'cltbld', 17:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:41 INFO - 'XPC_FLAGS': '0x0', 17:33:41 INFO - 'XPC_SERVICE_NAME': '0', 17:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-IslZUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-0kbK3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-bd_IUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-2FzxyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MDxiOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-llccXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4rq8YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-So9GL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zkvFvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-55iFzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-7wYOLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-U8dkpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-N_ccWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-xBufIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-23KDCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5_C8pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tpfyQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:33:43 INFO - Running setup.py install for manifestparser 17:33:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:33:44 INFO - Running setup.py install for mozcrash 17:33:44 INFO - Running setup.py install for mozdebug 17:33:44 INFO - Running setup.py install for mozdevice 17:33:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:33:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:33:44 INFO - Running setup.py install for mozfile 17:33:44 INFO - Running setup.py install for mozhttpd 17:33:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:33:44 INFO - Running setup.py install for mozinfo 17:33:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:33:44 INFO - Running setup.py install for mozInstall 17:33:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Running setup.py install for mozleak 17:33:45 INFO - Running setup.py install for mozlog 17:33:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Running setup.py install for moznetwork 17:33:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Running setup.py install for mozprocess 17:33:45 INFO - Running setup.py install for mozprofile 17:33:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:33:45 INFO - Running setup.py install for mozrunner 17:33:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Running setup.py install for mozscreenshot 17:33:46 INFO - Running setup.py install for moztest 17:33:46 INFO - Running setup.py install for mozversion 17:33:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:33:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:33:46 INFO - Cleaning up... 17:33:46 INFO - Return code: 0 17:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:46 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')]} 17:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:46 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')]} 17:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:46 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:46 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 17:33:46 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 17:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:46 INFO - 'HOME': '/Users/cltbld', 17:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:46 INFO - 'LOGNAME': 'cltbld', 17:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:46 INFO - 'MOZ_NO_REMOTE': '1', 17:33:46 INFO - 'NO_EM_RESTART': '1', 17:33:46 INFO - 'PAGER': '/bin/cat', 17:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:46 INFO - 'PWD': '/builds/slave/test', 17:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:46 INFO - 'SHELL': '/bin/bash', 17:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:46 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:46 INFO - 'USER': 'cltbld', 17:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:46 INFO - 'XPC_FLAGS': '0x0', 17:33:46 INFO - 'XPC_SERVICE_NAME': '0', 17:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-M2CzlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:46 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)) 17:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Z_5XZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5s_Fwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ld3KmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-eMnpOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-689H1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-175vF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dWiz7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-gScTFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-N4RU9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lM5ads-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:47 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)) 17:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ukqu91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SBQ9nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-S2nEzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1N9d_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Q459uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:48 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)) 17:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-acJfc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:48 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)) 17:33:48 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)) 17:33:48 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)) 17:33:48 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)) 17:33:48 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)) 17:33:48 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)) 17:33:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:51 INFO - Downloading blessings-1.6.tar.gz 17:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:33:51 INFO - Installing collected packages: blessings 17:33:51 INFO - Running setup.py install for blessings 17:33:51 INFO - Successfully installed blessings 17:33:51 INFO - Cleaning up... 17:33:51 INFO - Return code: 0 17:33:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:51 INFO - Reading from file tmpfile_stdout 17:33:51 INFO - Current package versions: 17:33:51 INFO - blessings == 1.6 17:33:51 INFO - blobuploader == 1.2.4 17:33:51 INFO - docopt == 0.6.1 17:33:51 INFO - functools32 == 3.2.3-2 17:33:51 INFO - jsonschema == 2.5.1 17:33:51 INFO - manifestparser == 1.1 17:33:51 INFO - mozInstall == 1.12 17:33:51 INFO - mozcrash == 0.17 17:33:51 INFO - mozdebug == 0.1 17:33:51 INFO - mozdevice == 0.48 17:33:51 INFO - mozfile == 1.2 17:33:51 INFO - mozhttpd == 0.7 17:33:51 INFO - mozinfo == 0.9 17:33:51 INFO - mozleak == 0.1 17:33:51 INFO - mozlog == 3.4 17:33:51 INFO - moznetwork == 0.27 17:33:51 INFO - mozprocess == 0.23 17:33:51 INFO - mozprofile == 0.28 17:33:51 INFO - mozrunner == 6.12 17:33:51 INFO - mozscreenshot == 0.1 17:33:51 INFO - mozsystemmonitor == 0.3 17:33:51 INFO - moztest == 0.7 17:33:51 INFO - mozversion == 1.4 17:33:51 INFO - psutil == 3.1.1 17:33:51 INFO - requests == 1.2.3 17:33:51 INFO - wsgiref == 0.1.2 17:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:52 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:52 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 17:33:52 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 17:33:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:52 INFO - 'HOME': '/Users/cltbld', 17:33:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:52 INFO - 'LOGNAME': 'cltbld', 17:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:52 INFO - 'MOZ_NO_REMOTE': '1', 17:33:52 INFO - 'NO_EM_RESTART': '1', 17:33:52 INFO - 'PAGER': '/bin/cat', 17:33:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:52 INFO - 'PWD': '/builds/slave/test', 17:33:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:52 INFO - 'SHELL': '/bin/bash', 17:33:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:52 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:52 INFO - 'USER': 'cltbld', 17:33:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:52 INFO - 'XPC_FLAGS': '0x0', 17:33:52 INFO - 'XPC_SERVICE_NAME': '0', 17:33:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 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)) 17:33:53 INFO - Cleaning up... 17:33:53 INFO - Return code: 0 17:33:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:33:53 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')]} 17:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:53 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')]} 17:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:53 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 0x10542f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053a5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0b3496b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, '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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:33:53 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 17:33:53 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 17:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:53 INFO - 'HOME': '/Users/cltbld', 17:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:53 INFO - 'LOGNAME': 'cltbld', 17:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:53 INFO - 'MOZ_NO_REMOTE': '1', 17:33:53 INFO - 'NO_EM_RESTART': '1', 17:33:53 INFO - 'PAGER': '/bin/cat', 17:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:53 INFO - 'PWD': '/builds/slave/test', 17:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:53 INFO - 'SHELL': '/bin/bash', 17:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:33:53 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:53 INFO - 'USER': 'cltbld', 17:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:53 INFO - 'XPC_FLAGS': '0x0', 17:33:53 INFO - 'XPC_SERVICE_NAME': '0', 17:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:33:53 INFO - Cleaning up... 17:33:53 INFO - Return code: 0 17:33:53 INFO - Running post-action listener: _resource_record_post_action 17:33:53 INFO - Running post-action listener: _start_resource_monitoring 17:33:53 INFO - Starting resource monitoring. 17:33:53 INFO - [mozharness: 2016-10-14 00:33:53.801384Z] Finished create-virtualenv step (success) 17:33:53 INFO - [mozharness: 2016-10-14 00:33:53.802393Z] Running install step. 17:33:53 INFO - Running pre-action listener: _resource_record_pre_action 17:33:53 INFO - Running main action method: install 17:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:54 INFO - Reading from file tmpfile_stdout 17:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:33:54 INFO - Reading from file tmpfile_stdout 17:33:54 INFO - Output received: 17:33:54 INFO - Usage: mozinstall [options] installer 17:33:54 INFO - Options: 17:33:54 INFO - -h, --help show this help message and exit 17:33:54 INFO - -d DEST, --destination=DEST 17:33:54 INFO - Directory to install application into. [default: 17:33:54 INFO - "/builds/slave/test"] 17:33:54 INFO - --app=APP Application being installed. [default: firefox] 17:33:54 INFO - mkdir: /builds/slave/test/build/application 17:33:54 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'] 17:33:54 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 17:34:29 INFO - Reading from file tmpfile_stdout 17:34:29 INFO - Output received: 17:34:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:34:29 INFO - Running post-action listener: _resource_record_post_action 17:34:29 INFO - [mozharness: 2016-10-14 00:34:29.139949Z] Finished install step (success) 17:34:29 INFO - [mozharness: 2016-10-14 00:34:29.140097Z] Running run-tests step. 17:34:29 INFO - Running pre-action listener: _resource_record_pre_action 17:34:29 INFO - Running main action method: run_tests 17:34:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:34:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:34:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:34:29 INFO - 2016-10-13 17:34:29.154 screenresolution[2228:26462] starting screenresolution argv=screenresolution get 17:34:29 INFO - 2016-10-13 17:34:29.157 screenresolution[2228:26462] Display 0: 1600x1200x32@60 17:34:29 INFO - 2016-10-13 17:34:29.163 screenresolution[2229:26464] starting screenresolution argv=screenresolution list 17:34:29 INFO - Available Modes on Display 0 17:34:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:34:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:34:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:34:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:34:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:34:29 INFO - Intel Iris: 17:34:29 INFO - Chipset Model: Intel Iris 17:34:29 INFO - Type: GPU 17:34:29 INFO - Bus: Built-In 17:34:29 INFO - VRAM (Dynamic, Max): 1536 MB 17:34:29 INFO - Vendor: Intel (0x8086) 17:34:29 INFO - Device ID: 0x0a2e 17:34:29 INFO - Revision ID: 0x0009 17:34:29 INFO - Displays: 17:34:29 INFO - Display: 17:34:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:34:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:34:29 INFO - Display Serial Number: 1600x1200 60 17:34:29 INFO - Main Display: Yes 17:34:29 INFO - Mirror: Off 17:34:29 INFO - Online: Yes 17:34:29 INFO - Rotation: Supported 17:34:29 INFO - Return code: 0 17:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:34:29 INFO - Python 2.7.3 17:34:29 INFO - Return code: 0 17:34:29 INFO - grabbing minidump binary from tooltool 17:34:29 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')]} 17:34:29 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 0x105243d30>, '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 0x105069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10523bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:34:29 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 17:34:29 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 17:34:29 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 17:34:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:34:29 INFO - Return code: 0 17:34:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:34:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:34:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:34:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:34:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3d4tsAAUEQ/Render', 17:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:29 INFO - 'HOME': '/Users/cltbld', 17:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:29 INFO - 'LOGNAME': 'cltbld', 17:34:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:34:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:29 INFO - 'MOZ_NO_REMOTE': '1', 17:34:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:34:29 INFO - 'NO_EM_RESTART': '1', 17:34:29 INFO - 'PAGER': '/bin/cat', 17:34:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:29 INFO - 'PWD': '/builds/slave/test', 17:34:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:29 INFO - 'SHELL': '/bin/bash', 17:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YLEUCRjj0a/Listeners', 17:34:29 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:29 INFO - 'USER': 'cltbld', 17:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:29 INFO - 'XPC_FLAGS': '0x0', 17:34:29 INFO - 'XPC_SERVICE_NAME': '0', 17:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:34:29 INFO - mozversion application_buildid: 20161013161835 17:34:29 INFO - mozversion application_changeset: 6e0972198333bb988e80b598e7eca13396e3183b 17:34:29 INFO - mozversion application_display_name: Nightly 17:34:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:34:29 INFO - mozversion application_name: Firefox 17:34:29 INFO - mozversion application_remotingname: firefox 17:34:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:34:29 INFO - mozversion application_vendor: Mozilla 17:34:29 INFO - mozversion application_version: 52.0a1 17:34:29 INFO - mozversion platform_buildid: 20161013161835 17:34:29 INFO - mozversion platform_changeset: 6e0972198333bb988e80b598e7eca13396e3183b 17:34:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:34:29 INFO - mozversion platform_version: 52.0a1 17:34:29 INFO - using testdate: 1476405269 17:34:29 INFO - actual date: 1476405269 17:34:29 INFO - starting webserver on 'localhost:59947' 17:34:29 INFO - SUITE-START | Running 2 tests 17:34:29 INFO - TEST-START | dromaeo_css 17:34:29 INFO - operating with platform_type : mac_ 17:34:29 INFO - Initialising browser for dromaeo_css test... 17:34:29 INFO - TEST-INFO | started process 2239 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpPpAfE7/profile http://localhost:59947/getInfo.html) 17:34:32 INFO - PROCESS | 2239 | __metrics Screen width/height:1600/1200 17:34:32 INFO - PROCESS | 2239 | colorDepth:24 17:34:32 INFO - PROCESS | 2239 | Browser inner width/height: 1024/689 17:34:32 INFO - PROCESS | 2239 | __metrics 17:34:32 INFO - PROCESS | 2239 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:34:32 INFO - PROCESS | 2239 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:34:33 INFO - TEST-INFO | 2239: exit 0 17:34:33 INFO - Browser initialized. 17:34:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:34:33 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpPpAfE7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:45 INFO - PROCESS | 2241 | RSS: Main: 251584512 17:34:45 INFO - PROCESS | 2241 | 17:35:36 INFO - PROCESS | 2241 | 1476405336556 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] 17:37:49 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59947/tests/dromaeo/cssquery-ext.html) 17:37:51 INFO - PROCESS | 2241 | RSS: Main: 420708352 17:37:51 INFO - PROCESS | 2241 | 17:40:53 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59947/tests/dromaeo/cssquery-ext.html (next: http://localhost:59947/tests/dromaeo/cssquery-jquery.html) 17:40:54 INFO - PROCESS | 2241 | RSS: Main: 380153856 17:40:54 INFO - PROCESS | 2241 | 17:43:57 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59947/tests/dromaeo/cssquery-mootools.html) 17:43:57 INFO - PROCESS | 2241 | RSS: Main: 374104064 17:43:57 INFO - PROCESS | 2241 | 17:47:00 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59947/tests/dromaeo/cssquery-prototype.html) 17:47:00 INFO - PROCESS | 2241 | RSS: Main: 361517056 17:47:00 INFO - PROCESS | 2241 | 17:50:04 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59947/tests/dromaeo/cssquery-yui.html) 17:50:04 INFO - PROCESS | 2241 | RSS: Main: 343908352 17:50:04 INFO - PROCESS | 2241 | 17:53:07 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59947/tests/dromaeo/cssquery-yui.html (next: http://localhost:59947/tests/dromaeo/cssquery-dojo.html) 17:53:08 INFO - PROCESS | 2241 | RSS: Main: 417140736 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | __start_tp_report 17:53:08 INFO - PROCESS | 2241 | _x_x_mozilla_page_load 17:53:08 INFO - PROCESS | 2241 | _x_x_mozilla_page_load_details 17:53:08 INFO - PROCESS | 2241 | |i|pagename|runs| 17:53:08 INFO - PROCESS | 2241 | |0;dojo.html;2915.46063978164;3235.158858696738;3237.5953005874253;3283.5238890360915;3286.704196622305;5464.863378415542;5608.298962629671;5616.9157462638095;5664.688442135681;5721.370649228586;5620.156976453534;5647.040003199456;5654.858628534289;5663.122216056508;5667.603267771257;5111.6166287528495;5131.7434128293435;5151.562117220041;5197.454267301917;5199.324087868572;5199.220116982445;5234.7120908350025;5236.162214045753;5240.554552862992;5245.31810864589;5107.616928730342;5165.63840531163;5169.405518365398;5205.531502164805;5219.060569097561;5245.4754524547625;5254.97372513135;5264.394594621591;5278.524932756032;5303.814366497154;5024.095662780698;5038.974805125988;5098.133317336062;5172.327597412313;5189.299444574972;4701.905961880743;5507.228987941691;5577.05190117681;5578;5630.605857589971;6174;6176.536759743038;6177.876442471171;6182.505399568069;6188.721507532126;5998.280206375263;6042.154098426224;6224.595401298901;6275.7175927082935;6278.434940855299;5648.039833228361;5726.31284245889;5728.083506638918;5738.913916291259;5804.65172089676;6239.844003899939;6287.842803929847;6295.685215739195;6303.558750887486;6310.5898116622275;5957.970210149008;6112.083187521818;6115.939717725866;6129.417705317987;6137.987232106652;6093.2326056351785;6107.674343494607;6123.557704288865;6135.1408007826785;6236.937630623635;6160.199174107337;6174.691265436711;6176.81469555914;6177.135201071854;6182.412670796357;6166.660833654192;6185.84535386619;6202.193714817045;6203.410675985864;6213.316535181127;4730.219513780256;4820.108279968147;4833.4441539223435;4839.080574690868;4857.854264372075;4398.362237475548;4402.163588918095;4425.889352766142;4429.55704429561;4447.221736196153;4780.306855505932;5578.442155784389;5608.523275521545;5613.073842815971;5631.465010823965;6077.3314935357075;6084.6349219047;6103.2164526668375;6220.098085777537;6224.968875155686;5571.275734154615;5636.3799982002765;5648.689322087324;5701.572382071278;5832.3292821326095;5318.973405133027;5330.38700549434;5336.092864213016;5342.1452567589;5345.091334473149;5844.678542680023;6176.629402235881;6238.65687387189;6246.094316324107;6256.749730010931;4804.615630749601;6111.135969295249;6114.054067497468;6126.663033533198;6182.289036760651;6195.845103872259;6212.47193988516;6238.625682459067;6240;6265.96867015662;6123.479504242011;6125.816225513242;6130.386961303834;6133.570650054453;6142.416470435302;6062.060380641008;6122.510199183966;6125.295591006913;6182.227221597301;6234.906476402948;5964.284285885548;6094.561897584374;6098.855844323317;6108.463491842691;6135.926212912812;6026.517878569792;6063.151158837854;6065.514758819372;6078.635281883101;6086.969565152146;5718.370979192368;5795.985702501961;5841.50347220491;5869;5919.4080591940465;5869;5871.794487192928;5905.202797622438;5956.791512297049;6003.279606447254;5647.661140331593;5660.716964151694;5688.288963879515;5748.367679555329;5769.94230057694 17:53:08 INFO - PROCESS | 2241 | |1;ext.html;456.24719213298056;472.7021976155021;501.09052070492055;510.8569600511858;531.4764956517827;27078.593821092676;31053.223669408275;32053;32111.51832722511;32271.19322016948;39573.60426395735;41552;42517.7874110629;44774.20903163878;45006;8384.748457546284;9494.52527373632;9667.419954802734;9668.758281042996;9675.612975480972;9507.477088760115;9604.759881002961;9607.711768646952;9615.855762163537;9639.08428699276;9629.037096290385;9660.468674222915;9661.710148695514;9679.177269932065;9693.321467497279;9471.431714097176;9563.330566860323;9613.375130616487;9642.035796420301;9676.129148376645;8272.214139656722;9598.808023839554;9618.134367906852;9624.615015399375;9642.180414664763;39169.41245881314;39573.80213098916;39596.40605390922;39761.40357894634;39796.00509987245;2817.619621351112;3412.368711788327;3587.617990834403;3631.2918980798754;3753.7560058596105;30145.246368840955;30626.38747225065;31374.843125784453;31387;31485.685143148505;3204.1829333520036;3262.8042317461027;3300.8679652813858;3330.0675810773023;3334;475640.62179689226;476568;476619;477148;483744;59402.62389504371;59842;59892.10161847576;59892.70053649704;60045.699771501735;62608.686956564925;62707.05939410913;62761;62791.6860415695;62953.68523157355;15718.685626287639;15784;15983.760243596354;16025.839741602667;16055.357785688442;11972.940135299443;12019.038476922;12019.639410817515;12034.277943323254;12052.457639406248;13249.602511924657;14138.575842724735;16661.00033997964;16946.406875759534;16983.660326793393;4466.955330446719;4913.128811070807;5888.587798854039;6003.849903752441;6391.616503009835;829.4276948905236;971.3589031239349;976.1068622210739;1053.7418332508585;1054.2093429927554;25753.74246257551;27011.459770804475;29195;29198.978035768647;29446.263843404085;981.2983716642492;1114.3202646385698;1133.2936034962224;1148.4831825678477;1150.919435639514;11496.367699776425;14628.268586570628;15061.322240499203;15157.72634104893;15493.302801373966;556958.165020192;615374;616694;617154;617630;56410;56477.43522564722;56489.58776030632;56589.86820263572;56878.86242275214;1177.605502156787;1223.2477026628737;1224.7428040111677;1275.1583954590112;1350.0414705559162;29448.852755736083;29931.431187364542;30339.696603033688;30366.240843979078;30598;48327;49000;49023.77440564014;49063.528094157235;49221;411211.88788111735;412082;412330;412933;414542;25445.87277063603;25931.61102583425;26156.215313540622;26492.602610961236;26796;45641.77179114083;45788.08423831438;46016.46909420014;46525.302120467546;47177.29234061423;37919;38158.809205953796;38414.900373104356;38898.80550597229;39274.01814954649;37948.81025594854;39364.409533856444;39404.605953940096;41159;42593;37748.98008159395;38651;39261.41107883327;39532.60467395404;40300.19399611933;39248.411273830345;39300.803495982334;39467.80266098651;40450;40733.59266407417;29946.550801737554;30591.847040764653;30849.383012339178;31021.224469387544;31615.525767113973 17:53:08 INFO - PROCESS | 2241 | |2;jquery.html;331.71472533621096;360.36215897860785;360.6087395176235;366.80375998840617;392.43293440977783;15024.624384390396;15442.536723898287;18377.816221837777;19665.803341966577;20647.58704825906;19717.605647887034;20109.39671809848;20584.588308233826;20878.791212087912;20959.58080838386;5501.614886957915;6018.8495287617725;6079.726412311435;6081.847953801146;6104.847378815521;4178.164367126572;4396.7361958282445;5930.940690593104;6082.9391706082815;6376.713047912832;6574.802755917306;6728.899066514006;6733.091032710595;6737.258901520829;6747.898781518281;6359.109724638554;6561.737530498798;6607;6622.73509059637;6630.966845165792;4931.7040977541465;5538.861528461821;5717.914231286534;5738.885222295572;5742.856428589277;25697.357566060997;25769.484610307878;25795.226143215546;25933.22200333993;26124.346891327677;1972.5068732816796;1998.2906068345674;2119.6502577074916;2204.6252137136726;2225.5326381459913;9793.412395256308;11023.25999820077;11075;11105.944470277596;15947.521574352671;1823.1795691938548;1824.963500729978;1906.780720217179;1941.9708704369446;1949.3274820187012;114304;131114;135029;135051.32474337565;136036.9594456084;10932.781344373068;11324.377159256155;11369.488373023234;11373.715657108638;11554.711132221593;12733.490660373482;13084.934575327063;13101.803472947913;13269.336533173302;14001.29993500321;8086.070101938352;8144.837103257902;8225.519406506886;8315;8393.24460798531;6653.2681405045405;7987.68049278034;8007.439479236397;8147.226013528705;8177.754667359989;4064.3293856513346;4235.089455767024;4245.426867372927;4399.912001759947;4569.177548041384;1696.3723422333815;1705.7270836666073;1785.3929663914332;1838.1268897273956;1842.3920106364867;822.8313195794967;854.9444286121383;897.6858099665066;980.1570649241789;1004.1715584642699;17641.470755877086;20755.481112972295;20845.68731469029;21415.892920535298;21836.781632183793;849.7466237299933;854.1117238072335;872.4808738800403;881.405051590174;918.7197904639149;10655.344249964024;10943.398113103856;10960.013598776148;10984.791672915973;11023.95272449116;524992;559045;570281;602321;612857;132196;135625.6437435613;135807.32096339454;136685;141285;937.2221056523069;981.7300242433388;985.9852102218473;986.5166068626178;996.7956568903357;18541.536461588566;18899.622007560047;18930.810691892904;19263;19268.518287042934;33062.83468582642;39642.60357396389;54010.45989540211;55259.17111243415;56739;73819.63090184514;78067.60966195133;81943;82853.58573207336;83021;7576.356009739234;7832.334251588451;7871.567063811545;8000.719974800854;8068.878966815385;11502.884971150515;12219.208463832445;12287.262764234174;12390.070744694003;12498.312592807482;5300.1519756838725;9419.62321507132;10548.894511054792;10578.312409693346;10766.676999690022;10181.694549163536;10526.736831578966;10629.734256643645;11191.776164476827;11292.096632269562;11047.171462140212;11133.55465781392;11550.59572914944;11557.768844622893;11824.527018919147;6916.308369163044;7139.178994415501;7194.892076618959;8032.429622520737;8060.879086813819;10733;10866.511007004861;10974.451277436256;11121.999020088231;11267 17:53:08 INFO - PROCESS | 2241 | |3;mootools.html;1516.272189349112;1520.049968769519;1672.9079900605477;1709.2479309103994;1844.93915998301;8250.91749082509;8740.694075707352;8758.167974042464;8767.868481972775;8772.254358379529;7687.884681729778;8010.95994520028;8023.679052837894;8337.291330236922;8566.057733649293;2294.724633044033;2321.257197696738;2326.0463210083867;2326.732425771041;2331.3122628824453;2289.564982653299;2297.9080836766593;2313.5025969416574;2331.80179684727;2335.976640233593;2293.5986202414592;2314.2710046335433;2324.9186278480256;2336.707911511061;2341.344423561397;2293.7247530296304;2303.9078436862505;2304.2971893572453;2305.792478676927;2311.8034967027825;2293.896774645145;2304.7349554801244;2307.157887371114;2307.90768369265;2308.353660974913;8538.316934645214;8640.30877529796;8670.566471676391;8676;8687.609057592423;4834.540718631724;4845.345878306419;5074.720890351029;5276.3140791697215;5276.551493123089;3375.3249350130072;3447.896563103086;3582.5700915889997;3592.8383222755037;3603.207294395229;1035.7048241251282;1066.2962444786403;1077.5151181968147;1087.456271864068;1093.1528065749028;11171.776564468746;11305.660830175108;11306.152038597056;11326.830097548462;11352;4396.8461103861855;4487.461504619401;4691.132140554008;4692.202325604655;4700.95299047012;9650.71047868565;9671.806563868824;9672.75818104553;9681.273904457194;9741.707748767549;5238.5023422774775;5242.659227150223;5251.054810134213;5253.579713622901;5257.316548848626;3979.46277252573;4287.464066991626;4430.936575221924;4757.881052973634;4793.113274044313;3747.606501317377;3777.9244415112094;3867.361885288952;3892.824822882977;3909.3354129798004;1234.9320787356603;1244.6141696074246;1244.7261602447447;1262.8232047513357;1264.8229247905301;875.7941883657336;881.0440671870964;884.4516399832145;886.7721493762709;887.9822403551893;5409.43200963901;5519.530839878656;5696.658200507983;5753.05074662676;5915.852103697356;905.9139381758722;950.9714708558754;971.1647982734843;972.3033306879399;1001.7495626093477;3299.4390953537954;3786.905327366783;3836.1943991761486;3905.3556163233316;3933.3706606943324;10305.381677099398;10424.68725938223;10576.418296993585;10632.681019569425;10634.096101831276;9866.654667086617;10424.113950314157;10458;10529.526171322308;10565.683029509128;7858.764237072897;8086.433949623588;8098.109207987117;8114.553699546582;8114.63484143215;5696.572757043155;5730.684812335195;5758.1650660654805;5900.70496475166;6035.6076855004285;9693.466859322805;9812.01879812013;9873;9878.259130565093;9882.752931176778;9259.907400925904;9627.90372096298;9694.175995040501;9771.12059914611;9911.454869981932;6305.180326557518;6738.7304507819135;6993.440524757905;6994.265602111908;7351.632418378953;6534.248561415498;8030.196980301923;8175.100738918595;8248.051474080557;8254.876176857471;7190.676419561028;7330.633468326456;7347.044884165024;7390.815229619303;7505.286997735425;6390.968045159744;7249.166345870081;7287.453440991841;7327.596982165819;7361.30067643573;6540.738370465128;6749.3250674932115;6865.347791959756;6923.099997000358;6969.895451568129;4816.133096042746;4849.369581954465;4860.805567777249;4886.95113048865;4980.825671101494;4812.687175333732;4865.416150062015;4892.706437613754;4982.956987635052;4997.325361076353 17:53:08 INFO - PROCESS | 2241 | |4;prototype.html;259.3904324836634;291.874493967594;295.14113928468146;305.3816022554329;310.2399122150731;4871.780769865356;5122.564582010529;5133.640645154841;5137.614678899088;5163.3545806774155;4856.2958371036175;5040.168372218589;5066.037452883958;5074;5076.873078173047;3948.9605103949025;3969.1863168050627;3982.4822773039464;3982.561918188997;4007.899802504946;3304.96695033049;3670.9816450917706;3887.853083340407;4001.25976694311;4027.617376349242;3522.4892390603345;3574;3686.834092465832;3910.608939106095;3949.565547789741;3898.922021559553;3921.803849825802;3935.704822138351;3947.3684210526467;3951;2967.8516074196204;3402.4896265560114;3402.812845293508;3411.215420453285;3424.760266781326;3733.8133093345496;5012.298278241049;5026.84919452417;5027.84916452507;5063.139266324733;3739.9626003739886;4410.823567057314;4423;4464.866054018385;4486.3494793254795;4811.687240329367;5053.924191137099;5340.385855626575;5361.142217245261;5384.73076346185;3545.3441113394106;3663.7101811367893;3711.109333759905;3717.739758216926;3720.813959302051;4951.331570238008;5505.614606977513;5513.9448605513835;5543.52880005204;5597.244372009767;3155.7790954632956;3712.3874560697723;3716.7955762432784;3726.757760745543;3744.2885851688093;3631.1648320885815;3758.661720445173;3788.935030408434;3798.962010379916;3823.6558709715705;4357.537991035055;4361.794081350268;4362.454693163355;4362.9781851091175;4401.691881568324;5274.156135018378;5318.25544423781;5318.324727710758;5346.8663283417445;5365.543928766098;1080.7676349584876;1155.7688462307572;1164.4119719541748;1247.058470854499;1293.6222922587415;753.5478712772293;831.5177197225595;838.6435764799936;849.7790574450687;867.7657032601288;4719.820044988753;5056.039352523009;5065.189569668835;5073.213651883964;5073.264376665363;5065.797368105308;5461.1808228766;5498.395176530578;5525.397634685976;5529.944700553024;4570.337301091323;4694.779357367109;5041.294218809369;5049.444561098277;5052.520010598987;2002.729631499758;2184.737831460235;2408.5182963407037;2417.4077351049104;2438.3782135555675;4023.959760402417;4708.152532544175;4727.692699974491;4756.833510827174;4788.1381351356395;3877.864274750427;4164.8334066637;4358.365612895164;4508.256137737302;4711.764411779397;4079.2069318550584;4380.211561918822;4404.1411924674385;4426.977865110783;4484.529124441952;4550.542706938217;4561.657875659405;4571.599910047252;4605.539446055368;4647.442306923191;4319.784010799384;4329.761863097434;4470.284754439274;4533.433320834895;4576.512633394093;4223.429836971969;4713.457952335388;4751.643626728079;4776.179056754513;4777.856664300077;2920.4813496981874;2967.679382674689;3036.05882176526;3161.3677264546723;3201.967980320167;4020.4974378202724;4419.624331931822;4633.235516139799;4653.208954477679;4736.976315118402;4371.267957526546;4687.640584230535;5127.282180494808;5186.8329625833885;5280.4455532170105;4410;4437;4550.863474095782;4786.856394308176;5459.727013649381;5083.121950250906;5332.573394128538;5363.5440987516495;5402.702851343057;5406.5668300628595;5384.326959130109;5390.434004429635;5402.35171779389;5486.917696234639;5497.642653227527;4940.382452193476;5255.500727430888;5265.736713164403;5327.653702509325;5359.812406565751 17:53:08 INFO - PROCESS | 2241 | |5;yui.html;683.020778524556;685.499585302729;686.9828254293639;728.497336837582;780.7501599488163;14722.411103555858;14836.55490335289;15387.307571159297;15417.922910385447;15676.608084797886;14042.157470551774;14077.366518506666;14132.081414708036;14337.641558961031;14357.856421435783;796.6534557467505;817.4400535633081;820.2781552234026;820.3396266005863;821.6056292979373;642.4956409218764;669.2838662630987;670.3162773970547;791.7347688524322;821.322409012564;847.8261956298944;873.7116751471999;876.1370050500252;876.5617191404298;878.2754227762122;866.8266346730616;869.2350731356429;872.690194980779;872.9912700872974;874.5321253129608;501.2806622496729;519.9272101905699;618.492835874583;642.9389208025231;644.9097126402307;14922.850771492254;14964.925175374163;14999.175045372609;15023.248837558187;15033.849661503355;13450.192988420726;13773.38019789112;13822;13954.51159209433;14278.571642850731;12311.638983210993;12592.81110783339;12617.530179200794;12660.430280637302;13064;4437.813725588034;4457.9331310030375;4500.234960056766;4546.818127274905;4602.470715867651;123195.38402307931;125464.37267813693;126350;127531;128888.3555582216;10711.196660250513;10922.399268040333;10932.945335273273;11017.614383496539;11323;22029.779702202773;22053.22813701513;22087.66868496974;22099.226527071474;22104.44738881541;7770.378369730521;7847.843043139105;7894.211377568376;7909.209079092045;8146.877796833052;4244.808983595745;4278.63631591312;4311.223979683625;4316.0073183167415;4461.866144015685;3450.258194488197;3481.4603736420895;3552.378333791576;3575.1598374382;3585.659362360572;650.180772226988;654.2802916791492;659.1957811469999;660.1055569703079;676.9356911093438;559.9160125981135;565.3498476751686;588.7527238559816;597.9970100149559;636.7994081864198;8018.679252829938;8650.43772154808;8842.292616590657;9052.27581793455;9122.543872806333;579.4355240849723;601.1583782704162;604.1602172979561;611.3733423241214;635.1457289945016;3511.227529943408;4044.5550989391145;4183.477065366829;4379.759113248802;4436.245838207513;129870.35064824615;152696;156007;156060;160747.19626401793;91604.54197728969;117755;131780.34109829582;142270.28864855817;147057;118811;120509.79490205161;120688.39655801666;121984;124519.3774031124;8358;8412.411131220755;8455.069942306218;8496.915030849612;8763.386562940534;56954;60986.64573448503;63674.68162659157;63917.360826393;65792.6710366445;88035;89540;92944;93667;95116;11169.609063683058;11329.394239324836;11338.14963877696;11393.088552915913;11531.538738450368;11891.49200985694;11974.341411222118;12075.215111018108;12243.32661703615;12585.937070314956;11328.716782080184;11573.305601663928;11584.94207528957;11772.646820595395;12075.57735479254;11028.172887033345;11253.71865703364;11571.884281157081;11636.650900473;11867.76264474723;11188.1608879336;11365.517516479142;11511.30932144074;11899.405029748652;11984.64046078619;8104.554249516334;9639.566219520279;9790.709799150865;9911.851322230028;9932.255080869108;8642.56787160652;9597.856032159663;9867.81432523831;9871.703848884545;9882.604695812088 17:53:08 INFO - PROCESS | 2241 | __end_tp_report 17:53:08 INFO - PROCESS | 2241 | __start_cc_report 17:53:08 INFO - PROCESS | 2241 | _x_x_mozilla_cycle_collect,1902 17:53:08 INFO - PROCESS | 2241 | __end_cc_report 17:53:08 INFO - PROCESS | 2241 | __startTimestamp1476406388207__endTimestamp 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | ------- Summary: start ------- 17:53:08 INFO - PROCESS | 2241 | Number of tests: 6 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | [#0] dojo.html Cycles:165 Average:5657.92 Median:5832.33 stddev:652.35 (11.2%) stddev-sans-first:617.85 17:53:08 INFO - PROCESS | 2241 | Values: 2915.5 3235.2 3237.6 3283.5 3286.7 5464.9 5608.3 5616.9 5664.7 5721.4 5620.2 5647.0 5654.9 5663.1 5667.6 5111.6 5131.7 5151.6 5197.5 5199.3 5199.2 5234.7 5236.2 5240.6 5245.3 5107.6 5165.6 5169.4 5205.5 5219.1 5245.5 5255.0 5264.4 5278.5 5303.8 5024.1 5039.0 5098.1 5172.3 5189.3 4701.9 5507.2 5577.1 5578.0 5630.6 6174.0 6176.5 6177.9 6182.5 6188.7 5998.3 6042.2 6224.6 6275.7 6278.4 5648.0 5726.3 5728.1 5738.9 5804.7 6239.8 6287.8 6295.7 6303.6 6310.6 5958.0 6112.1 6115.9 6129.4 6138.0 6093.2 6107.7 6123.6 6135.1 6236.9 6160.2 6174.7 6176.8 6177.1 6182.4 6166.7 6185.8 6202.2 6203.4 6213.3 4730.2 4820.1 4833.4 4839.1 4857.9 4398.4 4402.2 4425.9 4429.6 4447.2 4780.3 5578.4 5608.5 5613.1 5631.5 6077.3 6084.6 6103.2 6220.1 6225.0 5571.3 5636.4 5648.7 5701.6 5832.3 5319.0 5330.4 5336.1 5342.1 5345.1 5844.7 6176.6 6238.7 6246.1 6256.7 4804.6 6111.1 6114.1 6126.7 6182.3 6195.8 6212.5 6238.6 6240.0 6266.0 6123.5 6125.8 6130.4 6133.6 6142.4 6062.1 6122.5 6125.3 6182.2 6234.9 5964.3 6094.6 6098.9 6108.5 6135.9 6026.5 6063.2 6065.5 6078.6 6087.0 5718.4 5796.0 5841.5 5869.0 5919.4 5869.0 5871.8 5905.2 5956.8 6003.3 5647.7 5660.7 5688.3 5748.4 5769.9 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | [#1] ext.html Cycles:180 Average:64115.88 Median:39778.70 stddev:134588.91 (338.3%) stddev-sans-first:134881.59 17:53:08 INFO - PROCESS | 2241 | Values: 456.2 472.7 501.1 510.9 531.5 27078.6 31053.2 32053.0 32111.5 32271.2 39573.6 41552.0 42517.8 44774.2 45006.0 8384.7 9494.5 9667.4 9668.8 9675.6 9507.5 9604.8 9607.7 9615.9 9639.1 9629.0 9660.5 9661.7 9679.2 9693.3 9471.4 9563.3 9613.4 9642.0 9676.1 8272.2 9598.8 9618.1 9624.6 9642.2 39169.4 39573.8 39596.4 39761.4 39796.0 2817.6 3412.4 3587.6 3631.3 3753.8 30145.2 30626.4 31374.8 31387.0 31485.7 3204.2 3262.8 3300.9 3330.1 3334.0 475640.6 476568.0 476619.0 477148.0 483744.0 59402.6 59842.0 59892.1 59892.7 60045.7 62608.7 62707.1 62761.0 62791.7 62953.7 15718.7 15784.0 15983.8 16025.8 16055.4 11972.9 12019.0 12019.6 12034.3 12052.5 13249.6 14138.6 16661.0 16946.4 16983.7 4467.0 4913.1 5888.6 6003.8 6391.6 829.4 971.4 976.1 1053.7 1054.2 25753.7 27011.5 29195.0 29199.0 29446.3 981.3 1114.3 1133.3 1148.5 1150.9 11496.4 14628.3 15061.3 15157.7 15493.3 556958.2 615374.0 616694.0 617154.0 617630.0 56410.0 56477.4 56489.6 56589.9 56878.9 1177.6 1223.2 1224.7 1275.2 1350.0 29448.9 29931.4 30339.7 30366.2 30598.0 48327.0 49000.0 49023.8 49063.5 49221.0 411211.9 412082.0 412330.0 412933.0 414542.0 25445.9 25931.6 26156.2 26492.6 26796.0 45641.8 45788.1 46016.5 46525.3 47177.3 37919.0 38158.8 38414.9 38898.8 39274.0 37948.8 39364.4 39404.6 41159.0 42593.0 37749.0 38651.0 39261.4 39532.6 40300.2 39248.4 39300.8 39467.8 40450.0 40733.6 29946.6 30591.8 30849.4 31021.2 31615.5 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | [#2] jquery.html Cycles:180 Average:34679.93 Median:25864.22 stddev:96777.06 (374.2%) stddev-sans-first:97014.18 17:53:08 INFO - PROCESS | 2241 | Values: 331.7 360.4 360.6 366.8 392.4 15024.6 15442.5 18377.8 19665.8 20647.6 19717.6 20109.4 20584.6 20878.8 20959.6 5501.6 6018.8 6079.7 6081.8 6104.8 4178.2 4396.7 5930.9 6082.9 6376.7 6574.8 6728.9 6733.1 6737.3 6747.9 6359.1 6561.7 6607.0 6622.7 6631.0 4931.7 5538.9 5717.9 5738.9 5742.9 25697.4 25769.5 25795.2 25933.2 26124.3 1972.5 1998.3 2119.7 2204.6 2225.5 9793.4 11023.3 11075.0 11105.9 15947.5 1823.2 1825.0 1906.8 1942.0 1949.3 114304.0 131114.0 135029.0 135051.3 136037.0 10932.8 11324.4 11369.5 11373.7 11554.7 12733.5 13084.9 13101.8 13269.3 14001.3 8086.1 8144.8 8225.5 8315.0 8393.2 6653.3 7987.7 8007.4 8147.2 8177.8 4064.3 4235.1 4245.4 4399.9 4569.2 1696.4 1705.7 1785.4 1838.1 1842.4 822.8 854.9 897.7 980.2 1004.2 17641.5 20755.5 20845.7 21415.9 21836.8 849.7 854.1 872.5 881.4 918.7 10655.3 10943.4 10960.0 10984.8 11024.0 524992.0 559045.0 570281.0 602321.0 612857.0 132196.0 135625.6 135807.3 136685.0 141285.0 937.2 981.7 986.0 986.5 996.8 18541.5 18899.6 18930.8 19263.0 19268.5 33062.8 39642.6 54010.5 55259.2 56739.0 73819.6 78067.6 81943.0 82853.6 83021.0 7576.4 7832.3 7871.6 8000.7 8068.9 11502.9 12219.2 12287.3 12390.1 12498.3 5300.2 9419.6 10548.9 10578.3 10766.7 10181.7 10526.7 10629.7 11191.8 11292.1 11047.2 11133.6 11550.6 11557.8 11824.5 6916.3 7139.2 7194.9 8032.4 8060.9 10733.0 10866.5 10974.5 11122.0 11267.0 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | [#3] mootools.html Cycles:180 Average:5554.23 Median:4990.14 stddev:3097.55 (62.1%) stddev-sans-first:3091.38 17:53:08 INFO - PROCESS | 2241 | Values: 1516.3 1520.0 1672.9 1709.2 1844.9 8250.9 8740.7 8758.2 8767.9 8772.3 7687.9 8011.0 8023.7 8337.3 8566.1 2294.7 2321.3 2326.0 2326.7 2331.3 2289.6 2297.9 2313.5 2331.8 2336.0 2293.6 2314.3 2324.9 2336.7 2341.3 2293.7 2303.9 2304.3 2305.8 2311.8 2293.9 2304.7 2307.2 2307.9 2308.4 8538.3 8640.3 8670.6 8676.0 8687.6 4834.5 4845.3 5074.7 5276.3 5276.6 3375.3 3447.9 3582.6 3592.8 3603.2 1035.7 1066.3 1077.5 1087.5 1093.2 11171.8 11305.7 11306.2 11326.8 11352.0 4396.8 4487.5 4691.1 4692.2 4701.0 9650.7 9671.8 9672.8 9681.3 9741.7 5238.5 5242.7 5251.1 5253.6 5257.3 3979.5 4287.5 4430.9 4757.9 4793.1 3747.6 3777.9 3867.4 3892.8 3909.3 1234.9 1244.6 1244.7 1262.8 1264.8 875.8 881.0 884.5 886.8 888.0 5409.4 5519.5 5696.7 5753.1 5915.9 905.9 951.0 971.2 972.3 1001.7 3299.4 3786.9 3836.2 3905.4 3933.4 10305.4 10424.7 10576.4 10632.7 10634.1 9866.7 10424.1 10458.0 10529.5 10565.7 7858.8 8086.4 8098.1 8114.6 8114.6 5696.6 5730.7 5758.2 5900.7 6035.6 9693.5 9812.0 9873.0 9878.3 9882.8 9259.9 9627.9 9694.2 9771.1 9911.5 6305.2 6738.7 6993.4 6994.3 7351.6 6534.2 8030.2 8175.1 8248.1 8254.9 7190.7 7330.6 7347.0 7390.8 7505.3 6391.0 7249.2 7287.5 7327.6 7361.3 6540.7 6749.3 6865.3 6923.1 6969.9 4816.1 4849.4 4860.8 4887.0 4980.8 4812.7 4865.4 4892.7 4983.0 4997.3 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | [#4] prototype.html Cycles:180 Average:4147.80 Median:4541.99 stddev:1268.41 (27.9%) stddev-sans-first:1237.94 17:53:08 INFO - PROCESS | 2241 | Values: 259.4 291.9 295.1 305.4 310.2 4871.8 5122.6 5133.6 5137.6 5163.4 4856.3 5040.2 5066.0 5074.0 5076.9 3949.0 3969.2 3982.5 3982.6 4007.9 3305.0 3671.0 3887.9 4001.3 4027.6 3522.5 3574.0 3686.8 3910.6 3949.6 3898.9 3921.8 3935.7 3947.4 3951.0 2967.9 3402.5 3402.8 3411.2 3424.8 3733.8 5012.3 5026.8 5027.8 5063.1 3740.0 4410.8 4423.0 4464.9 4486.3 4811.7 5053.9 5340.4 5361.1 5384.7 3545.3 3663.7 3711.1 3717.7 3720.8 4951.3 5505.6 5513.9 5543.5 5597.2 3155.8 3712.4 3716.8 3726.8 3744.3 3631.2 3758.7 3788.9 3799.0 3823.7 4357.5 4361.8 4362.5 4363.0 4401.7 5274.2 5318.3 5318.3 5346.9 5365.5 1080.8 1155.8 1164.4 1247.1 1293.6 753.5 831.5 838.6 849.8 867.8 4719.8 5056.0 5065.2 5073.2 5073.3 5065.8 5461.2 5498.4 5525.4 5529.9 4570.3 4694.8 5041.3 5049.4 5052.5 2002.7 2184.7 2408.5 2417.4 2438.4 4024.0 4708.2 4727.7 4756.8 4788.1 3877.9 4164.8 4358.4 4508.3 4711.8 4079.2 4380.2 4404.1 4427.0 4484.5 4550.5 4561.7 4571.6 4605.5 4647.4 4319.8 4329.8 4470.3 4533.4 4576.5 4223.4 4713.5 4751.6 4776.2 4777.9 2920.5 2967.7 3036.1 3161.4 3202.0 4020.5 4419.6 4633.2 4653.2 4737.0 4371.3 4687.6 5127.3 5186.8 5280.4 4410.0 4437.0 4550.9 4786.9 5459.7 5083.1 5332.6 5363.5 5402.7 5406.6 5384.3 5390.4 5402.4 5486.9 5497.6 4940.4 5255.5 5265.7 5327.7 5359.8 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - PROCESS | 2241 | [#5] yui.html Cycles:180 Average:25226.80 Median:4347.88 stddev:41647.47 (957.9%) stddev-sans-first:41723.53 17:53:08 INFO - PROCESS | 2241 | Values: 683.0 685.5 687.0 728.5 780.8 14722.4 14836.6 15387.3 15417.9 15676.6 14042.2 14077.4 14132.1 14337.6 14357.9 796.7 817.4 820.3 820.3 821.6 642.5 669.3 670.3 791.7 821.3 847.8 873.7 876.1 876.6 878.3 866.8 869.2 872.7 873.0 874.5 501.3 519.9 618.5 642.9 644.9 14922.9 14964.9 14999.2 15023.2 15033.8 13450.2 13773.4 13822.0 13954.5 14278.6 12311.6 12592.8 12617.5 12660.4 13064.0 4437.8 4457.9 4500.2 4546.8 4602.5 123195.4 125464.4 126350.0 127531.0 128888.4 10711.2 10922.4 10932.9 11017.6 11323.0 22029.8 22053.2 22087.7 22099.2 22104.4 7770.4 7847.8 7894.2 7909.2 8146.9 4244.8 4278.6 4311.2 4316.0 4461.9 3450.3 3481.5 3552.4 3575.2 3585.7 650.2 654.3 659.2 660.1 676.9 559.9 565.3 588.8 598.0 636.8 8018.7 8650.4 8842.3 9052.3 9122.5 579.4 601.2 604.2 611.4 635.1 3511.2 4044.6 4183.5 4379.8 4436.2 129870.4 152696.0 156007.0 156060.0 160747.2 91604.5 117755.0 131780.3 142270.3 147057.0 118811.0 120509.8 120688.4 121984.0 124519.4 8358.0 8412.4 8455.1 8496.9 8763.4 56954.0 60986.6 63674.7 63917.4 65792.7 88035.0 89540.0 92944.0 93667.0 95116.0 11169.6 11329.4 11338.1 11393.1 11531.5 11891.5 11974.3 12075.2 12243.3 12585.9 11328.7 11573.3 11584.9 11772.6 12075.6 11028.2 11253.7 11571.9 11636.7 11867.8 11188.2 11365.5 11511.3 11899.4 11984.6 8104.6 9639.6 9790.7 9911.9 9932.3 8642.6 9597.9 9867.8 9871.7 9882.6 17:53:08 INFO - PROCESS | 2241 | -------- Summary: end -------- 17:53:08 INFO - PROCESS | 2241 | 17:53:08 INFO - TEST-INFO | 2241: exit 0 17:53:08 INFO - TEST-OK | dromaeo_css | took 1119130ms 17:53:08 INFO - TEST-START | kraken 17:53:08 INFO - operating with platform_type : mac_ 17:53:08 INFO - Initialising browser for kraken test... 17:53:08 INFO - TEST-INFO | started process 2243 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpFuweZs/profile http://localhost:59947/getInfo.html) 17:53:11 INFO - PROCESS | 2243 | __metrics Screen width/height:1600/1200 17:53:11 INFO - PROCESS | 2243 | colorDepth:24 17:53:11 INFO - PROCESS | 2243 | Browser inner width/height: 1024/689 17:53:11 INFO - PROCESS | 2243 | __metrics 17:53:11 INFO - PROCESS | 2243 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:53:11 INFO - PROCESS | 2243 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:53:12 INFO - TEST-INFO | 2243: exit 0 17:53:12 INFO - Browser initialized. 17:53:12 INFO - Running cycle 1/1 for kraken test... 17:53:12 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpFuweZs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:53:24 INFO - PROCESS | 2244 | RSS: Main: 254947328 17:53:24 INFO - PROCESS | 2244 | 17:53:26 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59947/tests/kraken/driver.html?testName=audio-beat-detection) 17:53:27 INFO - PROCESS | 2244 | RSS: Main: 311459840 17:53:27 INFO - PROCESS | 2244 | 17:53:30 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59947/tests/kraken/driver.html?testName=audio-dft) 17:53:31 INFO - PROCESS | 2244 | RSS: Main: 312307712 17:53:31 INFO - PROCESS | 2244 | 17:53:34 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59947/tests/kraken/driver.html?testName=audio-fft) 17:53:35 INFO - PROCESS | 2244 | RSS: Main: 400314368 17:53:35 INFO - PROCESS | 2244 | 17:53:37 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59947/tests/kraken/driver.html?testName=audio-oscillator) 17:53:37 INFO - PROCESS | 2244 | RSS: Main: 298127360 17:53:37 INFO - PROCESS | 2244 | 17:53:39 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:53:40 INFO - PROCESS | 2244 | RSS: Main: 302460928 17:53:40 INFO - PROCESS | 2244 | 17:53:43 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59947/tests/kraken/driver.html?testName=imaging-darkroom) 17:53:43 INFO - PROCESS | 2244 | RSS: Main: 340922368 17:53:43 INFO - PROCESS | 2244 | 17:53:46 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59947/tests/kraken/driver.html?testName=imaging-desaturate) 17:53:47 INFO - PROCESS | 2244 | RSS: Main: 341323776 17:53:47 INFO - PROCESS | 2244 | 17:53:50 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59947/tests/kraken/driver.html?testName=json-parse-financial) 17:53:51 INFO - PROCESS | 2244 | RSS: Main: 339910656 17:53:51 INFO - PROCESS | 2244 | 17:53:52 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:53:53 INFO - PROCESS | 2244 | RSS: Main: 313323520 17:53:53 INFO - PROCESS | 2244 | 17:53:55 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:53:55 INFO - PROCESS | 2244 | RSS: Main: 317243392 17:53:55 INFO - PROCESS | 2244 | 17:53:58 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:53:58 INFO - PROCESS | 2244 | RSS: Main: 323624960 17:53:58 INFO - PROCESS | 2244 | 17:54:01 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:02 INFO - PROCESS | 2244 | RSS: Main: 334213120 17:54:02 INFO - PROCESS | 2244 | 17:54:05 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:06 INFO - PROCESS | 2244 | RSS: Main: 334340096 17:54:06 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:59947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59947/tests/kraken/driver.html?testName=ai-astar) 17:54:08 INFO - PROCESS | 2244 | RSS: Main: 377401344 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | __start_tp_report 17:54:08 INFO - PROCESS | 2244 | _x_x_mozilla_page_load 17:54:08 INFO - PROCESS | 2244 | _x_x_mozilla_page_load_details 17:54:08 INFO - PROCESS | 2244 | |i|pagename|runs| 17:54:08 INFO - PROCESS | 2244 | |0;ai-astar;114;114;113;115;114;113;113;112;114;112 17:54:08 INFO - PROCESS | 2244 | |1;audio-beat-detection;150;113;114;157;136;139;111;112;146;113 17:54:08 INFO - PROCESS | 2244 | |2;audio-dft;185;184;185;181;186;188;180;183;184;183 17:54:08 INFO - PROCESS | 2244 | |3;audio-fft;81;59;60;89;63;59;59;59;83;58 17:54:08 INFO - PROCESS | 2244 | |4;audio-oscillator;86;73;91;69;68;69;92;68;68;89 17:54:08 INFO - PROCESS | 2244 | |5;imaging-gaussian-blur;89;87;90;87;90;86;91;87;90;87 17:54:08 INFO - PROCESS | 2244 | |6;imaging-darkroom;94;95;95;96;95;95;94;96;95;95 17:54:08 INFO - PROCESS | 2244 | |7;imaging-desaturate;99;133;135;69;131;133;136;84;84;86 17:54:08 INFO - PROCESS | 2244 | |8;json-parse-financial;57;54;54;51;55;57;54;54;54;54 17:54:08 INFO - PROCESS | 2244 | |9;json-stringify-tinderbox;69;73;69;76;72;71;71;71;71;73 17:54:08 INFO - PROCESS | 2244 | |10;stanford-crypto-aes;91;90;87;87;88;94;102;101;79;90 17:54:08 INFO - PROCESS | 2244 | |11;stanford-crypto-ccm;149;145;146;148;152;141;154;136;264;160 17:54:08 INFO - PROCESS | 2244 | |12;stanford-crypto-pbkdf2;227;180;173;172;171;172;171;171;171;172 17:54:08 INFO - PROCESS | 2244 | |13;stanford-crypto-sha256-iterative;70;68;67;70;64;87;68;69;68;68 17:54:08 INFO - PROCESS | 2244 | __end_tp_report 17:54:08 INFO - PROCESS | 2244 | __start_cc_report 17:54:08 INFO - PROCESS | 2244 | _x_x_mozilla_cycle_collect,2142 17:54:08 INFO - PROCESS | 2244 | __end_cc_report 17:54:08 INFO - PROCESS | 2244 | __startTimestamp1476406448313__endTimestamp 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | ------- Summary: start ------- 17:54:08 INFO - PROCESS | 2244 | Number of tests: 14 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 17:54:08 INFO - PROCESS | 2244 | Values: 114.0 114.0 113.0 115.0 114.0 113.0 113.0 112.0 114.0 112.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:137.50 stddev:18.30 (13.3%) stddev-sans-first:17.77 17:54:08 INFO - PROCESS | 2244 | Values: 150.0 113.0 114.0 157.0 136.0 139.0 111.0 112.0 146.0 113.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:2.33 (1.3%) stddev-sans-first:2.44 17:54:08 INFO - PROCESS | 2244 | Values: 185.0 184.0 185.0 181.0 186.0 188.0 180.0 183.0 184.0 183.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:12.19 (19.8%) stddev-sans-first:11.83 17:54:08 INFO - PROCESS | 2244 | Values: 81.0 59.0 60.0 89.0 63.0 59.0 59.0 59.0 83.0 58.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.50 stddev:10.71 (13.5%) stddev-sans-first:10.89 17:54:08 INFO - PROCESS | 2244 | Values: 86.0 73.0 91.0 69.0 68.0 69.0 92.0 68.0 68.0 89.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.50 stddev:1.78 (2.0%) stddev-sans-first:1.87 17:54:08 INFO - PROCESS | 2244 | Values: 89.0 87.0 90.0 87.0 90.0 86.0 91.0 87.0 90.0 87.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:54:08 INFO - PROCESS | 2244 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 94.0 96.0 95.0 95.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:76.50 stddev:26.92 (35.2%) stddev-sans-first:28.30 17:54:08 INFO - PROCESS | 2244 | Values: 99.0 133.0 135.0 69.0 131.0 133.0 136.0 84.0 84.0 86.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.71 (3.2%) stddev-sans-first:1.54 17:54:08 INFO - PROCESS | 2244 | Values: 57.0 54.0 54.0 51.0 55.0 57.0 54.0 54.0 54.0 54.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:2.07 (2.9%) stddev-sans-first:1.96 17:54:08 INFO - PROCESS | 2244 | Values: 69.0 73.0 69.0 76.0 72.0 71.0 71.0 71.0 71.0 73.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:89.00 stddev:6.81 (7.6%) stddev-sans-first:7.22 17:54:08 INFO - PROCESS | 2244 | Values: 91.0 90.0 87.0 87.0 88.0 94.0 102.0 101.0 79.0 90.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#11] stanford-crypto-ccm Cycles:10 Average:159.50 Median:150.50 stddev:37.32 (24.8%) stddev-sans-first:39.39 17:54:08 INFO - PROCESS | 2244 | Values: 149.0 145.0 146.0 148.0 152.0 141.0 154.0 136.0 264.0 160.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:172.00 stddev:17.43 (10.1%) stddev-sans-first:2.88 17:54:08 INFO - PROCESS | 2244 | Values: 227.0 180.0 173.0 172.0 171.0 172.0 171.0 171.0 171.0 172.0 17:54:08 INFO - PROCESS | 2244 | 17:54:08 INFO - PROCESS | 2244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:68.50 stddev:6.24 (9.1%) stddev-sans-first:6.62 17:54:08 INFO - PROCESS | 2244 | Values: 70.0 68.0 67.0 70.0 64.0 87.0 68.0 69.0 68.0 68.0 17:54:08 INFO - PROCESS | 2244 | -------- Summary: end -------- 17:54:08 INFO - PROCESS | 2244 | 17:54:09 INFO - TEST-INFO | 2244: exit 0 17:54:09 INFO - TEST-OK | kraken | took 60331ms 17:54:09 INFO - SUITE-END | took 1179s 17:54:09 INFO - Completed test suite (00:19:39) 17:54:09 INFO - javascript benchmark 17:54:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.46063978164, 3235.158858696738, 3237.5953005874253, 3283.5238890360915, 3286.704196622305, 5464.863378415542, 5608.298962629671, 5616.9157462638095, 5664.688442135681, 5721.370649228586, 5620.156976453534, 5647.040003199456, 5654.858628534289, 5663.122216056508, 5667.603267771257, 5111.6166287528495, 5131.7434128293435, 5151.562117220041, 5197.454267301917, 5199.324087868572, 5199.220116982445, 5234.7120908350025, 5236.162214045753, 5240.554552862992, 5245.31810864589, 5107.616928730342, 5165.63840531163, 5169.405518365398, 5205.531502164805, 5219.060569097561, 5245.4754524547625, 5254.97372513135, 5264.394594621591, 5278.524932756032, 5303.814366497154, 5024.095662780698, 5038.974805125988, 5098.133317336062, 5172.327597412313, 5189.299444574972, 4701.905961880743, 5507.228987941691, 5577.05190117681, 5578.0, 5630.605857589971, 6174.0, 6176.536759743038, 6177.876442471171, 6182.505399568069, 6188.721507532126, 5998.280206375263, 6042.154098426224, 6224.595401298901, 6275.7175927082935, 6278.434940855299, 5648.039833228361, 5726.31284245889, 5728.083506638918, 5738.913916291259, 5804.65172089676, 6239.844003899939, 6287.842803929847, 6295.685215739195, 6303.558750887486, 6310.5898116622275, 5957.970210149008, 6112.083187521818, 6115.939717725866, 6129.417705317987, 6137.987232106652, 6093.2326056351785, 6107.674343494607, 6123.557704288865, 6135.1408007826785, 6236.937630623635, 6160.199174107337, 6174.691265436711, 6176.81469555914, 6177.135201071854, 6182.412670796357, 6166.660833654192, 6185.84535386619, 6202.193714817045, 6203.410675985864, 6213.316535181127, 4730.219513780256, 4820.108279968147, 4833.4441539223435, 4839.080574690868, 4857.854264372075, 4398.362237475548, 4402.163588918095, 4425.889352766142, 4429.55704429561, 4447.221736196153, 4780.306855505932, 5578.442155784389, 5608.523275521545, 5613.073842815971, 5631.465010823965, 6077.3314935357075, 6084.6349219047, 6103.2164526668375, 6220.098085777537, 6224.968875155686, 5571.275734154615, 5636.3799982002765, 5648.689322087324, 5701.572382071278, 5832.3292821326095, 5318.973405133027, 5330.38700549434, 5336.092864213016, 5342.1452567589, 5345.091334473149, 5844.678542680023, 6176.629402235881, 6238.65687387189, 6246.094316324107, 6256.749730010931, 4804.615630749601, 6111.135969295249, 6114.054067497468, 6126.663033533198, 6182.289036760651, 6195.845103872259, 6212.47193988516, 6238.625682459067, 6240.0, 6265.96867015662, 6123.479504242011, 6125.816225513242, 6130.386961303834, 6133.570650054453, 6142.416470435302, 6062.060380641008, 6122.510199183966, 6125.295591006913, 6182.227221597301, 6234.906476402948, 5964.284285885548, 6094.561897584374, 6098.855844323317, 6108.463491842691, 6135.926212912812, 6026.517878569792, 6063.151158837854, 6065.514758819372, 6078.635281883101, 6086.969565152146, 5718.370979192368, 5795.985702501961, 5841.50347220491, 5869.0, 5919.4080591940465, 5869.0, 5871.794487192928, 5905.202797622438, 5956.791512297049, 6003.279606447254, 5647.661140331593, 5660.716964151694, 5688.288963879515, 5748.367679555329, 5769.94230057694], "value": 5614.679644966726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.24719213298056, 472.7021976155021, 501.09052070492055, 510.8569600511858, 531.4764956517827, 27078.593821092676, 31053.223669408275, 32053.0, 32111.51832722511, 32271.19322016948, 39573.60426395735, 41552.0, 42517.7874110629, 44774.20903163878, 45006.0, 8384.748457546284, 9494.52527373632, 9667.419954802734, 9668.758281042996, 9675.612975480972, 9507.477088760115, 9604.759881002961, 9607.711768646952, 9615.855762163537, 9639.08428699276, 9629.037096290385, 9660.468674222915, 9661.710148695514, 9679.177269932065, 9693.321467497279, 9471.431714097176, 9563.330566860323, 9613.375130616487, 9642.035796420301, 9676.129148376645, 8272.214139656722, 9598.808023839554, 9618.134367906852, 9624.615015399375, 9642.180414664763, 39169.41245881314, 39573.80213098916, 39596.40605390922, 39761.40357894634, 39796.00509987245, 2817.619621351112, 3412.368711788327, 3587.617990834403, 3631.2918980798754, 3753.7560058596105, 30145.246368840955, 30626.38747225065, 31374.843125784453, 31387.0, 31485.685143148505, 3204.1829333520036, 3262.8042317461027, 3300.8679652813858, 3330.0675810773023, 3334.0, 475640.62179689226, 476568.0, 476619.0, 477148.0, 483744.0, 59402.62389504371, 59842.0, 59892.10161847576, 59892.70053649704, 60045.699771501735, 62608.686956564925, 62707.05939410913, 62761.0, 62791.6860415695, 62953.68523157355, 15718.685626287639, 15784.0, 15983.760243596354, 16025.839741602667, 16055.357785688442, 11972.940135299443, 12019.038476922, 12019.639410817515, 12034.277943323254, 12052.457639406248, 13249.602511924657, 14138.575842724735, 16661.00033997964, 16946.406875759534, 16983.660326793393, 4466.955330446719, 4913.128811070807, 5888.587798854039, 6003.849903752441, 6391.616503009835, 829.4276948905236, 971.3589031239349, 976.1068622210739, 1053.7418332508585, 1054.2093429927554, 25753.74246257551, 27011.459770804475, 29195.0, 29198.978035768647, 29446.263843404085, 981.2983716642492, 1114.3202646385698, 1133.2936034962224, 1148.4831825678477, 1150.919435639514, 11496.367699776425, 14628.268586570628, 15061.322240499203, 15157.72634104893, 15493.302801373966, 556958.165020192, 615374.0, 616694.0, 617154.0, 617630.0, 56410.0, 56477.43522564722, 56489.58776030632, 56589.86820263572, 56878.86242275214, 1177.605502156787, 1223.2477026628737, 1224.7428040111677, 1275.1583954590112, 1350.0414705559162, 29448.852755736083, 29931.431187364542, 30339.696603033688, 30366.240843979078, 30598.0, 48327.0, 49000.0, 49023.77440564014, 49063.528094157235, 49221.0, 411211.88788111735, 412082.0, 412330.0, 412933.0, 414542.0, 25445.87277063603, 25931.61102583425, 26156.215313540622, 26492.602610961236, 26796.0, 45641.77179114083, 45788.08423831438, 46016.46909420014, 46525.302120467546, 47177.29234061423, 37919.0, 38158.809205953796, 38414.900373104356, 38898.80550597229, 39274.01814954649, 37948.81025594854, 39364.409533856444, 39404.605953940096, 41159.0, 42593.0, 37748.98008159395, 38651.0, 39261.41107883327, 39532.60467395404, 40300.19399611933, 39248.411273830345, 39300.803495982334, 39467.80266098651, 40450.0, 40733.59266407417, 29946.550801737554, 30591.847040764653, 30849.383012339178, 31021.224469387544, 31615.525767113973], "value": 19362.393295274145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.71472533621096, 360.36215897860785, 360.6087395176235, 366.80375998840617, 392.43293440977783, 15024.624384390396, 15442.536723898287, 18377.816221837777, 19665.803341966577, 20647.58704825906, 19717.605647887034, 20109.39671809848, 20584.588308233826, 20878.791212087912, 20959.58080838386, 5501.614886957915, 6018.8495287617725, 6079.726412311435, 6081.847953801146, 6104.847378815521, 4178.164367126572, 4396.7361958282445, 5930.940690593104, 6082.9391706082815, 6376.713047912832, 6574.802755917306, 6728.899066514006, 6733.091032710595, 6737.258901520829, 6747.898781518281, 6359.109724638554, 6561.737530498798, 6607.0, 6622.73509059637, 6630.966845165792, 4931.7040977541465, 5538.861528461821, 5717.914231286534, 5738.885222295572, 5742.856428589277, 25697.357566060997, 25769.484610307878, 25795.226143215546, 25933.22200333993, 26124.346891327677, 1972.5068732816796, 1998.2906068345674, 2119.6502577074916, 2204.6252137136726, 2225.5326381459913, 9793.412395256308, 11023.25999820077, 11075.0, 11105.944470277596, 15947.521574352671, 1823.1795691938548, 1824.963500729978, 1906.780720217179, 1941.9708704369446, 1949.3274820187012, 114304.0, 131114.0, 135029.0, 135051.32474337565, 136036.9594456084, 10932.781344373068, 11324.377159256155, 11369.488373023234, 11373.715657108638, 11554.711132221593, 12733.490660373482, 13084.934575327063, 13101.803472947913, 13269.336533173302, 14001.29993500321, 8086.070101938352, 8144.837103257902, 8225.519406506886, 8315.0, 8393.24460798531, 6653.2681405045405, 7987.68049278034, 8007.439479236397, 8147.226013528705, 8177.754667359989, 4064.3293856513346, 4235.089455767024, 4245.426867372927, 4399.912001759947, 4569.177548041384, 1696.3723422333815, 1705.7270836666073, 1785.3929663914332, 1838.1268897273956, 1842.3920106364867, 822.8313195794967, 854.9444286121383, 897.6858099665066, 980.1570649241789, 1004.1715584642699, 17641.470755877086, 20755.481112972295, 20845.68731469029, 21415.892920535298, 21836.781632183793, 849.7466237299933, 854.1117238072335, 872.4808738800403, 881.405051590174, 918.7197904639149, 10655.344249964024, 10943.398113103856, 10960.013598776148, 10984.791672915973, 11023.95272449116, 524992.0, 559045.0, 570281.0, 602321.0, 612857.0, 132196.0, 135625.6437435613, 135807.32096339454, 136685.0, 141285.0, 937.2221056523069, 981.7300242433388, 985.9852102218473, 986.5166068626178, 996.7956568903357, 18541.536461588566, 18899.622007560047, 18930.810691892904, 19263.0, 19268.518287042934, 33062.83468582642, 39642.60357396389, 54010.45989540211, 55259.17111243415, 56739.0, 73819.63090184514, 78067.60966195133, 81943.0, 82853.58573207336, 83021.0, 7576.356009739234, 7832.334251588451, 7871.567063811545, 8000.719974800854, 8068.878966815385, 11502.884971150515, 12219.208463832445, 12287.262764234174, 12390.070744694003, 12498.312592807482, 5300.1519756838725, 9419.62321507132, 10548.894511054792, 10578.312409693346, 10766.676999690022, 10181.694549163536, 10526.736831578966, 10629.734256643645, 11191.776164476827, 11292.096632269562, 11047.171462140212, 11133.55465781392, 11550.59572914944, 11557.768844622893, 11824.527018919147, 6916.308369163044, 7139.178994415501, 7194.892076618959, 8032.429622520737, 8060.879086813819, 10733.0, 10866.511007004861, 10974.451277436256, 11121.999020088231, 11267.0], "value": 9399.179343408025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.272189349112, 1520.049968769519, 1672.9079900605477, 1709.2479309103994, 1844.93915998301, 8250.91749082509, 8740.694075707352, 8758.167974042464, 8767.868481972775, 8772.254358379529, 7687.884681729778, 8010.95994520028, 8023.679052837894, 8337.291330236922, 8566.057733649293, 2294.724633044033, 2321.257197696738, 2326.0463210083867, 2326.732425771041, 2331.3122628824453, 2289.564982653299, 2297.9080836766593, 2313.5025969416574, 2331.80179684727, 2335.976640233593, 2293.5986202414592, 2314.2710046335433, 2324.9186278480256, 2336.707911511061, 2341.344423561397, 2293.7247530296304, 2303.9078436862505, 2304.2971893572453, 2305.792478676927, 2311.8034967027825, 2293.896774645145, 2304.7349554801244, 2307.157887371114, 2307.90768369265, 2308.353660974913, 8538.316934645214, 8640.30877529796, 8670.566471676391, 8676.0, 8687.609057592423, 4834.540718631724, 4845.345878306419, 5074.720890351029, 5276.3140791697215, 5276.551493123089, 3375.3249350130072, 3447.896563103086, 3582.5700915889997, 3592.8383222755037, 3603.207294395229, 1035.7048241251282, 1066.2962444786403, 1077.5151181968147, 1087.456271864068, 1093.1528065749028, 11171.776564468746, 11305.660830175108, 11306.152038597056, 11326.830097548462, 11352.0, 4396.8461103861855, 4487.461504619401, 4691.132140554008, 4692.202325604655, 4700.95299047012, 9650.71047868565, 9671.806563868824, 9672.75818104553, 9681.273904457194, 9741.707748767549, 5238.5023422774775, 5242.659227150223, 5251.054810134213, 5253.579713622901, 5257.316548848626, 3979.46277252573, 4287.464066991626, 4430.936575221924, 4757.881052973634, 4793.113274044313, 3747.606501317377, 3777.9244415112094, 3867.361885288952, 3892.824822882977, 3909.3354129798004, 1234.9320787356603, 1244.6141696074246, 1244.7261602447447, 1262.8232047513357, 1264.8229247905301, 875.7941883657336, 881.0440671870964, 884.4516399832145, 886.7721493762709, 887.9822403551893, 5409.43200963901, 5519.530839878656, 5696.658200507983, 5753.05074662676, 5915.852103697356, 905.9139381758722, 950.9714708558754, 971.1647982734843, 972.3033306879399, 1001.7495626093477, 3299.4390953537954, 3786.905327366783, 3836.1943991761486, 3905.3556163233316, 3933.3706606943324, 10305.381677099398, 10424.68725938223, 10576.418296993585, 10632.681019569425, 10634.096101831276, 9866.654667086617, 10424.113950314157, 10458.0, 10529.526171322308, 10565.683029509128, 7858.764237072897, 8086.433949623588, 8098.109207987117, 8114.553699546582, 8114.63484143215, 5696.572757043155, 5730.684812335195, 5758.1650660654805, 5900.70496475166, 6035.6076855004285, 9693.466859322805, 9812.01879812013, 9873.0, 9878.259130565093, 9882.752931176778, 9259.907400925904, 9627.90372096298, 9694.175995040501, 9771.12059914611, 9911.454869981932, 6305.180326557518, 6738.7304507819135, 6993.440524757905, 6994.265602111908, 7351.632418378953, 6534.248561415498, 8030.196980301923, 8175.100738918595, 8248.051474080557, 8254.876176857471, 7190.676419561028, 7330.633468326456, 7347.044884165024, 7390.815229619303, 7505.286997735425, 6390.968045159744, 7249.166345870081, 7287.453440991841, 7327.596982165819, 7361.30067643573, 6540.738370465128, 6749.3250674932115, 6865.347791959756, 6923.099997000358, 6969.895451568129, 4816.133096042746, 4849.369581954465, 4860.805567777249, 4886.95113048865, 4980.825671101494, 4812.687175333732, 4865.416150062015, 4892.706437613754, 4982.956987635052, 4997.325361076353], "value": 4484.3142401670475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.3904324836634, 291.874493967594, 295.14113928468146, 305.3816022554329, 310.2399122150731, 4871.780769865356, 5122.564582010529, 5133.640645154841, 5137.614678899088, 5163.3545806774155, 4856.2958371036175, 5040.168372218589, 5066.037452883958, 5074.0, 5076.873078173047, 3948.9605103949025, 3969.1863168050627, 3982.4822773039464, 3982.561918188997, 4007.899802504946, 3304.96695033049, 3670.9816450917706, 3887.853083340407, 4001.25976694311, 4027.617376349242, 3522.4892390603345, 3574.0, 3686.834092465832, 3910.608939106095, 3949.565547789741, 3898.922021559553, 3921.803849825802, 3935.704822138351, 3947.3684210526467, 3951.0, 2967.8516074196204, 3402.4896265560114, 3402.812845293508, 3411.215420453285, 3424.760266781326, 3733.8133093345496, 5012.298278241049, 5026.84919452417, 5027.84916452507, 5063.139266324733, 3739.9626003739886, 4410.823567057314, 4423.0, 4464.866054018385, 4486.3494793254795, 4811.687240329367, 5053.924191137099, 5340.385855626575, 5361.142217245261, 5384.73076346185, 3545.3441113394106, 3663.7101811367893, 3711.109333759905, 3717.739758216926, 3720.813959302051, 4951.331570238008, 5505.614606977513, 5513.9448605513835, 5543.52880005204, 5597.244372009767, 3155.7790954632956, 3712.3874560697723, 3716.7955762432784, 3726.757760745543, 3744.2885851688093, 3631.1648320885815, 3758.661720445173, 3788.935030408434, 3798.962010379916, 3823.6558709715705, 4357.537991035055, 4361.794081350268, 4362.454693163355, 4362.9781851091175, 4401.691881568324, 5274.156135018378, 5318.25544423781, 5318.324727710758, 5346.8663283417445, 5365.543928766098, 1080.7676349584876, 1155.7688462307572, 1164.4119719541748, 1247.058470854499, 1293.6222922587415, 753.5478712772293, 831.5177197225595, 838.6435764799936, 849.7790574450687, 867.7657032601288, 4719.820044988753, 5056.039352523009, 5065.189569668835, 5073.213651883964, 5073.264376665363, 5065.797368105308, 5461.1808228766, 5498.395176530578, 5525.397634685976, 5529.944700553024, 4570.337301091323, 4694.779357367109, 5041.294218809369, 5049.444561098277, 5052.520010598987, 2002.729631499758, 2184.737831460235, 2408.5182963407037, 2417.4077351049104, 2438.3782135555675, 4023.959760402417, 4708.152532544175, 4727.692699974491, 4756.833510827174, 4788.1381351356395, 3877.864274750427, 4164.8334066637, 4358.365612895164, 4508.256137737302, 4711.764411779397, 4079.2069318550584, 4380.211561918822, 4404.1411924674385, 4426.977865110783, 4484.529124441952, 4550.542706938217, 4561.657875659405, 4571.599910047252, 4605.539446055368, 4647.442306923191, 4319.784010799384, 4329.761863097434, 4470.284754439274, 4533.433320834895, 4576.512633394093, 4223.429836971969, 4713.457952335388, 4751.643626728079, 4776.179056754513, 4777.856664300077, 2920.4813496981874, 2967.679382674689, 3036.05882176526, 3161.3677264546723, 3201.967980320167, 4020.4974378202724, 4419.624331931822, 4633.235516139799, 4653.208954477679, 4736.976315118402, 4371.267957526546, 4687.640584230535, 5127.282180494808, 5186.8329625833885, 5280.4455532170105, 4410.0, 4437.0, 4550.863474095782, 4786.856394308176, 5459.727013649381, 5083.121950250906, 5332.573394128538, 5363.5440987516495, 5402.702851343057, 5406.5668300628595, 5384.326959130109, 5390.434004429635, 5402.35171779389, 5486.917696234639, 5497.642653227527, 4940.382452193476, 5255.500727430888, 5265.736713164403, 5327.653702509325, 5359.812406565751], "value": 3743.7791003755897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.020778524556, 685.499585302729, 686.9828254293639, 728.497336837582, 780.7501599488163, 14722.411103555858, 14836.55490335289, 15387.307571159297, 15417.922910385447, 15676.608084797886, 14042.157470551774, 14077.366518506666, 14132.081414708036, 14337.641558961031, 14357.856421435783, 796.6534557467505, 817.4400535633081, 820.2781552234026, 820.3396266005863, 821.6056292979373, 642.4956409218764, 669.2838662630987, 670.3162773970547, 791.7347688524322, 821.322409012564, 847.8261956298944, 873.7116751471999, 876.1370050500252, 876.5617191404298, 878.2754227762122, 866.8266346730616, 869.2350731356429, 872.690194980779, 872.9912700872974, 874.5321253129608, 501.2806622496729, 519.9272101905699, 618.492835874583, 642.9389208025231, 644.9097126402307, 14922.850771492254, 14964.925175374163, 14999.175045372609, 15023.248837558187, 15033.849661503355, 13450.192988420726, 13773.38019789112, 13822.0, 13954.51159209433, 14278.571642850731, 12311.638983210993, 12592.81110783339, 12617.530179200794, 12660.430280637302, 13064.0, 4437.813725588034, 4457.9331310030375, 4500.234960056766, 4546.818127274905, 4602.470715867651, 123195.38402307931, 125464.37267813693, 126350.0, 127531.0, 128888.3555582216, 10711.196660250513, 10922.399268040333, 10932.945335273273, 11017.614383496539, 11323.0, 22029.779702202773, 22053.22813701513, 22087.66868496974, 22099.226527071474, 22104.44738881541, 7770.378369730521, 7847.843043139105, 7894.211377568376, 7909.209079092045, 8146.877796833052, 4244.808983595745, 4278.63631591312, 4311.223979683625, 4316.0073183167415, 4461.866144015685, 3450.258194488197, 3481.4603736420895, 3552.378333791576, 3575.1598374382, 3585.659362360572, 650.180772226988, 654.2802916791492, 659.1957811469999, 660.1055569703079, 676.9356911093438, 559.9160125981135, 565.3498476751686, 588.7527238559816, 597.9970100149559, 636.7994081864198, 8018.679252829938, 8650.43772154808, 8842.292616590657, 9052.27581793455, 9122.543872806333, 579.4355240849723, 601.1583782704162, 604.1602172979561, 611.3733423241214, 635.1457289945016, 3511.227529943408, 4044.5550989391145, 4183.477065366829, 4379.759113248802, 4436.245838207513, 129870.35064824615, 152696.0, 156007.0, 156060.0, 160747.19626401793, 91604.54197728969, 117755.0, 131780.34109829582, 142270.28864855817, 147057.0, 118811.0, 120509.79490205161, 120688.39655801666, 121984.0, 124519.3774031124, 8358.0, 8412.411131220755, 8455.069942306218, 8496.915030849612, 8763.386562940534, 56954.0, 60986.64573448503, 63674.68162659157, 63917.360826393, 65792.6710366445, 88035.0, 89540.0, 92944.0, 93667.0, 95116.0, 11169.609063683058, 11329.394239324836, 11338.14963877696, 11393.088552915913, 11531.538738450368, 11891.49200985694, 11974.341411222118, 12075.215111018108, 12243.32661703615, 12585.937070314956, 11328.716782080184, 11573.305601663928, 11584.94207528957, 11772.646820595395, 12075.57735479254, 11028.172887033345, 11253.71865703364, 11571.884281157081, 11636.650900473, 11867.76264474723, 11188.1608879336, 11365.517516479142, 11511.30932144074, 11899.405029748652, 11984.64046078619, 8104.554249516334, 9639.566219520279, 9790.709799150865, 9911.851322230028, 9932.255080869108, 8642.56787160652, 9597.856032159663, 9867.81432523831, 9871.703848884545, 9882.604695812088], "value": 7506.254004168258, "unit": "score"}], "name": "dromaeo_css", "value": 7106.278822992688, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 115.0, 114.0, 113.0, 113.0, 112.0, 114.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 114.0, 157.0, 136.0, 139.0, 111.0, 112.0, 146.0, 113.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 181.0, 186.0, 188.0, 180.0, 183.0, 184.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 89.0, 63.0, 59.0, 59.0, 59.0, 83.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 73.0, 91.0, 69.0, 68.0, 69.0, 92.0, 68.0, 68.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 87.0, 90.0, 86.0, 91.0, 87.0, 90.0, 87.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 133.0, 135.0, 69.0, 131.0, 133.0, 136.0, 84.0, 84.0, 86.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 51.0, 55.0, 57.0, 54.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 69.0, 76.0, 72.0, 71.0, 71.0, 71.0, 71.0, 73.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 87.0, 87.0, 88.0, 94.0, 102.0, 101.0, 79.0, 90.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 145.0, 146.0, 148.0, 152.0, 141.0, 154.0, 136.0, 264.0, 160.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [227.0, 180.0, 173.0, 172.0, 171.0, 172.0, 171.0, 171.0, 171.0, 172.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 70.0, 64.0, 87.0, 68.0, 69.0, 68.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1487.4, "alertThreshold": 2.0}]} 17:54:09 INFO - Return code: 0 17:54:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:54:09 INFO - # TBPL SUCCESS # 17:54:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:54:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:54:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:54:09 INFO - 2016-10-13 17:54:09.651 screenresolution[2248:28396] starting screenresolution argv=screenresolution get 17:54:09 INFO - 2016-10-13 17:54:09.653 screenresolution[2248:28396] Display 0: 1600x1200x32@60 17:54:09 INFO - 2016-10-13 17:54:09.660 screenresolution[2249:28399] starting screenresolution argv=screenresolution list 17:54:09 INFO - Available Modes on Display 0 17:54:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:54:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:54:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:54:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:54:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:54:09 INFO - Intel Iris: 17:54:09 INFO - Chipset Model: Intel Iris 17:54:09 INFO - Type: GPU 17:54:09 INFO - Bus: Built-In 17:54:09 INFO - VRAM (Dynamic, Max): 1536 MB 17:54:09 INFO - Vendor: Intel (0x8086) 17:54:09 INFO - Device ID: 0x0a2e 17:54:09 INFO - Revision ID: 0x0009 17:54:09 INFO - Displays: 17:54:09 INFO - Display: 17:54:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:54:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:54:09 INFO - Display Serial Number: 1600x1200 60 17:54:09 INFO - Main Display: Yes 17:54:09 INFO - Mirror: Off 17:54:09 INFO - Online: Yes 17:54:09 INFO - Rotation: Supported 17:54:09 INFO - Return code: 0 17:54:09 INFO - Running post-action listener: _resource_record_post_action 17:54:09 INFO - [mozharness: 2016-10-14 00:54:09.897906Z] Finished run-tests step (success) 17:54:09 INFO - Running post-run listener: _resource_record_post_run 17:54:09 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 12288; Write bytes: 706556928; Read time: 1; Write time: 1986 17:54:09 INFO - TinderboxPrint: CPU usage
53.7% 17:54:09 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 1 17:54:09 INFO - TinderboxPrint: I/O write bytes / time
706,556,928 / 1,986 17:54:09 INFO - TinderboxPrint: CPU idle
2,250.7 (46.3%) 17:54:09 INFO - TinderboxPrint: CPU system
979.0 (20.1%) 17:54:09 INFO - TinderboxPrint: CPU user
1,632.0 (33.6%) 17:54:09 INFO - TinderboxPrint: Swap in / out
406,577,152 / 0 17:54:09 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 403556864; Write bytes: 398161408; Read time: 30313; Write time: 803 17:54:09 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 12288; Write bytes: 295411200; Read time: 1; Write time: 1141 17:54:10 INFO - Running post-run listener: _upload_blobber_files 17:54:10 INFO - Blob upload gear active. 17:54:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:54:10 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 17:54:10 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:54:10 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:54:10 INFO - (blobuploader) - INFO - Open directory for files ... 17:54:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:54:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:54:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:12 INFO - (blobuploader) - INFO - Done attempting. 17:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:13 INFO - (blobuploader) - INFO - Done attempting. 17:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:54:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:15 INFO - (blobuploader) - INFO - Done attempting. 17:54:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:54:15 INFO - Return code: 0 17:54:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:54:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:54:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43d238ae5a30c6f1b6cd78c53c68636122412a3b148e64ce3785fdefb3cd1ec2daec58b5bf032d07aa1edf9e64c816a8bd8f1e04a9a4a3196c673551df037bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/966fee02bd78ed934d6ce940519a6069b39f84bd667a1b8a6928ffd672f2da21bbb9688573631497dfc7ffe39113670fbe4241113c47a4504f72e0f5cafd54a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a25d79ae7d89bbc2c07d31f9943244c0463a39b1f53e2f36986fee129742374ffa0bf00fa47a90f416c93ab89e945ce4170ab4dd19e16d206564ad5d5293954a"} 17:54:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:54:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:54:15 INFO - Contents: 17:54:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43d238ae5a30c6f1b6cd78c53c68636122412a3b148e64ce3785fdefb3cd1ec2daec58b5bf032d07aa1edf9e64c816a8bd8f1e04a9a4a3196c673551df037bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/966fee02bd78ed934d6ce940519a6069b39f84bd667a1b8a6928ffd672f2da21bbb9688573631497dfc7ffe39113670fbe4241113c47a4504f72e0f5cafd54a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a25d79ae7d89bbc2c07d31f9943244c0463a39b1f53e2f36986fee129742374ffa0bf00fa47a90f416c93ab89e945ce4170ab4dd19e16d206564ad5d5293954a"} 17:54:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:54:15 INFO - Copying logs to upload dir... 17:54:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:54:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.470003 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-13 17:54:15.949382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 17:54:15.953764) ========= 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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43d238ae5a30c6f1b6cd78c53c68636122412a3b148e64ce3785fdefb3cd1ec2daec58b5bf032d07aa1edf9e64c816a8bd8f1e04a9a4a3196c673551df037bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/966fee02bd78ed934d6ce940519a6069b39f84bd667a1b8a6928ffd672f2da21bbb9688573631497dfc7ffe39113670fbe4241113c47a4504f72e0f5cafd54a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a25d79ae7d89bbc2c07d31f9943244c0463a39b1f53e2f36986fee129742374ffa0bf00fa47a90f416c93ab89e945ce4170ab4dd19e16d206564ad5d5293954a"} build_url:https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/fEE6J0WYROuV-o9GM0A5Kg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43d238ae5a30c6f1b6cd78c53c68636122412a3b148e64ce3785fdefb3cd1ec2daec58b5bf032d07aa1edf9e64c816a8bd8f1e04a9a4a3196c673551df037bef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/966fee02bd78ed934d6ce940519a6069b39f84bd667a1b8a6928ffd672f2da21bbb9688573631497dfc7ffe39113670fbe4241113c47a4504f72e0f5cafd54a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a25d79ae7d89bbc2c07d31f9943244c0463a39b1f53e2f36986fee129742374ffa0bf00fa47a90f416c93ab89e945ce4170ab4dd19e16d206564ad5d5293954a"}' ========= master_lag: 0.57 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 17:54:16.530106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:54:16.530448) ========= 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.3d4tsAAUEQ/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.YLEUCRjj0a/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005272 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:54:16.579912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 17:54:16.580224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 17:54:16.580656) ========= ========= Total master_lag: 0.74 =========