builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0355 starttime: 1479469128.07 results: success (0) buildid: 20161118003528 builduid: 7ecae77d51f44b5da2752b56ca464ecc revision: b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.074641) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.075154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.075460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.100551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.100922) ========= 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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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-11-18 03:38:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-11-18 03:38:48 (38.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.365574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.488787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.489139) ========= 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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.024535 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:48.537518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 03:38:48.537906) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KXzgdWLdh5/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.I0e7vYVtrY/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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-11-18 03:38:48,648 truncating revision to first 12 chars 2016-11-18 03:38:48,648 Setting DEBUG logging. 2016-11-18 03:38:48,648 attempt 1/10 2016-11-18 03:38:48,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/b1542ac3fc70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 03:38:49,594 unpacking tar archive at: graphics-b1542ac3fc70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.224179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 03:38:49.783556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:49.783886) ========= script_repo_revision: b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:49.784260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:49.784539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 03:38:49.803108) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-18 03:38:49.803524) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KXzgdWLdh5/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.I0e7vYVtrY/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:38:49 INFO - MultiFileLogger online at 20161118 03:38:49 in /builds/slave/test 03:38:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 03:38:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:50 INFO - {'append_to_log': False, 03:38:50 INFO - 'base_work_dir': '/builds/slave/test', 03:38:50 INFO - 'blob_upload_branch': 'Graphics', 03:38:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:50 INFO - 'branch': 'Graphics', 03:38:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:50 INFO - 'config_files': ('talos/mac_config.py',), 03:38:50 INFO - 'default_actions': ('clobber', 03:38:50 INFO - 'read-buildbot-config', 03:38:50 INFO - 'download-and-extract', 03:38:50 INFO - 'populate-webroot', 03:38:50 INFO - 'create-virtualenv', 03:38:50 INFO - 'install', 03:38:50 INFO - 'run-tests'), 03:38:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:50 INFO - 'download_minidump_stackwalk': True, 03:38:50 INFO - 'download_symbols': 'ondemand', 03:38:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:50 INFO - 'installer_path': 'installer.exe', 03:38:50 INFO - 'log_level': 'info', 03:38:50 INFO - 'log_name': 'talos', 03:38:50 INFO - 'log_to_console': True, 03:38:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:38:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:38:50 INFO - 'opt_config_files': (), 03:38:50 INFO - 'pip_index': False, 03:38:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:50 INFO - 'cmd': ('bash', 03:38:50 INFO - '-c', 03:38:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:50 INFO - 'enabled': True, 03:38:50 INFO - 'halt_on_failure': False, 03:38:50 INFO - 'name': 'check_screen_resolution'},), 03:38:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:50 INFO - 'cmd': ('bash', 03:38:50 INFO - '-c', 03:38:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:50 INFO - 'enabled': True, 03:38:50 INFO - 'halt_on_failure': False, 03:38:50 INFO - 'name': 'check_screen_resolution'},), 03:38:50 INFO - 'run_cmd_checks_enabled': True, 03:38:50 INFO - 'sps_profile': False, 03:38:50 INFO - 'sps_profile_interval': 0, 03:38:50 INFO - 'suite': 'dromaeojs', 03:38:50 INFO - 'system_bits': '32', 03:38:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:50 INFO - 'title': 't-yosemite-r7-0355', 03:38:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:50 INFO - 'use_talos_json': True, 03:38:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:50 INFO - 'work_dir': 'build'} 03:38:50 INFO - [mozharness: 2016-11-18 11:38:50.009712Z] Running clobber step. 03:38:50 INFO - Running pre-action listener: _resource_record_pre_action 03:38:50 INFO - Running main action method: clobber 03:38:50 INFO - rmtree: /builds/slave/test/build 03:38:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:52 INFO - Running post-action listener: _resource_record_post_action 03:38:52 INFO - [mozharness: 2016-11-18 11:38:52.345004Z] Finished clobber step (success) 03:38:52 INFO - [mozharness: 2016-11-18 11:38:52.345223Z] Running read-buildbot-config step. 03:38:52 INFO - Running pre-action listener: _resource_record_pre_action 03:38:52 INFO - Running main action method: read_buildbot_config 03:38:52 INFO - Using buildbot properties: 03:38:52 INFO - { 03:38:52 INFO - "project": "", 03:38:52 INFO - "product": "firefox", 03:38:52 INFO - "script_repo_revision": "default", 03:38:52 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 03:38:52 INFO - "repository": "", 03:38:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 03:38:52 INFO - "buildid": "20161118003528", 03:38:52 INFO - "pgo_build": "False", 03:38:52 INFO - "basedir": "/builds/slave/test", 03:38:52 INFO - "buildnumber": 1, 03:38:52 INFO - "slavename": "t-yosemite-r7-0355", 03:38:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:38:52 INFO - "platform": "yosemite_r7", 03:38:52 INFO - "scheduler": "tests-graphics-macosx64-talos", 03:38:52 INFO - "branch": "graphics", 03:38:52 INFO - "repo_path": "projects/graphics", 03:38:52 INFO - "revision": "b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e", 03:38:52 INFO - "stage_platform": "macosx64", 03:38:52 INFO - "builduid": "7ecae77d51f44b5da2752b56ca464ecc", 03:38:52 INFO - "slavebuilddir": "test" 03:38:52 INFO - } 03:38:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 03:38:52 INFO - Running post-action listener: _resource_record_post_action 03:38:52 INFO - [mozharness: 2016-11-18 11:38:52.349270Z] Finished read-buildbot-config step (success) 03:38:52 INFO - [mozharness: 2016-11-18 11:38:52.349380Z] Running download-and-extract step. 03:38:52 INFO - Running pre-action listener: _resource_record_pre_action 03:38:52 INFO - Running main action method: download_and_extract 03:38:52 INFO - mkdir: /builds/slave/test/build/tests 03:38: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')]} 03:38:52 INFO - trying https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 03:38:52 INFO - Downloading https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 03:38:53 INFO - Downloaded 1199 bytes. 03:38:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:38:53 INFO - Using the following test package requirements: 03:38:53 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:38:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 03:38:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 03:38:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'jsshell-mac.zip'], 03:38:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 03:38:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:38:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 03:38:53 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 03:38:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 03:38:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:38:53 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 03:38:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:38:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:38:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:38:53 INFO - Fetch https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:38:54 INFO - Http code: 200 03:38:54 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 03:38:54 INFO - x-amz-cf-id: pLje52xf3vBTSk19cAFgJwXQ3JHx49i8Wq4JaUxjTfadw8i9FDbVfw== 03:38:54 INFO - x-amz-version-id: WO5k0IJF_fT8ZqO0EQdacvL04UGl..4z 03:38:54 INFO - Expected file size: 16274714 03:38:54 INFO - Obtained file size: 16274714 03:39:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:39:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:39:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:39:01 INFO - Fetch https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:39:01 INFO - Http code: 200 03:39:01 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 03:39:01 INFO - x-amz-cf-id: LFey8XAfuD2vh0Ow1F-E5kh9lCmG2fD5Y3Tx1SG5VZ5bpp3JY4Tp6Q== 03:39:01 INFO - x-amz-version-id: WO5k0IJF_fT8ZqO0EQdacvL04UGl..4z 03:39:01 INFO - Expected file size: 16274714 03:39:01 INFO - Obtained file size: 16274714 03:39:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 03:39:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:39:08 INFO - Fetch https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 03:39:08 INFO - Http code: 200 03:39:08 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 03:39:08 INFO - x-amz-cf-id: _2X9oZRhzyx312tYSz72sDVa61owEQfk5935yrcbg1-7Z3NGsokczQ== 03:39:08 INFO - x-amz-version-id: r2t81Zv5HgTmctVzCP.JpCe3lO9jGj9F 03:39:09 INFO - Expected file size: 14409392 03:39:09 INFO - Obtained file size: 14409392 03:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:09 INFO - trying https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:39:09 INFO - Downloading https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 03:39:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 03:39:12 INFO - Downloaded 110997690 bytes. 03:39:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:39:12 INFO - mkdir: /builds/slave/test/properties 03:39:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:12 INFO - Contents: 03:39:12 INFO - build_url:https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:39:13 INFO - Running post-action listener: _resource_record_post_action 03:39:13 INFO - Running post-action listener: set_extra_try_arguments 03:39:13 INFO - [mozharness: 2016-11-18 11:39:13.102145Z] Finished download-and-extract step (success) 03:39:13 INFO - [mozharness: 2016-11-18 11:39:13.102297Z] Running populate-webroot step. 03:39:13 INFO - Running pre-action listener: _resource_record_pre_action 03:39:13 INFO - Running main action method: populate_webroot 03:39:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:13 INFO - '--tppagecycles', 03:39:13 INFO - '7'], 03:39:13 INFO - 'tests': ['tsvgm']}}, 03:39:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['damp', 'tps']}, 03:39:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'tests': ['damp', 'tps']}, 03:39:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['dromaeo_dom']}, 03:39:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['basic_compositor_video']}, 03:39:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:39:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['a11yr', 03:39:13 INFO - 'ts_paint', 03:39:13 INFO - 'tpaint', 03:39:13 INFO - 'sessionrestore', 03:39:13 INFO - 'sessionrestore_no_auto_restore', 03:39:13 INFO - 'tabpaint']}, 03:39:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:13 INFO - 'ts_paint', 03:39:13 INFO - 'tpaint', 03:39:13 INFO - 'sessionrestore', 03:39:13 INFO - 'sessionrestore_no_auto_restore', 03:39:13 INFO - 'tabpaint']}, 03:39:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:39:13 INFO - 'ts_paint', 03:39:13 INFO - 'tpaint', 03:39:13 INFO - 'sessionrestore', 03:39:13 INFO - 'sessionrestore_no_auto_restore', 03:39:13 INFO - 'tabpaint']}, 03:39:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:39:13 INFO - 'ts_paint', 03:39:13 INFO - 'tpaint', 03:39:13 INFO - 'sessionrestore', 03:39:13 INFO - 'sessionrestore_no_auto_restore', 03:39:13 INFO - 'tabpaint']}, 03:39:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['a11yr', 03:39:13 INFO - 'ts_paint', 03:39:13 INFO - 'tpaint', 03:39:13 INFO - 'sessionrestore', 03:39:13 INFO - 'sessionrestore_no_auto_restore', 03:39:13 INFO - 'tabpaint']}, 03:39:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['a11yr', 03:39:13 INFO - 'ts_paint', 03:39:13 INFO - 'tpaint', 03:39:13 INFO - 'sessionrestore', 03:39:13 INFO - 'sessionrestore_no_auto_restore', 03:39:13 INFO - 'tabpaint']}, 03:39:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['tsvgx', 03:39:13 INFO - 'tsvgr_opacity', 03:39:13 INFO - 'tart', 03:39:13 INFO - 'tscrollx', 03:39:13 INFO - 'cart']}, 03:39:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:13 INFO - 'tsvgr_opacity', 03:39:13 INFO - 'tart', 03:39:13 INFO - 'tscrollx', 03:39:13 INFO - 'cart']}, 03:39:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'talos_options': ['--disable-e10s'], 03:39:13 INFO - 'tests': ['tp5o']}, 03:39:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:39:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'talos_options': ['--disable-e10s', 03:39:13 INFO - '--xperf_path', 03:39:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:13 INFO - 'tests': ['tp5n']}, 03:39:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:39:13 INFO - 'talos_options': ['--xperf_path', 03:39:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:13 INFO - 'tests': ['tp5n']}}, 03:39:13 INFO - 'talos.zip': {'path': '', 03:39:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:13 INFO - Running post-action listener: _resource_record_post_action 03:39:13 INFO - [mozharness: 2016-11-18 11:39:13.120942Z] Finished populate-webroot step (success) 03:39:13 INFO - [mozharness: 2016-11-18 11:39:13.121085Z] Running create-virtualenv step. 03:39:13 INFO - Running pre-action listener: _resource_record_pre_action 03:39:13 INFO - Running main action method: create_virtualenv 03:39:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:13 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 03:39:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:13 INFO - Using real prefix '/tools/python27' 03:39:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:16 INFO - Installing pip.................done. 03:39:16 INFO - Return code: 0 03:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:39:17 INFO - Reading from file tmpfile_stdout 03:39:17 INFO - Output received: 03:39:17 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) 03:39:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:17 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:17 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 03:39:17 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 03:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:17 INFO - 'HOME': '/Users/cltbld', 03:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:17 INFO - 'LOGNAME': 'cltbld', 03:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:17 INFO - 'MOZ_NO_REMOTE': '1', 03:39:17 INFO - 'NO_EM_RESTART': '1', 03:39:17 INFO - 'PAGER': '/bin/cat', 03:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:17 INFO - 'PWD': '/builds/slave/test', 03:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:17 INFO - 'SHELL': '/bin/bash', 03:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:17 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:17 INFO - 'USER': 'cltbld', 03:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:17 INFO - 'XPC_FLAGS': '0x0', 03:39:17 INFO - 'XPC_SERVICE_NAME': '0', 03:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:17 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 03:39:17 INFO - Cleaning up... 03:39:17 INFO - Return code: 0 03:39:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:17 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:17 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 03:39:17 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 03:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:17 INFO - 'HOME': '/Users/cltbld', 03:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:17 INFO - 'LOGNAME': 'cltbld', 03:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:17 INFO - 'MOZ_NO_REMOTE': '1', 03:39:17 INFO - 'NO_EM_RESTART': '1', 03:39:17 INFO - 'PAGER': '/bin/cat', 03:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:17 INFO - 'PWD': '/builds/slave/test', 03:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:17 INFO - 'SHELL': '/bin/bash', 03:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:17 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:17 INFO - 'USER': 'cltbld', 03:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:17 INFO - 'XPC_FLAGS': '0x0', 03:39:17 INFO - 'XPC_SERVICE_NAME': '0', 03:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:17 INFO - Downloading/unpacking psutil>=3.1.1 03:39:17 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 03:39:17 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 03:39:17 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 03:39:17 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 03:39:17 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 03:39:17 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 03:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:21 INFO - Installing collected packages: psutil 03:39:21 INFO - Running setup.py install for psutil 03:39:21 INFO - building 'psutil._psutil_osx' extension 03:39:21 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 03:39:21 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 03:39:21 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 03:39:21 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 03:39:21 INFO - building 'psutil._psutil_posix' extension 03:39:21 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 03:39:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:39:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:39:22 INFO - ^ 03:39:22 INFO - 1 warning generated. 03:39:22 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 03:39:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:22 INFO - Successfully installed psutil 03:39:22 INFO - Cleaning up... 03:39:22 INFO - Return code: 0 03:39:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:22 INFO - 'HOME': '/Users/cltbld', 03:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:22 INFO - 'LOGNAME': 'cltbld', 03:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:22 INFO - 'MOZ_NO_REMOTE': '1', 03:39:22 INFO - 'NO_EM_RESTART': '1', 03:39:22 INFO - 'PAGER': '/bin/cat', 03:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:22 INFO - 'PWD': '/builds/slave/test', 03:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:22 INFO - 'SHELL': '/bin/bash', 03:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:22 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:22 INFO - 'USER': 'cltbld', 03:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:22 INFO - 'XPC_FLAGS': '0x0', 03:39:22 INFO - 'XPC_SERVICE_NAME': '0', 03:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39:22 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 03:39:22 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 03:39:22 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 03:39:22 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 03:39:22 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 03:39:22 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 03:39:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:39:25 INFO - Installing collected packages: mozsystemmonitor 03:39:25 INFO - Running setup.py install for mozsystemmonitor 03:39:25 INFO - Successfully installed mozsystemmonitor 03:39:25 INFO - Cleaning up... 03:39:25 INFO - Return code: 0 03:39:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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', '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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:39: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 jsonschema==2.5.1 03:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:25 INFO - 'HOME': '/Users/cltbld', 03:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:25 INFO - 'LOGNAME': 'cltbld', 03:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:25 INFO - 'MOZ_NO_REMOTE': '1', 03:39:25 INFO - 'NO_EM_RESTART': '1', 03:39:25 INFO - 'PAGER': '/bin/cat', 03:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:25 INFO - 'PWD': '/builds/slave/test', 03:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:25 INFO - 'SHELL': '/bin/bash', 03:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:25 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:25 INFO - 'USER': 'cltbld', 03:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:25 INFO - 'XPC_FLAGS': '0x0', 03:39:25 INFO - 'XPC_SERVICE_NAME': '0', 03:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:39:28 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 03:39:28 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 03:39:28 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 03:39:28 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 03:39:28 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 03:39:28 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 03:39:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:39:28 INFO - warning: no files found matching '*.txt' 03:39:28 INFO - no previously-included directories found matching 'build' 03:39:28 INFO - no previously-included directories found matching 'dist' 03:39:28 INFO - no previously-included directories found matching '.git*' 03:39:28 INFO - Installing collected packages: jsonschema, functools32 03:39:28 INFO - Running setup.py install for functools32 03:39:28 INFO - warning: no files found matching '*.txt' 03:39:28 INFO - no previously-included directories found matching 'build' 03:39:28 INFO - no previously-included directories found matching 'dist' 03:39:28 INFO - no previously-included directories found matching '.git*' 03:39:28 INFO - Successfully installed jsonschema functools32 03:39:28 INFO - Cleaning up... 03:39:28 INFO - Return code: 0 03:39:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:39:28 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')]} 03:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:28 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')]} 03:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:28 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:28 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 03:39:28 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 03:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:28 INFO - 'HOME': '/Users/cltbld', 03:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:28 INFO - 'LOGNAME': 'cltbld', 03:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:28 INFO - 'MOZ_NO_REMOTE': '1', 03:39:28 INFO - 'NO_EM_RESTART': '1', 03:39:28 INFO - 'PAGER': '/bin/cat', 03:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:28 INFO - 'PWD': '/builds/slave/test', 03:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:28 INFO - 'SHELL': '/bin/bash', 03:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:28 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:28 INFO - 'USER': 'cltbld', 03:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:28 INFO - 'XPC_FLAGS': '0x0', 03:39:28 INFO - 'XPC_SERVICE_NAME': '0', 03:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:39:29 INFO - Cleaning up... 03:39:29 INFO - Return code: 0 03:39:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:29 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:29 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 03:39:29 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 03:39:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:29 INFO - 'HOME': '/Users/cltbld', 03:39:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:29 INFO - 'LOGNAME': 'cltbld', 03:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:29 INFO - 'MOZ_NO_REMOTE': '1', 03:39:29 INFO - 'NO_EM_RESTART': '1', 03:39:29 INFO - 'PAGER': '/bin/cat', 03:39:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:29 INFO - 'PWD': '/builds/slave/test', 03:39:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:29 INFO - 'SHELL': '/bin/bash', 03:39:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:29 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:29 INFO - 'USER': 'cltbld', 03:39:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:29 INFO - 'XPC_FLAGS': '0x0', 03:39:29 INFO - 'XPC_SERVICE_NAME': '0', 03:39:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:39:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 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 03:39:32 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 03:39:33 INFO - Downloading docopt-0.6.1.tar.gz 03:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:39:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:33 INFO - Running setup.py install for blobuploader 03:39:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:39:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:39:33 INFO - Running setup.py install for requests 03:39:33 INFO - Running setup.py install for docopt 03:39:34 INFO - Successfully installed blobuploader requests docopt 03:39:34 INFO - Cleaning up... 03:39:34 INFO - Return code: 0 03:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:34 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')]} 03:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:34 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')]} 03:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:34 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:34 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 03:39:34 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 03:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:34 INFO - 'HOME': '/Users/cltbld', 03:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:34 INFO - 'LOGNAME': 'cltbld', 03:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:34 INFO - 'MOZ_NO_REMOTE': '1', 03:39:34 INFO - 'NO_EM_RESTART': '1', 03:39:34 INFO - 'PAGER': '/bin/cat', 03:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:34 INFO - 'PWD': '/builds/slave/test', 03:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:34 INFO - 'SHELL': '/bin/bash', 03:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:34 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:34 INFO - 'USER': 'cltbld', 03:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:34 INFO - 'XPC_FLAGS': '0x0', 03:39:34 INFO - 'XPC_SERVICE_NAME': '0', 03:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:34 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-XQgdOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:34 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-AkclTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:34 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-d_K5QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:34 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-uWNzoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:34 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-p2Z0LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-4CRCNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-rN8WQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-ilFkkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-RX8NXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-RR2pD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-3qc_8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-8pQ7QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-h5lPVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:35 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-YpWZj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:36 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-IgFQrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:36 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-fWHoPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:36 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-4j7iUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:36 INFO - Running setup.py install for manifestparser 03:39:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:39:36 INFO - Running setup.py install for mozcrash 03:39:36 INFO - Running setup.py install for mozdebug 03:39:36 INFO - Running setup.py install for mozdevice 03:39:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:39:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:39:36 INFO - Running setup.py install for mozfile 03:39:37 INFO - Running setup.py install for mozhttpd 03:39:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Running setup.py install for mozinfo 03:39:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Running setup.py install for mozInstall 03:39:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Running setup.py install for mozleak 03:39:37 INFO - Running setup.py install for mozlog 03:39:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:39:37 INFO - Running setup.py install for moznetwork 03:39:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:39:38 INFO - Running setup.py install for mozprocess 03:39:38 INFO - Running setup.py install for mozprofile 03:39:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:39:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:39:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:39:38 INFO - Running setup.py install for mozrunner 03:39:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:39:38 INFO - Running setup.py install for mozscreenshot 03:39:38 INFO - Running setup.py install for moztest 03:39:38 INFO - Running setup.py install for mozversion 03:39:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:38 INFO - Cleaning up... 03:39:38 INFO - Return code: 0 03:39:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:38 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')]} 03:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:38 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')]} 03:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:38 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:38 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 03:39:38 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 03:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:38 INFO - 'HOME': '/Users/cltbld', 03:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:38 INFO - 'LOGNAME': 'cltbld', 03:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:38 INFO - 'MOZ_NO_REMOTE': '1', 03:39:38 INFO - 'NO_EM_RESTART': '1', 03:39:38 INFO - 'PAGER': '/bin/cat', 03:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:38 INFO - 'PWD': '/builds/slave/test', 03:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:38 INFO - 'SHELL': '/bin/bash', 03:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:38 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:38 INFO - 'USER': 'cltbld', 03:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:38 INFO - 'XPC_FLAGS': '0x0', 03:39:38 INFO - 'XPC_SERVICE_NAME': '0', 03:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-womQGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:39 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)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-IineKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-oEwp7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:39 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)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-OAJkYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:39 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)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-bGfNnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:39 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)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-J4vGDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:39 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)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-QpdFdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:39 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)) 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:39 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-WDVM4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-h2MKiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-6y09RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-RhBr1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-KCbrRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-daJsDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-taVpRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-h3WYxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-y1Oo5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:40 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)) 03:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:40 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-S9GGRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:41 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)) 03:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:41 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)) 03:39:41 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)) 03:39:41 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)) 03:39:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:41 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 03:39:41 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 03:39:41 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 03:39:41 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 03:39:41 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 03:39:41 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 03:39:43 INFO - Downloading blessings-1.6.tar.gz 03:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:43 INFO - Installing collected packages: blessings 03:39:43 INFO - Running setup.py install for blessings 03:39:43 INFO - Successfully installed blessings 03:39:43 INFO - Cleaning up... 03:39:44 INFO - Return code: 0 03:39:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:44 INFO - Reading from file tmpfile_stdout 03:39:44 INFO - Current package versions: 03:39:44 INFO - blessings == 1.6 03:39:44 INFO - blobuploader == 1.2.4 03:39:44 INFO - docopt == 0.6.1 03:39:44 INFO - functools32 == 3.2.3-2 03:39:44 INFO - jsonschema == 2.5.1 03:39:44 INFO - manifestparser == 1.1 03:39:44 INFO - mozInstall == 1.12 03:39:44 INFO - mozcrash == 1.0 03:39:44 INFO - mozdebug == 0.1 03:39:44 INFO - mozdevice == 0.48 03:39:44 INFO - mozfile == 1.2 03:39:44 INFO - mozhttpd == 0.7 03:39:44 INFO - mozinfo == 0.9 03:39:44 INFO - mozleak == 0.1 03:39:44 INFO - mozlog == 3.4 03:39:44 INFO - moznetwork == 0.27 03:39:44 INFO - mozprocess == 0.23 03:39:44 INFO - mozprofile == 0.28 03:39:44 INFO - mozrunner == 6.13 03:39:44 INFO - mozscreenshot == 0.1 03:39:44 INFO - mozsystemmonitor == 0.3 03:39:44 INFO - moztest == 0.7 03:39:44 INFO - mozversion == 1.4 03:39:44 INFO - psutil == 3.1.1 03:39:44 INFO - requests == 1.2.3 03:39:44 INFO - wsgiref == 0.1.2 03:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:44 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:44 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 03:39:44 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 03:39:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:44 INFO - 'HOME': '/Users/cltbld', 03:39:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:44 INFO - 'LOGNAME': 'cltbld', 03:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:44 INFO - 'MOZ_NO_REMOTE': '1', 03:39:44 INFO - 'NO_EM_RESTART': '1', 03:39:44 INFO - 'PAGER': '/bin/cat', 03:39:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:44 INFO - 'PWD': '/builds/slave/test', 03:39:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:44 INFO - 'SHELL': '/bin/bash', 03:39:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:44 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:44 INFO - 'USER': 'cltbld', 03:39:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:44 INFO - 'XPC_FLAGS': '0x0', 03:39:44 INFO - 'XPC_SERVICE_NAME': '0', 03:39:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 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)) 03:39:44 INFO - Cleaning up... 03:39:44 INFO - Return code: 0 03:39:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:45 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 0x1008d13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100847570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcba8d8b660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, '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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 03:39:45 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 03:39:45 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 03:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:45 INFO - 'HOME': '/Users/cltbld', 03:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:45 INFO - 'LOGNAME': 'cltbld', 03:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:45 INFO - 'MOZ_NO_REMOTE': '1', 03:39:45 INFO - 'NO_EM_RESTART': '1', 03:39:45 INFO - 'PAGER': '/bin/cat', 03:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:45 INFO - 'PWD': '/builds/slave/test', 03:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:45 INFO - 'SHELL': '/bin/bash', 03:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:39:45 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:45 INFO - 'USER': 'cltbld', 03:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:45 INFO - 'XPC_FLAGS': '0x0', 03:39:45 INFO - 'XPC_SERVICE_NAME': '0', 03:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:39:45 INFO - Cleaning up... 03:39:45 INFO - Return code: 0 03:39:45 INFO - Running post-action listener: _resource_record_post_action 03:39:45 INFO - Running post-action listener: _start_resource_monitoring 03:39:45 INFO - Starting resource monitoring. 03:39:45 INFO - [mozharness: 2016-11-18 11:39:45.561740Z] Finished create-virtualenv step (success) 03:39:45 INFO - [mozharness: 2016-11-18 11:39:45.562762Z] Running install step. 03:39:45 INFO - Running pre-action listener: _resource_record_pre_action 03:39:45 INFO - Running main action method: install 03:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:45 INFO - Reading from file tmpfile_stdout 03:39:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:45 INFO - Reading from file tmpfile_stdout 03:39:45 INFO - Output received: 03:39:45 INFO - Usage: mozinstall [options] installer 03:39:45 INFO - Options: 03:39:45 INFO - -h, --help show this help message and exit 03:39:45 INFO - -d DEST, --destination=DEST 03:39:45 INFO - Directory to install application into. [default: 03:39:45 INFO - "/builds/slave/test"] 03:39:45 INFO - --app=APP Application being installed. [default: firefox] 03:39:45 INFO - mkdir: /builds/slave/test/build/application 03:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:40:20 INFO - Reading from file tmpfile_stdout 03:40:20 INFO - Output received: 03:40:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:40:20 INFO - Running post-action listener: _resource_record_post_action 03:40:20 INFO - [mozharness: 2016-11-18 11:40:20.489181Z] Finished install step (success) 03:40:20 INFO - [mozharness: 2016-11-18 11:40:20.489277Z] Running run-tests step. 03:40:20 INFO - Running pre-action listener: _resource_record_pre_action 03:40:20 INFO - Running main action method: run_tests 03:40:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:40:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:40:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:40:20 INFO - 2016-11-18 03:40:20.502 screenresolution[1631:7416] starting screenresolution argv=screenresolution get 03:40:20 INFO - 2016-11-18 03:40:20.504 screenresolution[1631:7416] Display 0: 1600x1200x32@60 03:40:20 INFO - 2016-11-18 03:40:20.509 screenresolution[1632:7418] starting screenresolution argv=screenresolution list 03:40:20 INFO - Available Modes on Display 0 03:40:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:40:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:40:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:40:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:40:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:40:20 INFO - Intel Iris: 03:40:20 INFO - Chipset Model: Intel Iris 03:40:20 INFO - Type: GPU 03:40:20 INFO - Bus: Built-In 03:40:20 INFO - VRAM (Dynamic, Max): 1536 MB 03:40:20 INFO - Vendor: Intel (0x8086) 03:40:20 INFO - Device ID: 0x0a2e 03:40:20 INFO - Revision ID: 0x0009 03:40:20 INFO - Displays: 03:40:20 INFO - Display: 03:40:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:40:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:40:20 INFO - Display Serial Number: 1600x1200 60 03:40:20 INFO - Main Display: Yes 03:40:20 INFO - Mirror: Off 03:40:20 INFO - Online: Yes 03:40:20 INFO - Rotation: Supported 03:40:20 INFO - Return code: 0 03:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:20 INFO - Python 2.7.3 03:40:20 INFO - Return code: 0 03:40:20 INFO - grabbing minidump binary from tooltool 03:40:20 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')]} 03:40:20 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 0x1006e7d30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006dfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:20 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 03:40:20 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 03:40:20 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 03:40:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:20 INFO - Return code: 0 03:40:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:40:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:40:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--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 03:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0355 --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 03:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KXzgdWLdh5/Render', 03:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:20 INFO - 'HOME': '/Users/cltbld', 03:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:20 INFO - 'LOGNAME': 'cltbld', 03:40:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:20 INFO - 'MOZ_NO_REMOTE': '1', 03:40:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:20 INFO - 'NO_EM_RESTART': '1', 03:40:20 INFO - 'PAGER': '/bin/cat', 03:40:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:20 INFO - 'PWD': '/builds/slave/test', 03:40:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:20 INFO - 'SHELL': '/bin/bash', 03:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I0e7vYVtrY/Listeners', 03:40:20 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 03:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:20 INFO - 'USER': 'cltbld', 03:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:20 INFO - 'XPC_FLAGS': '0x0', 03:40:20 INFO - 'XPC_SERVICE_NAME': '0', 03:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--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 03:40:21 INFO - mozversion application_buildid: 20161118003528 03:40:21 INFO - mozversion application_changeset: b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e 03:40:21 INFO - mozversion application_display_name: Nightly 03:40:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:21 INFO - mozversion application_name: Firefox 03:40:21 INFO - mozversion application_remotingname: firefox 03:40:21 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 03:40:21 INFO - mozversion application_vendor: Mozilla 03:40:21 INFO - mozversion application_version: 53.0a1 03:40:21 INFO - mozversion platform_buildid: 20161118003528 03:40:21 INFO - mozversion platform_changeset: b1542ac3fc7034d6efe289e78e5fe1d5b79aef7e 03:40:21 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 03:40:21 INFO - mozversion platform_version: 53.0a1 03:40:21 INFO - using testdate: 1479469221 03:40:21 INFO - actual date: 1479469221 03:40:21 INFO - starting webserver on 'localhost:49244' 03:40:21 INFO - SUITE-START | Running 2 tests 03:40:21 INFO - TEST-START | dromaeo_css 03:40:21 INFO - operating with platform_type : mac_ 03:40:21 INFO - Initialising browser for dromaeo_css test... 03:40:21 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmp1q1GN2/profile http://localhost:49244/getInfo.html) 03:40:23 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 03:40:23 INFO - PROCESS | 1642 | colorDepth:24 03:40:23 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 03:40:23 INFO - PROCESS | 1642 | __metrics 03:40:23 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:40:23 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:24 INFO - TEST-INFO | 1642: exit 0 03:40:24 INFO - Browser initialized. 03:40:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:24 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmp1q1GN2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:36 INFO - PROCESS | 1644 | RSS: Main: 239255552 03:40:36 INFO - PROCESS | 1644 | 03:41:27 INFO - PROCESS | 1644 | 1479469287738 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] 03:43:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 03:43:42 INFO - PROCESS | 1644 | RSS: Main: 359084032 03:43:42 INFO - PROCESS | 1644 | 03:46:45 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 03:46:45 INFO - PROCESS | 1644 | RSS: Main: 368312320 03:46:45 INFO - PROCESS | 1644 | 03:49:48 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 03:49:49 INFO - PROCESS | 1644 | RSS: Main: 336650240 03:49:49 INFO - PROCESS | 1644 | 03:52:51 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 03:52:52 INFO - PROCESS | 1644 | RSS: Main: 344641536 03:52:52 INFO - PROCESS | 1644 | 03:55:55 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 03:55:56 INFO - PROCESS | 1644 | RSS: Main: 328511488 03:55:56 INFO - PROCESS | 1644 | 03:58:59 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 03:59:00 INFO - PROCESS | 1644 | RSS: Main: 398671872 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | __start_tp_report 03:59:00 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 03:59:00 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 03:59:00 INFO - PROCESS | 1644 | |i|pagename|runs| 03:59:00 INFO - PROCESS | 1644 | |0;dojo.html;3310.5530753348294;3331.3337332533483;3337.766356355053;3368.6294507604175;3378.611459682136;4410.853178173674;5299.735013249337;5542.63972841765;5630.971845140773;5666.320041595014;5652.604317697763;5655.208270842086;5656.460819927353;5687.317521897367;5695.971520142393;4336.696431249814;5140.691558506502;5173.922391164136;5253.947460525404;5254.999999999981;5149.922751158736;5212.635115541913;5251.264822924793;5287.206918962148;5297.708626025567;5241.79032838686;5276.393214780292;5286.867828304285;5296.576273898098;5311.760970756306;5086.669366491166;5238.266642670029;5246.108161612535;5256.658317209369;5309.654872433318;5127.256547800548;5132.717700526469;5156;5174.689518628894;5193.324867767204;4652.464966528825;5590.217369568264;5622.971885140548;5628.296462942132;5649.717514124277;6200.069989501566;6206.472449841724;6211.844703882394;6216.844578885519;6221.564490485668;6091.116788065706;6117.388261173847;6141.744875216098;6178.567500274982;6266.310705822356;5661.34894487131;5696.572757043238;5732.512736417368;5768.451997060272;5802.187693722883;6295.842603934938;6316.810495685045;6317.684115794192;6324.083007963912;6328.367163283635;5898.410158984153;6109.450149486479;6125.908111378333;6128.571000030044;6133.509319254449;6101.82280290701;6121.605402471149;6157.107219453154;6164.106204600397;6178.752849886044;6095.451409373178;6143.955527560325;6156.045812899008;6158.630482170995;6159.137720719103;6115.594416413446;6175.814725558241;6181.783637572664;6220.688965551704;6225.501959843202;4261.765602891871;4852.8544143675745;4883.95116048835;4888.340074090023;4890.095332363524;3459.3081383723356;4182.2681030820095;4426.380306757057;4432.645388368923;4526.253168227206;4918.803247870045;5763.423657634287;5763.88472230553;5786.797462088806;5788.160716696056;5761.625494342854;6116.974953844038;6289.55973081889;6293.056041593706;6308.905366419507;5736.340320863071;5756.597038207369;5757.942420575824;5763.9135412968835;5766.106253530709;5345.919811202835;5368.973155134199;5383.461653834585;5387.757550910218;5393.406725260218;6302.936970630327;6304.275008374096;6321.146645202839;6340.048992651139;6342.302346741947;6178.104174894705;6235.875282494234;6242.469390101711;6325.146105275729;6329.968350158219;5365.9463405367005;6243.313235543996;6309.936900630935;6317.905231421624;6322.146510221061;6020.307664618625;6182.319944806158;6188.9690551546955;6195.783147589813;6196.721147548281;6139.6454669416935;6178.382161783786;6197.194364732556;6210.968945155245;6215.564910456224;6109.144719739329;6121.300552271563;6127.142200091902;6129.754809807558;6131.110988906673;6051.576389652682;6083.026715725463;6106.938930610815;6115.266168059861;6124.173236613;5137.563307118937;5749.051406517878;5816.883662326645;5832.766689332549;5928.970355148197;5085.949140508547;6111.19673459643;6115.027386288435;6130.417610327012;6130.551011451029;5920.319163296276;5925.140854575976;5940;5969.134475501115;5983.551233657406 03:59:00 INFO - PROCESS | 1644 | |1;ext.html;478.3255609590476;504.0901173382044;510.77781165193136;517.2396577031764;525.3957948359389;31732.20669483264;33076.66923330766;33121.33757324855;34648.96053118404;34692.47961280583;32835.50746738801;33061.834690826574;33181.83409082957;33199.83400083002;33229.5015574766;7275.163356214037;7445;7447.255274472536;7450.478466507347;7456.925430745678;7714.382849372037;7780.455368124233;7787.610619469032;7788.80527986802;7795.532268063935;7727.536347819121;7770.533767973911;7791.883121753178;7818.12365032391;7824.061112666488;7742.109657389387;7789.454738168331;7789.727359542446;7793.688252469894;7799.805004874924;7679.2704693054075;7784.299413052796;7788.3769298456555;7799.805004874866;7803.453758236926;31347.84326078378;31690.207744806336;31736.682633173834;31756.20609484758;31806.363872722646;3225;3411.3347897160065;3585.1933315004176;3901.9804900975596;4028.798560072014;22000.669989950162;22091.889540552194;22109.226177083885;22166;22226.222082227043;2752.1330780803983;2764.7235276472393;2943.8675259613156;2962.9259268518244;2963.9110826675233;433461;435824;436966;438745;441315;48734;58246.70876645589;58398.4160158393;58560.70719646374;58590.82818343609;58940;60967.69516152391;61018;61192.69403652953;61361.693191533755;15757.212139393214;16023.599410014844;16039.278232479566;16076.517704468884;16092.356305747639;12441.315727634887;12493;12515.937420312841;12517.374131293582;12525.185862918881;16081.437149699705;16335.509934701979;16682.332706691595;16702.24839882208;16797.83202167987;5256.947430525645;5317.41508434072;6194.163787888578;6338.714757835908;6407.647579383085;757.246539693009;981.563204374061;997.9002099789963;1022.900382089257;1037.3983089807894;28408.289792754935;29041.709582904325;29578.704212957597;29590.704092958797;29749.405011899642;982.543117450389;1023.488255872064;1025.958961641541;1041.3075304922293;1070.4059247117768;15151.545453636409;15201.543953681186;15224.543263702106;15498;15606.580979948127;582511;586243;586795;588591;588760;50631.49368506341;50686.986260274585;50766.74616626893;50827.49172508228;50834;1195.2947760820985;1231.322772475135;1288.4846061575258;1298.6039258026392;1346.3133801760976;24183.879080604485;28166.2958426041;29116.12651620455;29757.851210743807;29853.402931941673;48581;49217.75391123021;49252.76868078183;49300;49347;450858.9656413707;486114;501704;502720;543404;23739.032620922386;23776.4055898597;24158.51682966366;24354.512909741352;24728.505429891662;35666.821665892545;41687.583124169585;42504.362434562885;42551.787241064834;43251.567484324754;34976.125596860285;34989.30021399507;35153.1211719709;35735.82132089427;35992.28015439624;28965.710342896302;34906.12734681653;35080.64919350876;35403.760868369485;35836.28327433489;35246.64753352434;35587.644123558435;35780.28439431249;36039;36360.454593181654;25853.482930341663;31034.534481982337;31602;31702.682973169973;31780.841095794374;23877.761222387555;24055;24067.879660601586;24116.642191387175;24761.62857557174 03:59:00 INFO - PROCESS | 1644 | |2;jquery.html;347.2343482620821;362.56130082600055;368.5706152332531;371.95164628598286;392.1216475095786;12135.089868259884;12353.320567368803;12796.424160912758;12928.030397720162;15958.920205398957;18635.534111647215;18709.532261693465;19590;19771.505712357197;19881.801181988176;3524.8061356625376;4452.3989261449615;5257.080010998079;5269.420363760002;5324.1747529133045;5204.375474943012;5236.502532259429;5239.449857764937;5246.186841039645;5337.7598008089535;4960.3303554020285;5220.92168617471;5253.6322457428;5253.7373131343475;5266.3153790007245;4316.115196384733;5219.608529360295;5234.214867769846;5276.7889284428575;5345.705986170759;4558.931616025762;4587.564181402761;4611.907761844778;4624.7687615619425;4625.514320996281;20940.685889711665;21450.46373840651;21484.140634374606;21756;21918;1914.5022294203468;2191.167356404572;2423.818213633967;3067.4631939410515;3154.3375891062906;9557.426554406758;9921.90078099217;12802.679933001657;13855.376508057161;14086.506972255922;1640.8441198086164;1658.6185177409143;1722.7415887616833;1735.1931351921417;1798.199801088516;109189;116441;116831;120314.59370812535;121468;11135.498902549405;11343.943280283545;11392.715182120513;11440.94279528597;11625.476853541611;13874.93062534681;13995.790063149061;14323.498677546237;14335.498257561145;14375.340561996065;8226.30076443509;8365.330773538102;8439.831203375898;8507.914920850835;8549.487030778173;8255.876161857577;8268.627911743866;8276.586170691442;8436.24073833358;8439.831203375898;3946.2699400610977;4220.388043733641;4450.354698568754;4475.328700694857;4521.570450807168;1838.9080545972647;1853.3605905962422;1906.4757191772096;1918.9712154317697;1940.4282531149813;739.6338812287952;828.9171082891662;845.7674139611656;864.6411739128191;980.1962390839443;20302;21199;21202.939853007287;21244.681329780065;21341.679874801892;926.8748718922994;931.469062634292;936.2042264075482;940.3229674634252;976.4190306767462;10413.531391087268;10671.25301228922;11091.611793587186;11156.888431115747;11308.660740177807;531864;596199;601735;602316;603563.982180095;78125.53121281456;85968;96590;112539;135517;909.3997961345481;989.5299732627088;999.7950420163849;1008.324422636835;1008.4000019988096;15434.073955562702;17768.022758747877;18408.895466272068;18626.72059919075;18710;47875;53451;53830;57419;57458.71270643787;72938.63530682313;73598;75458;75582.24417755973;77372.61313693396;7504.587247701429;7754.340881025176;7969;8021.478603890729;8292.751217463485;10784.568617255221;12520.436580354088;12556.560520382109;12834.743305134032;12934.482620695444;10889.965453281926;10915.235933484897;11060.225784195029;11252.381119038204;11319.377434241196;10471.795743489292;10752.892471075189;11080.113590912546;11269.436528173395;11624.709382265512;11095.833562496731;11301.378424186749;11393;11574.6527604172;11588.420578970849;8015.6392962318005;8033.437659363788;8097.446875991185;8443.535605541754;8475.194856488624;8343.45767525109;10189.796204076025;11301.943490282496;11541.480633371686;11649.068074554185 03:59:00 INFO - PROCESS | 1644 | |3;mootools.html;1466.4354223623905;1486.1825995702363;1649.5793572638975;1772.8581713462909;1837.6049149432877;7062.258462861396;7632.160462349144;8031.4377993540475;8044.637991290391;8059.274665280138;7143.464240181994;7367.852642947151;7369.852602947938;7668.156502784689;7878.527288362688;2011.2558353409258;2057.77364489906;2063.0819285417997;2067.8138967492923;2071.54426026274;2019.7273368095339;2030.4517780199337;2033.6339458897392;2058.9794102058936;2110.831133509323;1817.690992531273;1883.2372888979917;1891.527118220445;2051.0975170924744;2076.948076298097;2003.9799602003939;2081.313166655008;2084.593504266669;2091.874487530753;2096.821770149539;2080.916763329465;2084.603925254197;2101.9264325748527;2102.6845973104155;2119.7668256491775;7807.726729564438;7977.962864827593;7983.720569780088;7988.840223195503;7995.2804247618;4985.102681517325;5150.459201783834;5155.252488389163;5156.587473002151;5158.226266060084;3147.213196700825;3403.3873902697505;3476.235228249781;3480.738944579167;3509.2279698466295;938.2306508662899;959.6209497248548;1020.9438480883548;1025.3642741500319;1594.6013496625844;10656.840147397796;10878.401687907162;10917.454127293682;10931;10938.945305273422;4116.547179810218;4328;4374.147041326911;4388.29787234041;4393.934090988638;8546.145385461405;8644.265237454887;8662.133786621413;8662.393632445794;8672.739817805475;5053.065182941167;5061.190209566452;5061.721605311744;5068.16375298079;5071.137906555894;4624.838130665411;4666.719996800203;4682.759068846758;4743.976280118646;4750.216214324598;3536.80547569881;3586.336527742324;3593.5148754918273;3619.4208926571623;3638.7270954678506;1112.821948488238;1114.5541783286587;1116.0792346314324;1118.2060736876747;1127.2841745491507;658.8451713847242;774.3147314626596;871.7166920750782;879.2394578689388;903.8418276801533;4583.977080114645;4754.976225118852;4979.929315197178;5641.576881733887;5671.546276297886;868.7567481105301;891.148952750122;899.6986009686698;904.1455824246156;930.0885132570119;3601.585817631006;3618.4210526315665;3758.605346438639;3815.198808250243;3822.292875817927;9769.658061967797;9822;9941.254405919584;10042.096211341015;10115.241356898263;9927.453990030617;10123.898761012442;10131.746706332253;10133.64532241368;10153.4923253837;7257.092863392076;7512.962435187789;7531.585762783099;7604.885926711104;7741.690332386642;5194.844154675366;5287.704512394488;5330.54690351309;5391.460853914734;5684.687342196219;9365.438073715599;9423.340366174301;9440.575174117044;9459.952700236454;9473.47895865734;8704.477731336141;9226.630934762534;9480.194183494204;9647.855282170633;9648.71053868385;7148.070750802571;7296.379807716404;7301.160366557914;7302.817429564091;7303.488755787044;7827.139014708491;7840.294373506412;7866.095399029185;7918.802029949297;7922.445428819928;6799.898001529882;7042.366187043191;7076.22161562238;7140.321669441395;7167.8924816126755;5578.30271216098;6854.074699915447;6928.965355173394;7008.544444611084;7154.642267886689;6548.443382312556;6567.9671601643595;6722.932770672231;6728.327167283428;6732.798016059526;4637.837675681335;4670.766461676971;4701.482836887872;4865.270209468466;4931.580815630711;4221.176870510344;4767.118083154627;4906.9018619626695;4931.827386041471;5063.265826455217 03:59:00 INFO - PROCESS | 1644 | |4;prototype.html;299.6120024568184;299.8740528977829;306.32302611229187;311.67741387663756;314.9984250078749;5214.028004037696;5275.0768615492325;5297.602679799016;5299.708516031616;5344.625876188668;4492.887677808057;4571.428571428572;4976.800927962886;5119.948800511994;5130.410002849664;3472.3923313420178;3668.578113516953;3750.343689854278;3938.3304838177437;3947.3092208863404;3469.9653003469894;3842.4236364545404;3982.3230050891275;3986.1429792594586;4017;3459.4605400596743;3730.5896351401325;3912.2762288976487;3952.2490726761966;3970.642642162205;3325.2684409429885;3919.804009799527;3926.0773718176206;3929.8014105697753;3973.6225058619384;3399.5920489541413;3404.557407537029;3415.624281329052;3419.504171895086;3420.4869269609508;5052.4189718182515;5076.746162691888;5083.491650834924;5083.949160508385;5108.463611320795;4248.766317852517;4404.911901761979;4432.246518091933;4474.664400169968;4487.416635837353;4526.932096018562;5411.161270003156;5418.891622167574;5419.729013549307;5527.972360138214;3721.665050145473;3731.4589384539363;3734.7572407793677;3736.7010639148803;3762.435634654796;5335.706536140511;5649.632773869726;5708.058170401879;5734.8780951048375;5738.340090889601;3776.9802153418423;3780.432935059763;3790.886273411802;3794.8671796487542;3796.6393192646656;3566.6076731559506;3594.986807387871;3845.558070625173;3869.5356557213313;3880.320943834874;4041.3399506167993;4270.658347332206;4300.903269666215;4359.716618419792;4471.6361509739845;4856.902861942812;5039.823606173766;5407.972960135174;5461.126219804892;5480.479354461319;1152.9654110376703;1223.3699644682995;1238.2137342787396;1241.509603706531;1243.639344590077;788.0779487999055;798.2336956521688;814.8429230492715;815.6778072661266;817.1705718695529;4197.929527970409;4339.895150851834;4411.382406463098;4772.928406073912;4825.9034819303415;4432.49026361966;4916.06594746997;5039.185893078489;5402.756875940592;5503.257060296809;3860.7876566789096;4261.765602891871;4848.097281688275;4898.007944330004;5034.395872495324;2665.653465049531;2839.6592408911065;2866.154484427099;2869.3543952610494;2880.6111174991106;5528.419515950848;5535.58483113768;5565.801508404239;5578.553715702734;5616.5787565931905;4900.779464924087;5027.899442011139;5032.339328021744;5059.645824792229;5369.5167434931045;4763.428388593391;5258.474152584711;5446.863828404322;5578.843761397785;5587.74855131512;4958.950410495849;5224.791008359623;5296;5349.3848207455085;5374;4868.3934301681065;5269.631125821309;5295.25866378715;5326.227696983993;5363.651362661414;4615.861524154281;5523.4200408956485;5536.916946245729;5547.916781248204;5550.111982082847;3081.245094951751;3114.9688503115585;3202.6957439043254;3471.8579685383756;3483.9303213936087;5117.283580298836;5118.564921981524;5384.703841288767;5714.399988001366;5742.196092546963;4836.975815120902;5542.972285138549;5543.861403464945;5558.3315012091825;5560.108743453301;5141.2288156776785;5545.889082218414;5545.944540554704;5551.694656793915;5593.216949627137;4791.928121078117;5391.16436952273;5432.809851655173;5450.928647114071;5456.61803673739;4713.717176969393;4924;5224.7126408047925;5255.400050965101;5469.507744303032;5173.534381905646;5407.242985982044;5410.431904650112;5422.457754224546;5476.002518161685 03:59:00 INFO - PROCESS | 1644 | |5;yui.html;680.4760334542402;707.5895980331405;714.6498215874224;768.2010708862783;771.6643260181818;13083.345832708363;13547.390367433465;13885.722285554308;14109.082909610868;14134.64663383416;12056.578019769287;12609.4325755341;12730.872691273107;12743.808842867342;12751.936240318808;784.2784638132918;817.4318848400364;818.8321394114192;819.7417813388794;821.3716506872247;646.615263917968;667.7562689618279;785.937125029999;818.3330585572769;818.9140140285274;847.0555330806137;858.8883445152121;861.1603686405767;862.2067697718084;862.4437237981498;846.2468403121227;852.4373913217247;854.1543871567166;854.44461100285;855.649183834631;498.9716801203134;514.0105297302678;633.8637193003526;635.3836778325017;640.69887153038;12089.395530223454;12515.499380024788;12537.686557836127;12622;12679;10390.948045259802;10545.84181237282;10658.626948056859;10773.138148948065;10982.835257471144;9400.811983760355;9410.529473526365;9500.334976551645;9516.23870090391;9848.704538863845;3015.8642861071085;3063.6170478690165;3074.4927087030615;3082.6917308269217;3155.0377134973824;87446.56276718639;89214.55392723059;89225;89249;89768.10231897663;8170.264676179172;8413.158684131538;8438.704645337384;8446.57767111642;8465.492070475791;17007.744883826752;17067.402640907756;17402.564935876704;17509;17535.03557304335;7476.289752473506;7519.511231769918;7519.586422746692;7625.199354067854;7688.231176882267;4117.608827161415;4245.596668316505;4247.936280955788;4250.213710463574;4270.42349282849;2875.180573536532;3228.7094161525574;3289.3256882339065;3343.6656334366367;3344.9832750836576;534.1747000883644;557.6598275052215;637.2957881540831;642.1972534332085;649.084790445479;525.5296509623942;530.3503208569472;584.4081498553927;633.6293268437923;666.8332916770808;8517.659293628309;8640;8797.912020879838;8850.159234872677;9124.680636177702;512.190738632959;542.1650657986735;595.4700316718124;636.3636363636364;642.9132067170872;4281.464816897887;4390.824367025283;4397.384366188736;4440.111977604427;4540.2054640438455;76009.61995189989;92978.53510732538;115957.84042159471;117734.41132794453;118562.4071879635;67497.3125671862;69892;101074.98925010803;106549;108006.45996769966;89265.55367223122;90371;93845.53077234571;93857;95331.0466895336;8478.83042339162;8631.26634236097;8671.653133874574;8673.262772664395;8674.609642565974;58491;58595.828083438944;60197.699011504665;60530;61222.08166877411;81308;83062.7865238185;86007;86390;88336.25814322049;9208;10899.182561308093;10918.344899306067;10966.670999870017;11471.311721296748;11168.66494005181;11209.775804484028;11864.466099025392;12066.044880226073;12295.9385203077;11705.531778728755;11824.881751182722;11878.584249551224;12022.819657704966;12107.273563586214;11684.449886303937;11908.702282443008;11948.46231919583;12086.51653933868;12227.816582751087;11302.717432064264;11798.233114847508;11868.703282418008;11955.760884782081;12155.635330940086;9392.154706076486;10008.549615267477;10013.349132306377;10070.99290070987;10182.643607473703;9324.393914395814;9813.11681948628;9819.683031150946;9832.508374581384;9944.84463662496 03:59:00 INFO - PROCESS | 1644 | __end_tp_report 03:59:00 INFO - PROCESS | 1644 | __start_cc_report 03:59:00 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1885 03:59:00 INFO - PROCESS | 1644 | __end_cc_report 03:59:00 INFO - PROCESS | 1644 | __startTimestamp1479470340012__endTimestamp 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | ------- Summary: start ------- 03:59:00 INFO - PROCESS | 1644 | Number of tests: 6 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5676.66 Median:5898.41 stddev:681.63 (11.6%) stddev-sans-first:657.97 03:59:00 INFO - PROCESS | 1644 | Values: 3310.6 3331.3 3337.8 3368.6 3378.6 4410.9 5299.7 5542.6 5631.0 5666.3 5652.6 5655.2 5656.5 5687.3 5696.0 4336.7 5140.7 5173.9 5253.9 5255.0 5149.9 5212.6 5251.3 5287.2 5297.7 5241.8 5276.4 5286.9 5296.6 5311.8 5086.7 5238.3 5246.1 5256.7 5309.7 5127.3 5132.7 5156.0 5174.7 5193.3 4652.5 5590.2 5623.0 5628.3 5649.7 6200.1 6206.5 6211.8 6216.8 6221.6 6091.1 6117.4 6141.7 6178.6 6266.3 5661.3 5696.6 5732.5 5768.5 5802.2 6295.8 6316.8 6317.7 6324.1 6328.4 5898.4 6109.5 6125.9 6128.6 6133.5 6101.8 6121.6 6157.1 6164.1 6178.8 6095.5 6144.0 6156.0 6158.6 6159.1 6115.6 6175.8 6181.8 6220.7 6225.5 4261.8 4852.9 4884.0 4888.3 4890.1 3459.3 4182.3 4426.4 4432.6 4526.3 4918.8 5763.4 5763.9 5786.8 5788.2 5761.6 6117.0 6289.6 6293.1 6308.9 5736.3 5756.6 5757.9 5763.9 5766.1 5345.9 5369.0 5383.5 5387.8 5393.4 6302.9 6304.3 6321.1 6340.0 6342.3 6178.1 6235.9 6242.5 6325.1 6330.0 5365.9 6243.3 6309.9 6317.9 6322.1 6020.3 6182.3 6189.0 6195.8 6196.7 6139.6 6178.4 6197.2 6211.0 6215.6 6109.1 6121.3 6127.1 6129.8 6131.1 6051.6 6083.0 6106.9 6115.3 6124.2 5137.6 5749.1 5816.9 5832.8 5929.0 5085.9 6111.2 6115.0 6130.4 6130.6 5920.3 5925.1 5940.0 5969.1 5983.6 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:62662.49 Median:35495.70 stddev:136579.51 (384.8%) stddev-sans-first:136882.85 03:59:00 INFO - PROCESS | 1644 | Values: 478.3 504.1 510.8 517.2 525.4 31732.2 33076.7 33121.3 34649.0 34692.5 32835.5 33061.8 33181.8 33199.8 33229.5 7275.2 7445.0 7447.3 7450.5 7456.9 7714.4 7780.5 7787.6 7788.8 7795.5 7727.5 7770.5 7791.9 7818.1 7824.1 7742.1 7789.5 7789.7 7793.7 7799.8 7679.3 7784.3 7788.4 7799.8 7803.5 31347.8 31690.2 31736.7 31756.2 31806.4 3225.0 3411.3 3585.2 3902.0 4028.8 22000.7 22091.9 22109.2 22166.0 22226.2 2752.1 2764.7 2943.9 2962.9 2963.9 433461.0 435824.0 436966.0 438745.0 441315.0 48734.0 58246.7 58398.4 58560.7 58590.8 58940.0 60967.7 61018.0 61192.7 61361.7 15757.2 16023.6 16039.3 16076.5 16092.4 12441.3 12493.0 12515.9 12517.4 12525.2 16081.4 16335.5 16682.3 16702.2 16797.8 5256.9 5317.4 6194.2 6338.7 6407.6 757.2 981.6 997.9 1022.9 1037.4 28408.3 29041.7 29578.7 29590.7 29749.4 982.5 1023.5 1026.0 1041.3 1070.4 15151.5 15201.5 15224.5 15498.0 15606.6 582511.0 586243.0 586795.0 588591.0 588760.0 50631.5 50687.0 50766.7 50827.5 50834.0 1195.3 1231.3 1288.5 1298.6 1346.3 24183.9 28166.3 29116.1 29757.9 29853.4 48581.0 49217.8 49252.8 49300.0 49347.0 450859.0 486114.0 501704.0 502720.0 543404.0 23739.0 23776.4 24158.5 24354.5 24728.5 35666.8 41687.6 42504.4 42551.8 43251.6 34976.1 34989.3 35153.1 35735.8 35992.3 28965.7 34906.1 35080.6 35403.8 35836.3 35246.6 35587.6 35780.3 36039.0 36360.5 25853.5 31034.5 31602.0 31702.7 31780.8 23877.8 24055.0 24067.9 24116.6 24761.6 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:33444.87 Median:1750.79 stddev:97693.15 (5580.0%) stddev-sans-first:97935.59 03:59:00 INFO - PROCESS | 1644 | Values: 347.2 362.6 368.6 372.0 392.1 12135.1 12353.3 12796.4 12928.0 15958.9 18635.5 18709.5 19590.0 19771.5 19881.8 3524.8 4452.4 5257.1 5269.4 5324.2 5204.4 5236.5 5239.4 5246.2 5337.8 4960.3 5220.9 5253.6 5253.7 5266.3 4316.1 5219.6 5234.2 5276.8 5345.7 4558.9 4587.6 4611.9 4624.8 4625.5 20940.7 21450.5 21484.1 21756.0 21918.0 1914.5 2191.2 2423.8 3067.5 3154.3 9557.4 9921.9 12802.7 13855.4 14086.5 1640.8 1658.6 1722.7 1735.2 1798.2 109189.0 116441.0 116831.0 120314.6 121468.0 11135.5 11343.9 11392.7 11440.9 11625.5 13874.9 13995.8 14323.5 14335.5 14375.3 8226.3 8365.3 8439.8 8507.9 8549.5 8255.9 8268.6 8276.6 8436.2 8439.8 3946.3 4220.4 4450.4 4475.3 4521.6 1838.9 1853.4 1906.5 1919.0 1940.4 739.6 828.9 845.8 864.6 980.2 20302.0 21199.0 21202.9 21244.7 21341.7 926.9 931.5 936.2 940.3 976.4 10413.5 10671.3 11091.6 11156.9 11308.7 531864.0 596199.0 601735.0 602316.0 603564.0 78125.5 85968.0 96590.0 112539.0 135517.0 909.4 989.5 999.8 1008.3 1008.4 15434.1 17768.0 18408.9 18626.7 18710.0 47875.0 53451.0 53830.0 57419.0 57458.7 72938.6 73598.0 75458.0 75582.2 77372.6 7504.6 7754.3 7969.0 8021.5 8292.8 10784.6 12520.4 12556.6 12834.7 12934.5 10890.0 10915.2 11060.2 11252.4 11319.4 10471.8 10752.9 11080.1 11269.4 11624.7 11095.8 11301.4 11393.0 11574.7 11588.4 8015.6 8033.4 8097.4 8443.5 8475.2 8343.5 10189.8 11301.9 11541.5 11649.1 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5287.84 Median:5065.71 stddev:2958.89 (58.4%) stddev-sans-first:2953.25 03:59:00 INFO - PROCESS | 1644 | Values: 1466.4 1486.2 1649.6 1772.9 1837.6 7062.3 7632.2 8031.4 8044.6 8059.3 7143.5 7367.9 7369.9 7668.2 7878.5 2011.3 2057.8 2063.1 2067.8 2071.5 2019.7 2030.5 2033.6 2059.0 2110.8 1817.7 1883.2 1891.5 2051.1 2076.9 2004.0 2081.3 2084.6 2091.9 2096.8 2080.9 2084.6 2101.9 2102.7 2119.8 7807.7 7978.0 7983.7 7988.8 7995.3 4985.1 5150.5 5155.3 5156.6 5158.2 3147.2 3403.4 3476.2 3480.7 3509.2 938.2 959.6 1020.9 1025.4 1594.6 10656.8 10878.4 10917.5 10931.0 10938.9 4116.5 4328.0 4374.1 4388.3 4393.9 8546.1 8644.3 8662.1 8662.4 8672.7 5053.1 5061.2 5061.7 5068.2 5071.1 4624.8 4666.7 4682.8 4744.0 4750.2 3536.8 3586.3 3593.5 3619.4 3638.7 1112.8 1114.6 1116.1 1118.2 1127.3 658.8 774.3 871.7 879.2 903.8 4584.0 4755.0 4979.9 5641.6 5671.5 868.8 891.1 899.7 904.1 930.1 3601.6 3618.4 3758.6 3815.2 3822.3 9769.7 9822.0 9941.3 10042.1 10115.2 9927.5 10123.9 10131.7 10133.6 10153.5 7257.1 7513.0 7531.6 7604.9 7741.7 5194.8 5287.7 5330.5 5391.5 5684.7 9365.4 9423.3 9440.6 9460.0 9473.5 8704.5 9226.6 9480.2 9647.9 9648.7 7148.1 7296.4 7301.2 7302.8 7303.5 7827.1 7840.3 7866.1 7918.8 7922.4 6799.9 7042.4 7076.2 7140.3 7167.9 5578.3 6854.1 6929.0 7008.5 7154.6 6548.4 6568.0 6722.9 6728.3 6732.8 4637.8 4670.8 4701.5 4865.3 4931.6 4221.2 4767.1 4906.9 4931.8 5063.3 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4346.06 Median:4908.42 stddev:1337.65 (27.3%) stddev-sans-first:1306.47 03:59:00 INFO - PROCESS | 1644 | Values: 299.6 299.9 306.3 311.7 315.0 5214.0 5275.1 5297.6 5299.7 5344.6 4492.9 4571.4 4976.8 5119.9 5130.4 3472.4 3668.6 3750.3 3938.3 3947.3 3470.0 3842.4 3982.3 3986.1 4017.0 3459.5 3730.6 3912.3 3952.2 3970.6 3325.3 3919.8 3926.1 3929.8 3973.6 3399.6 3404.6 3415.6 3419.5 3420.5 5052.4 5076.7 5083.5 5083.9 5108.5 4248.8 4404.9 4432.2 4474.7 4487.4 4526.9 5411.2 5418.9 5419.7 5528.0 3721.7 3731.5 3734.8 3736.7 3762.4 5335.7 5649.6 5708.1 5734.9 5738.3 3777.0 3780.4 3790.9 3794.9 3796.6 3566.6 3595.0 3845.6 3869.5 3880.3 4041.3 4270.7 4300.9 4359.7 4471.6 4856.9 5039.8 5408.0 5461.1 5480.5 1153.0 1223.4 1238.2 1241.5 1243.6 788.1 798.2 814.8 815.7 817.2 4197.9 4339.9 4411.4 4772.9 4825.9 4432.5 4916.1 5039.2 5402.8 5503.3 3860.8 4261.8 4848.1 4898.0 5034.4 2665.7 2839.7 2866.2 2869.4 2880.6 5528.4 5535.6 5565.8 5578.6 5616.6 4900.8 5027.9 5032.3 5059.6 5369.5 4763.4 5258.5 5446.9 5578.8 5587.7 4959.0 5224.8 5296.0 5349.4 5374.0 4868.4 5269.6 5295.3 5326.2 5363.7 4615.9 5523.4 5536.9 5547.9 5550.1 3081.2 3115.0 3202.7 3471.9 3483.9 5117.3 5118.6 5384.7 5714.4 5742.2 4837.0 5543.0 5543.9 5558.3 5560.1 5141.2 5545.9 5545.9 5551.7 5593.2 4791.9 5391.2 5432.8 5450.9 5456.6 4713.7 4924.0 5224.7 5255.4 5469.5 5173.5 5407.2 5410.4 5422.5 5476.0 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20276.99 Median:30396.58 stddev:31002.76 (102.0%) stddev-sans-first:31054.82 03:59:00 INFO - PROCESS | 1644 | Values: 680.5 707.6 714.6 768.2 771.7 13083.3 13547.4 13885.7 14109.1 14134.6 12056.6 12609.4 12730.9 12743.8 12751.9 784.3 817.4 818.8 819.7 821.4 646.6 667.8 785.9 818.3 818.9 847.1 858.9 861.2 862.2 862.4 846.2 852.4 854.2 854.4 855.6 499.0 514.0 633.9 635.4 640.7 12089.4 12515.5 12537.7 12622.0 12679.0 10390.9 10545.8 10658.6 10773.1 10982.8 9400.8 9410.5 9500.3 9516.2 9848.7 3015.9 3063.6 3074.5 3082.7 3155.0 87446.6 89214.6 89225.0 89249.0 89768.1 8170.3 8413.2 8438.7 8446.6 8465.5 17007.7 17067.4 17402.6 17509.0 17535.0 7476.3 7519.5 7519.6 7625.2 7688.2 4117.6 4245.6 4247.9 4250.2 4270.4 2875.2 3228.7 3289.3 3343.7 3345.0 534.2 557.7 637.3 642.2 649.1 525.5 530.4 584.4 633.6 666.8 8517.7 8640.0 8797.9 8850.2 9124.7 512.2 542.2 595.5 636.4 642.9 4281.5 4390.8 4397.4 4440.1 4540.2 76009.6 92978.5 115957.8 117734.4 118562.4 67497.3 69892.0 101075.0 106549.0 108006.5 89265.6 90371.0 93845.5 93857.0 95331.0 8478.8 8631.3 8671.7 8673.3 8674.6 58491.0 58595.8 60197.7 60530.0 61222.1 81308.0 83062.8 86007.0 86390.0 88336.3 9208.0 10899.2 10918.3 10966.7 11471.3 11168.7 11209.8 11864.5 12066.0 12295.9 11705.5 11824.9 11878.6 12022.8 12107.3 11684.4 11908.7 11948.5 12086.5 12227.8 11302.7 11798.2 11868.7 11955.8 12155.6 9392.2 10008.5 10013.3 10071.0 10182.6 9324.4 9813.1 9819.7 9832.5 9944.8 03:59:00 INFO - PROCESS | 1644 | -------- Summary: end -------- 03:59:00 INFO - PROCESS | 1644 | 03:59:00 INFO - TEST-INFO | 1644: exit 0 03:59:00 INFO - TEST-OK | dromaeo_css | took 1119608ms 03:59:00 INFO - TEST-START | kraken 03:59:00 INFO - operating with platform_type : mac_ 03:59:00 INFO - Initialising browser for kraken test... 03:59:00 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpBoRg_w/profile http://localhost:49244/getInfo.html) 03:59:02 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 03:59:02 INFO - PROCESS | 1658 | colorDepth:24 03:59:02 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 03:59:02 INFO - PROCESS | 1658 | __metrics 03:59:03 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:59:03 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:03 INFO - TEST-INFO | 1658: exit 0 03:59:03 INFO - Browser initialized. 03:59:03 INFO - Running cycle 1/1 for kraken test... 03:59:03 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpBoRg_w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:15 INFO - PROCESS | 1659 | RSS: Main: 229928960 03:59:15 INFO - PROCESS | 1659 | 03:59:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:19 INFO - PROCESS | 1659 | RSS: Main: 289599488 03:59:19 INFO - PROCESS | 1659 | 03:59:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 03:59:22 INFO - PROCESS | 1659 | RSS: Main: 292372480 03:59:22 INFO - PROCESS | 1659 | 03:59:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 03:59:26 INFO - PROCESS | 1659 | RSS: Main: 381460480 03:59:26 INFO - PROCESS | 1659 | 03:59:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 03:59:29 INFO - PROCESS | 1659 | RSS: Main: 282763264 03:59:29 INFO - PROCESS | 1659 | 03:59:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:32 INFO - PROCESS | 1659 | RSS: Main: 287404032 03:59:32 INFO - PROCESS | 1659 | 03:59:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:35 INFO - PROCESS | 1659 | RSS: Main: 328962048 03:59:35 INFO - PROCESS | 1659 | 03:59:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:39 INFO - PROCESS | 1659 | RSS: Main: 330031104 03:59:39 INFO - PROCESS | 1659 | 03:59:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 03:59:42 INFO - PROCESS | 1659 | RSS: Main: 327630848 03:59:42 INFO - PROCESS | 1659 | 03:59:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:44 INFO - PROCESS | 1659 | RSS: Main: 303583232 03:59:44 INFO - PROCESS | 1659 | 03:59:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:47 INFO - PROCESS | 1659 | RSS: Main: 305537024 03:59:47 INFO - PROCESS | 1659 | 03:59:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:50 INFO - PROCESS | 1659 | RSS: Main: 314675200 03:59:50 INFO - PROCESS | 1659 | 03:59:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:54 INFO - PROCESS | 1659 | RSS: Main: 321712128 03:59:54 INFO - PROCESS | 1659 | 03:59:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:57 INFO - PROCESS | 1659 | RSS: Main: 322039808 03:59:57 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 03:59:59 INFO - PROCESS | 1659 | RSS: Main: 365309952 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | __start_tp_report 03:59:59 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 03:59:59 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 03:59:59 INFO - PROCESS | 1659 | |i|pagename|runs| 03:59:59 INFO - PROCESS | 1659 | |0;ai-astar;111;114;114;113;114;115;114;115;114;113 03:59:59 INFO - PROCESS | 1659 | |1;audio-beat-detection;151;116;112;150;112;121;136;135;167;115 03:59:59 INFO - PROCESS | 1659 | |2;audio-dft;180;183;183;186;184;183;185;185;183;179 03:59:59 INFO - PROCESS | 1659 | |3;audio-fft;81;59;59;91;84;81;82;68;83;57 03:59:59 INFO - PROCESS | 1659 | |4;audio-oscillator;92;70;113;99;97;75;91;69;69;93 03:59:59 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;89;86;88;85;88;86;87;86;89;84 03:59:59 INFO - PROCESS | 1659 | |6;imaging-darkroom;97;97;97;101;94;97;95;97;96;96 03:59:59 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;85;85;85;87;85;84;90;85;84 03:59:59 INFO - PROCESS | 1659 | |8;json-parse-financial;55;53;54;54;55;55;55;55;54;54 03:59:59 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;66;72;68;76;73;69;71;71;71;73 03:59:59 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;86;88;104;91;91;90;88;87;78;107 03:59:59 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;141;147;138;158;154;164;152;152;201;154 03:59:59 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;178;171;223;234;176;171;172;175;173;170 03:59:59 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;69;67;68;66;68;68;67;66;68;67 03:59:59 INFO - PROCESS | 1659 | __end_tp_report 03:59:59 INFO - PROCESS | 1659 | __start_cc_report 03:59:59 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2002 03:59:59 INFO - PROCESS | 1659 | __end_cc_report 03:59:59 INFO - PROCESS | 1659 | __startTimestamp1479470399812__endTimestamp 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | ------- Summary: start ------- 03:59:59 INFO - PROCESS | 1659 | Number of tests: 14 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:0.71 03:59:59 INFO - PROCESS | 1659 | Values: 111.0 114.0 114.0 113.0 114.0 115.0 114.0 115.0 114.0 113.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:135.50 stddev:19.43 (14.3%) stddev-sans-first:19.29 03:59:59 INFO - PROCESS | 1659 | Values: 151.0 116.0 112.0 150.0 112.0 121.0 136.0 135.0 167.0 115.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:2.18 (1.2%) stddev-sans-first:2.01 03:59:59 INFO - PROCESS | 1659 | Values: 180.0 183.0 183.0 186.0 184.0 183.0 185.0 185.0 183.0 179.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:74.50 Median:81.50 stddev:12.49 (15.3%) stddev-sans-first:13.03 03:59:59 INFO - PROCESS | 1659 | Values: 81.0 59.0 59.0 91.0 84.0 81.0 82.0 68.0 83.0 57.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:91.50 stddev:15.19 (16.6%) stddev-sans-first:16.00 03:59:59 INFO - PROCESS | 1659 | Values: 92.0 70.0 113.0 99.0 97.0 75.0 91.0 69.0 69.0 93.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.69 (1.9%) stddev-sans-first:1.59 03:59:59 INFO - PROCESS | 1659 | Values: 89.0 86.0 88.0 85.0 88.0 86.0 87.0 86.0 89.0 84.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:1.83 (1.9%) stddev-sans-first:1.94 03:59:59 INFO - PROCESS | 1659 | Values: 97.0 97.0 97.0 101.0 94.0 97.0 95.0 97.0 96.0 96.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:1.84 (2.2%) stddev-sans-first:1.88 03:59:59 INFO - PROCESS | 1659 | Values: 84.0 85.0 85.0 85.0 87.0 85.0 84.0 90.0 85.0 84.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 03:59:59 INFO - PROCESS | 1659 | Values: 55.0 53.0 54.0 54.0 55.0 55.0 55.0 55.0 54.0 54.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:2.83 (4.0%) stddev-sans-first:2.35 03:59:59 INFO - PROCESS | 1659 | Values: 66.0 72.0 68.0 76.0 73.0 69.0 71.0 71.0 71.0 73.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:88.00 stddev:8.52 (9.7%) stddev-sans-first:8.85 03:59:59 INFO - PROCESS | 1659 | Values: 86.0 88.0 104.0 91.0 91.0 90.0 88.0 87.0 78.0 107.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:154.00 stddev:17.52 (11.4%) stddev-sans-first:17.71 03:59:59 INFO - PROCESS | 1659 | Values: 141.0 147.0 138.0 158.0 154.0 164.0 152.0 152.0 201.0 154.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:175.50 stddev:23.57 (13.4%) stddev-sans-first:24.89 03:59:59 INFO - PROCESS | 1659 | Values: 178.0 171.0 223.0 234.0 176.0 171.0 172.0 175.0 173.0 170.0 03:59:59 INFO - PROCESS | 1659 | 03:59:59 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 03:59:59 INFO - PROCESS | 1659 | Values: 69.0 67.0 68.0 66.0 68.0 68.0 67.0 66.0 68.0 67.0 03:59:59 INFO - PROCESS | 1659 | -------- Summary: end -------- 03:59:59 INFO - PROCESS | 1659 | 04:00:00 INFO - TEST-INFO | 1659: exit 0 04:00:00 INFO - TEST-OK | kraken | took 60034ms 04:00:00 INFO - SUITE-END | took 1179s 04:00:00 INFO - Completed test suite (00:19:39) 04:00:00 INFO - javascript benchmark 04:00:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.5530753348294, 3331.3337332533483, 3337.766356355053, 3368.6294507604175, 3378.611459682136, 4410.853178173674, 5299.735013249337, 5542.63972841765, 5630.971845140773, 5666.320041595014, 5652.604317697763, 5655.208270842086, 5656.460819927353, 5687.317521897367, 5695.971520142393, 4336.696431249814, 5140.691558506502, 5173.922391164136, 5253.947460525404, 5254.999999999981, 5149.922751158736, 5212.635115541913, 5251.264822924793, 5287.206918962148, 5297.708626025567, 5241.79032838686, 5276.393214780292, 5286.867828304285, 5296.576273898098, 5311.760970756306, 5086.669366491166, 5238.266642670029, 5246.108161612535, 5256.658317209369, 5309.654872433318, 5127.256547800548, 5132.717700526469, 5156.0, 5174.689518628894, 5193.324867767204, 4652.464966528825, 5590.217369568264, 5622.971885140548, 5628.296462942132, 5649.717514124277, 6200.069989501566, 6206.472449841724, 6211.844703882394, 6216.844578885519, 6221.564490485668, 6091.116788065706, 6117.388261173847, 6141.744875216098, 6178.567500274982, 6266.310705822356, 5661.34894487131, 5696.572757043238, 5732.512736417368, 5768.451997060272, 5802.187693722883, 6295.842603934938, 6316.810495685045, 6317.684115794192, 6324.083007963912, 6328.367163283635, 5898.410158984153, 6109.450149486479, 6125.908111378333, 6128.571000030044, 6133.509319254449, 6101.82280290701, 6121.605402471149, 6157.107219453154, 6164.106204600397, 6178.752849886044, 6095.451409373178, 6143.955527560325, 6156.045812899008, 6158.630482170995, 6159.137720719103, 6115.594416413446, 6175.814725558241, 6181.783637572664, 6220.688965551704, 6225.501959843202, 4261.765602891871, 4852.8544143675745, 4883.95116048835, 4888.340074090023, 4890.095332363524, 3459.3081383723356, 4182.2681030820095, 4426.380306757057, 4432.645388368923, 4526.253168227206, 4918.803247870045, 5763.423657634287, 5763.88472230553, 5786.797462088806, 5788.160716696056, 5761.625494342854, 6116.974953844038, 6289.55973081889, 6293.056041593706, 6308.905366419507, 5736.340320863071, 5756.597038207369, 5757.942420575824, 5763.9135412968835, 5766.106253530709, 5345.919811202835, 5368.973155134199, 5383.461653834585, 5387.757550910218, 5393.406725260218, 6302.936970630327, 6304.275008374096, 6321.146645202839, 6340.048992651139, 6342.302346741947, 6178.104174894705, 6235.875282494234, 6242.469390101711, 6325.146105275729, 6329.968350158219, 5365.9463405367005, 6243.313235543996, 6309.936900630935, 6317.905231421624, 6322.146510221061, 6020.307664618625, 6182.319944806158, 6188.9690551546955, 6195.783147589813, 6196.721147548281, 6139.6454669416935, 6178.382161783786, 6197.194364732556, 6210.968945155245, 6215.564910456224, 6109.144719739329, 6121.300552271563, 6127.142200091902, 6129.754809807558, 6131.110988906673, 6051.576389652682, 6083.026715725463, 6106.938930610815, 6115.266168059861, 6124.173236613, 5137.563307118937, 5749.051406517878, 5816.883662326645, 5832.766689332549, 5928.970355148197, 5085.949140508547, 6111.19673459643, 6115.027386288435, 6130.417610327012, 6130.551011451029, 5920.319163296276, 5925.140854575976, 5940.0, 5969.134475501115, 5983.551233657406], "value": 5632.642371791414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.3255609590476, 504.0901173382044, 510.77781165193136, 517.2396577031764, 525.3957948359389, 31732.20669483264, 33076.66923330766, 33121.33757324855, 34648.96053118404, 34692.47961280583, 32835.50746738801, 33061.834690826574, 33181.83409082957, 33199.83400083002, 33229.5015574766, 7275.163356214037, 7445.0, 7447.255274472536, 7450.478466507347, 7456.925430745678, 7714.382849372037, 7780.455368124233, 7787.610619469032, 7788.80527986802, 7795.532268063935, 7727.536347819121, 7770.533767973911, 7791.883121753178, 7818.12365032391, 7824.061112666488, 7742.109657389387, 7789.454738168331, 7789.727359542446, 7793.688252469894, 7799.805004874924, 7679.2704693054075, 7784.299413052796, 7788.3769298456555, 7799.805004874866, 7803.453758236926, 31347.84326078378, 31690.207744806336, 31736.682633173834, 31756.20609484758, 31806.363872722646, 3225.0, 3411.3347897160065, 3585.1933315004176, 3901.9804900975596, 4028.798560072014, 22000.669989950162, 22091.889540552194, 22109.226177083885, 22166.0, 22226.222082227043, 2752.1330780803983, 2764.7235276472393, 2943.8675259613156, 2962.9259268518244, 2963.9110826675233, 433461.0, 435824.0, 436966.0, 438745.0, 441315.0, 48734.0, 58246.70876645589, 58398.4160158393, 58560.70719646374, 58590.82818343609, 58940.0, 60967.69516152391, 61018.0, 61192.69403652953, 61361.693191533755, 15757.212139393214, 16023.599410014844, 16039.278232479566, 16076.517704468884, 16092.356305747639, 12441.315727634887, 12493.0, 12515.937420312841, 12517.374131293582, 12525.185862918881, 16081.437149699705, 16335.509934701979, 16682.332706691595, 16702.24839882208, 16797.83202167987, 5256.947430525645, 5317.41508434072, 6194.163787888578, 6338.714757835908, 6407.647579383085, 757.246539693009, 981.563204374061, 997.9002099789963, 1022.900382089257, 1037.3983089807894, 28408.289792754935, 29041.709582904325, 29578.704212957597, 29590.704092958797, 29749.405011899642, 982.543117450389, 1023.488255872064, 1025.958961641541, 1041.3075304922293, 1070.4059247117768, 15151.545453636409, 15201.543953681186, 15224.543263702106, 15498.0, 15606.580979948127, 582511.0, 586243.0, 586795.0, 588591.0, 588760.0, 50631.49368506341, 50686.986260274585, 50766.74616626893, 50827.49172508228, 50834.0, 1195.2947760820985, 1231.322772475135, 1288.4846061575258, 1298.6039258026392, 1346.3133801760976, 24183.879080604485, 28166.2958426041, 29116.12651620455, 29757.851210743807, 29853.402931941673, 48581.0, 49217.75391123021, 49252.76868078183, 49300.0, 49347.0, 450858.9656413707, 486114.0, 501704.0, 502720.0, 543404.0, 23739.032620922386, 23776.4055898597, 24158.51682966366, 24354.512909741352, 24728.505429891662, 35666.821665892545, 41687.583124169585, 42504.362434562885, 42551.787241064834, 43251.567484324754, 34976.125596860285, 34989.30021399507, 35153.1211719709, 35735.82132089427, 35992.28015439624, 28965.710342896302, 34906.12734681653, 35080.64919350876, 35403.760868369485, 35836.28327433489, 35246.64753352434, 35587.644123558435, 35780.28439431249, 36039.0, 36360.454593181654, 25853.482930341663, 31034.534481982337, 31602.0, 31702.682973169973, 31780.841095794374, 23877.761222387555, 24055.0, 24067.879660601586, 24116.642191387175, 24761.62857557174], "value": 17869.97312025297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.2343482620821, 362.56130082600055, 368.5706152332531, 371.95164628598286, 392.1216475095786, 12135.089868259884, 12353.320567368803, 12796.424160912758, 12928.030397720162, 15958.920205398957, 18635.534111647215, 18709.532261693465, 19590.0, 19771.505712357197, 19881.801181988176, 3524.8061356625376, 4452.3989261449615, 5257.080010998079, 5269.420363760002, 5324.1747529133045, 5204.375474943012, 5236.502532259429, 5239.449857764937, 5246.186841039645, 5337.7598008089535, 4960.3303554020285, 5220.92168617471, 5253.6322457428, 5253.7373131343475, 5266.3153790007245, 4316.115196384733, 5219.608529360295, 5234.214867769846, 5276.7889284428575, 5345.705986170759, 4558.931616025762, 4587.564181402761, 4611.907761844778, 4624.7687615619425, 4625.514320996281, 20940.685889711665, 21450.46373840651, 21484.140634374606, 21756.0, 21918.0, 1914.5022294203468, 2191.167356404572, 2423.818213633967, 3067.4631939410515, 3154.3375891062906, 9557.426554406758, 9921.90078099217, 12802.679933001657, 13855.376508057161, 14086.506972255922, 1640.8441198086164, 1658.6185177409143, 1722.7415887616833, 1735.1931351921417, 1798.199801088516, 109189.0, 116441.0, 116831.0, 120314.59370812535, 121468.0, 11135.498902549405, 11343.943280283545, 11392.715182120513, 11440.94279528597, 11625.476853541611, 13874.93062534681, 13995.790063149061, 14323.498677546237, 14335.498257561145, 14375.340561996065, 8226.30076443509, 8365.330773538102, 8439.831203375898, 8507.914920850835, 8549.487030778173, 8255.876161857577, 8268.627911743866, 8276.586170691442, 8436.24073833358, 8439.831203375898, 3946.2699400610977, 4220.388043733641, 4450.354698568754, 4475.328700694857, 4521.570450807168, 1838.9080545972647, 1853.3605905962422, 1906.4757191772096, 1918.9712154317697, 1940.4282531149813, 739.6338812287952, 828.9171082891662, 845.7674139611656, 864.6411739128191, 980.1962390839443, 20302.0, 21199.0, 21202.939853007287, 21244.681329780065, 21341.679874801892, 926.8748718922994, 931.469062634292, 936.2042264075482, 940.3229674634252, 976.4190306767462, 10413.531391087268, 10671.25301228922, 11091.611793587186, 11156.888431115747, 11308.660740177807, 531864.0, 596199.0, 601735.0, 602316.0, 603563.982180095, 78125.53121281456, 85968.0, 96590.0, 112539.0, 135517.0, 909.3997961345481, 989.5299732627088, 999.7950420163849, 1008.324422636835, 1008.4000019988096, 15434.073955562702, 17768.022758747877, 18408.895466272068, 18626.72059919075, 18710.0, 47875.0, 53451.0, 53830.0, 57419.0, 57458.71270643787, 72938.63530682313, 73598.0, 75458.0, 75582.24417755973, 77372.61313693396, 7504.587247701429, 7754.340881025176, 7969.0, 8021.478603890729, 8292.751217463485, 10784.568617255221, 12520.436580354088, 12556.560520382109, 12834.743305134032, 12934.482620695444, 10889.965453281926, 10915.235933484897, 11060.225784195029, 11252.381119038204, 11319.377434241196, 10471.795743489292, 10752.892471075189, 11080.113590912546, 11269.436528173395, 11624.709382265512, 11095.833562496731, 11301.378424186749, 11393.0, 11574.6527604172, 11588.420578970849, 8015.6392962318005, 8033.437659363788, 8097.446875991185, 8443.535605541754, 8475.194856488624, 8343.45767525109, 10189.796204076025, 11301.943490282496, 11541.480633371686, 11649.068074554185], "value": 9092.904269513025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.4354223623905, 1486.1825995702363, 1649.5793572638975, 1772.8581713462909, 1837.6049149432877, 7062.258462861396, 7632.160462349144, 8031.4377993540475, 8044.637991290391, 8059.274665280138, 7143.464240181994, 7367.852642947151, 7369.852602947938, 7668.156502784689, 7878.527288362688, 2011.2558353409258, 2057.77364489906, 2063.0819285417997, 2067.8138967492923, 2071.54426026274, 2019.7273368095339, 2030.4517780199337, 2033.6339458897392, 2058.9794102058936, 2110.831133509323, 1817.690992531273, 1883.2372888979917, 1891.527118220445, 2051.0975170924744, 2076.948076298097, 2003.9799602003939, 2081.313166655008, 2084.593504266669, 2091.874487530753, 2096.821770149539, 2080.916763329465, 2084.603925254197, 2101.9264325748527, 2102.6845973104155, 2119.7668256491775, 7807.726729564438, 7977.962864827593, 7983.720569780088, 7988.840223195503, 7995.2804247618, 4985.102681517325, 5150.459201783834, 5155.252488389163, 5156.587473002151, 5158.226266060084, 3147.213196700825, 3403.3873902697505, 3476.235228249781, 3480.738944579167, 3509.2279698466295, 938.2306508662899, 959.6209497248548, 1020.9438480883548, 1025.3642741500319, 1594.6013496625844, 10656.840147397796, 10878.401687907162, 10917.454127293682, 10931.0, 10938.945305273422, 4116.547179810218, 4328.0, 4374.147041326911, 4388.29787234041, 4393.934090988638, 8546.145385461405, 8644.265237454887, 8662.133786621413, 8662.393632445794, 8672.739817805475, 5053.065182941167, 5061.190209566452, 5061.721605311744, 5068.16375298079, 5071.137906555894, 4624.838130665411, 4666.719996800203, 4682.759068846758, 4743.976280118646, 4750.216214324598, 3536.80547569881, 3586.336527742324, 3593.5148754918273, 3619.4208926571623, 3638.7270954678506, 1112.821948488238, 1114.5541783286587, 1116.0792346314324, 1118.2060736876747, 1127.2841745491507, 658.8451713847242, 774.3147314626596, 871.7166920750782, 879.2394578689388, 903.8418276801533, 4583.977080114645, 4754.976225118852, 4979.929315197178, 5641.576881733887, 5671.546276297886, 868.7567481105301, 891.148952750122, 899.6986009686698, 904.1455824246156, 930.0885132570119, 3601.585817631006, 3618.4210526315665, 3758.605346438639, 3815.198808250243, 3822.292875817927, 9769.658061967797, 9822.0, 9941.254405919584, 10042.096211341015, 10115.241356898263, 9927.453990030617, 10123.898761012442, 10131.746706332253, 10133.64532241368, 10153.4923253837, 7257.092863392076, 7512.962435187789, 7531.585762783099, 7604.885926711104, 7741.690332386642, 5194.844154675366, 5287.704512394488, 5330.54690351309, 5391.460853914734, 5684.687342196219, 9365.438073715599, 9423.340366174301, 9440.575174117044, 9459.952700236454, 9473.47895865734, 8704.477731336141, 9226.630934762534, 9480.194183494204, 9647.855282170633, 9648.71053868385, 7148.070750802571, 7296.379807716404, 7301.160366557914, 7302.817429564091, 7303.488755787044, 7827.139014708491, 7840.294373506412, 7866.095399029185, 7918.802029949297, 7922.445428819928, 6799.898001529882, 7042.366187043191, 7076.22161562238, 7140.321669441395, 7167.8924816126755, 5578.30271216098, 6854.074699915447, 6928.965355173394, 7008.544444611084, 7154.642267886689, 6548.443382312556, 6567.9671601643595, 6722.932770672231, 6728.327167283428, 6732.798016059526, 4637.837675681335, 4670.766461676971, 4701.482836887872, 4865.270209468466, 4931.580815630711, 4221.176870510344, 4767.118083154627, 4906.9018619626695, 4931.827386041471, 5063.265826455217], "value": 4249.445463208517, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.6120024568184, 299.8740528977829, 306.32302611229187, 311.67741387663756, 314.9984250078749, 5214.028004037696, 5275.0768615492325, 5297.602679799016, 5299.708516031616, 5344.625876188668, 4492.887677808057, 4571.428571428572, 4976.800927962886, 5119.948800511994, 5130.410002849664, 3472.3923313420178, 3668.578113516953, 3750.343689854278, 3938.3304838177437, 3947.3092208863404, 3469.9653003469894, 3842.4236364545404, 3982.3230050891275, 3986.1429792594586, 4017.0, 3459.4605400596743, 3730.5896351401325, 3912.2762288976487, 3952.2490726761966, 3970.642642162205, 3325.2684409429885, 3919.804009799527, 3926.0773718176206, 3929.8014105697753, 3973.6225058619384, 3399.5920489541413, 3404.557407537029, 3415.624281329052, 3419.504171895086, 3420.4869269609508, 5052.4189718182515, 5076.746162691888, 5083.491650834924, 5083.949160508385, 5108.463611320795, 4248.766317852517, 4404.911901761979, 4432.246518091933, 4474.664400169968, 4487.416635837353, 4526.932096018562, 5411.161270003156, 5418.891622167574, 5419.729013549307, 5527.972360138214, 3721.665050145473, 3731.4589384539363, 3734.7572407793677, 3736.7010639148803, 3762.435634654796, 5335.706536140511, 5649.632773869726, 5708.058170401879, 5734.8780951048375, 5738.340090889601, 3776.9802153418423, 3780.432935059763, 3790.886273411802, 3794.8671796487542, 3796.6393192646656, 3566.6076731559506, 3594.986807387871, 3845.558070625173, 3869.5356557213313, 3880.320943834874, 4041.3399506167993, 4270.658347332206, 4300.903269666215, 4359.716618419792, 4471.6361509739845, 4856.902861942812, 5039.823606173766, 5407.972960135174, 5461.126219804892, 5480.479354461319, 1152.9654110376703, 1223.3699644682995, 1238.2137342787396, 1241.509603706531, 1243.639344590077, 788.0779487999055, 798.2336956521688, 814.8429230492715, 815.6778072661266, 817.1705718695529, 4197.929527970409, 4339.895150851834, 4411.382406463098, 4772.928406073912, 4825.9034819303415, 4432.49026361966, 4916.06594746997, 5039.185893078489, 5402.756875940592, 5503.257060296809, 3860.7876566789096, 4261.765602891871, 4848.097281688275, 4898.007944330004, 5034.395872495324, 2665.653465049531, 2839.6592408911065, 2866.154484427099, 2869.3543952610494, 2880.6111174991106, 5528.419515950848, 5535.58483113768, 5565.801508404239, 5578.553715702734, 5616.5787565931905, 4900.779464924087, 5027.899442011139, 5032.339328021744, 5059.645824792229, 5369.5167434931045, 4763.428388593391, 5258.474152584711, 5446.863828404322, 5578.843761397785, 5587.74855131512, 4958.950410495849, 5224.791008359623, 5296.0, 5349.3848207455085, 5374.0, 4868.3934301681065, 5269.631125821309, 5295.25866378715, 5326.227696983993, 5363.651362661414, 4615.861524154281, 5523.4200408956485, 5536.916946245729, 5547.916781248204, 5550.111982082847, 3081.245094951751, 3114.9688503115585, 3202.6957439043254, 3471.8579685383756, 3483.9303213936087, 5117.283580298836, 5118.564921981524, 5384.703841288767, 5714.399988001366, 5742.196092546963, 4836.975815120902, 5542.972285138549, 5543.861403464945, 5558.3315012091825, 5560.108743453301, 5141.2288156776785, 5545.889082218414, 5545.944540554704, 5551.694656793915, 5593.216949627137, 4791.928121078117, 5391.16436952273, 5432.809851655173, 5450.928647114071, 5456.61803673739, 4713.717176969393, 4924.0, 5224.7126408047925, 5255.400050965101, 5469.507744303032, 5173.534381905646, 5407.242985982044, 5410.431904650112, 5422.457754224546, 5476.002518161685], "value": 3916.532853216483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.4760334542402, 707.5895980331405, 714.6498215874224, 768.2010708862783, 771.6643260181818, 13083.345832708363, 13547.390367433465, 13885.722285554308, 14109.082909610868, 14134.64663383416, 12056.578019769287, 12609.4325755341, 12730.872691273107, 12743.808842867342, 12751.936240318808, 784.2784638132918, 817.4318848400364, 818.8321394114192, 819.7417813388794, 821.3716506872247, 646.615263917968, 667.7562689618279, 785.937125029999, 818.3330585572769, 818.9140140285274, 847.0555330806137, 858.8883445152121, 861.1603686405767, 862.2067697718084, 862.4437237981498, 846.2468403121227, 852.4373913217247, 854.1543871567166, 854.44461100285, 855.649183834631, 498.9716801203134, 514.0105297302678, 633.8637193003526, 635.3836778325017, 640.69887153038, 12089.395530223454, 12515.499380024788, 12537.686557836127, 12622.0, 12679.0, 10390.948045259802, 10545.84181237282, 10658.626948056859, 10773.138148948065, 10982.835257471144, 9400.811983760355, 9410.529473526365, 9500.334976551645, 9516.23870090391, 9848.704538863845, 3015.8642861071085, 3063.6170478690165, 3074.4927087030615, 3082.6917308269217, 3155.0377134973824, 87446.56276718639, 89214.55392723059, 89225.0, 89249.0, 89768.10231897663, 8170.264676179172, 8413.158684131538, 8438.704645337384, 8446.57767111642, 8465.492070475791, 17007.744883826752, 17067.402640907756, 17402.564935876704, 17509.0, 17535.03557304335, 7476.289752473506, 7519.511231769918, 7519.586422746692, 7625.199354067854, 7688.231176882267, 4117.608827161415, 4245.596668316505, 4247.936280955788, 4250.213710463574, 4270.42349282849, 2875.180573536532, 3228.7094161525574, 3289.3256882339065, 3343.6656334366367, 3344.9832750836576, 534.1747000883644, 557.6598275052215, 637.2957881540831, 642.1972534332085, 649.084790445479, 525.5296509623942, 530.3503208569472, 584.4081498553927, 633.6293268437923, 666.8332916770808, 8517.659293628309, 8640.0, 8797.912020879838, 8850.159234872677, 9124.680636177702, 512.190738632959, 542.1650657986735, 595.4700316718124, 636.3636363636364, 642.9132067170872, 4281.464816897887, 4390.824367025283, 4397.384366188736, 4440.111977604427, 4540.2054640438455, 76009.61995189989, 92978.53510732538, 115957.84042159471, 117734.41132794453, 118562.4071879635, 67497.3125671862, 69892.0, 101074.98925010803, 106549.0, 108006.45996769966, 89265.55367223122, 90371.0, 93845.53077234571, 93857.0, 95331.0466895336, 8478.83042339162, 8631.26634236097, 8671.653133874574, 8673.262772664395, 8674.609642565974, 58491.0, 58595.828083438944, 60197.699011504665, 60530.0, 61222.08166877411, 81308.0, 83062.7865238185, 86007.0, 86390.0, 88336.25814322049, 9208.0, 10899.182561308093, 10918.344899306067, 10966.670999870017, 11471.311721296748, 11168.66494005181, 11209.775804484028, 11864.466099025392, 12066.044880226073, 12295.9385203077, 11705.531778728755, 11824.881751182722, 11878.584249551224, 12022.819657704966, 12107.273563586214, 11684.449886303937, 11908.702282443008, 11948.46231919583, 12086.51653933868, 12227.816582751087, 11302.717432064264, 11798.233114847508, 11868.703282418008, 11955.760884782081, 12155.635330940086, 9392.154706076486, 10008.549615267477, 10013.349132306377, 10070.99290070987, 10182.643607473703, 9324.393914395814, 9813.11681948628, 9819.683031150946, 9832.508374581384, 9944.84463662496], "value": 6828.562649517685, "unit": "score"}], "name": "dromaeo_css", "value": 6857.902674825123, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 115.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 112.0, 150.0, 112.0, 121.0, 136.0, 135.0, 167.0, 115.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 183.0, 186.0, 184.0, 183.0, 185.0, 185.0, 183.0, 179.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 91.0, 84.0, 81.0, 82.0, 68.0, 83.0, 57.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 113.0, 99.0, 97.0, 75.0, 91.0, 69.0, 69.0, 93.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 88.0, 86.0, 87.0, 86.0, 89.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 101.0, 94.0, 97.0, 95.0, 97.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 87.0, 85.0, 84.0, 90.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 68.0, 76.0, 73.0, 69.0, 71.0, 71.0, 71.0, 73.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 104.0, 91.0, 91.0, 90.0, 88.0, 87.0, 78.0, 107.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 147.0, 138.0, 158.0, 154.0, 164.0, 152.0, 152.0, 201.0, 154.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 171.0, 223.0, 234.0, 176.0, 171.0, 172.0, 175.0, 173.0, 170.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 66.0, 68.0, 68.0, 67.0, 66.0, 68.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1482.6999999999998, "alertThreshold": 2.0}]} 04:00:01 INFO - Return code: 0 04:00:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:01 INFO - # TBPL SUCCESS # 04:00:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:00:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:00:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:00:01 INFO - 2016-11-18 04:00:01.154 screenresolution[1663:9814] starting screenresolution argv=screenresolution get 04:00:01 INFO - 2016-11-18 04:00:01.157 screenresolution[1663:9814] Display 0: 1600x1200x32@60 04:00:01 INFO - 2016-11-18 04:00:01.163 screenresolution[1664:9817] starting screenresolution argv=screenresolution list 04:00:01 INFO - Available Modes on Display 0 04:00:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:00:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:00:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:00:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:00:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:00:01 INFO - Intel Iris: 04:00:01 INFO - Chipset Model: Intel Iris 04:00:01 INFO - Type: GPU 04:00:01 INFO - Bus: Built-In 04:00:01 INFO - VRAM (Dynamic, Max): 1536 MB 04:00:01 INFO - Vendor: Intel (0x8086) 04:00:01 INFO - Device ID: 0x0a2e 04:00:01 INFO - Revision ID: 0x0009 04:00:01 INFO - Displays: 04:00:01 INFO - Display: 04:00:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:00:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:00:01 INFO - Display Serial Number: 1600x1200 60 04:00:01 INFO - Main Display: Yes 04:00:01 INFO - Mirror: Off 04:00:01 INFO - Online: Yes 04:00:01 INFO - Rotation: Supported 04:00:01 INFO - Return code: 0 04:00:01 INFO - Running post-action listener: _resource_record_post_action 04:00:01 INFO - [mozharness: 2016-11-18 12:00:01.400477Z] Finished run-tests step (success) 04:00:01 INFO - Running post-run listener: _resource_record_post_run 04:00:01 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37721088; Write bytes: 700304384; Read time: 245; Write time: 1934 04:00:01 INFO - TinderboxPrint: CPU usage
53.6% 04:00:01 INFO - TinderboxPrint: I/O read bytes / time
37,721,088 / 245 04:00:01 INFO - TinderboxPrint: I/O write bytes / time
700,304,384 / 1,934 04:00:01 INFO - TinderboxPrint: CPU idle
2,254.1 (46.4%) 04:00:01 INFO - TinderboxPrint: CPU system
973.2 (20.0%) 04:00:01 INFO - TinderboxPrint: CPU user
1,634.4 (33.6%) 04:00:01 INFO - TinderboxPrint: Swap in / out
436,473,856 / 0 04:00:01 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 383586816; Write bytes: 377969664; Read time: 29721; Write time: 782 04:00:01 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36774912; Write bytes: 298692608; Read time: 228; Write time: 1096 04:00:01 INFO - Running post-run listener: _upload_blobber_files 04:00:01 INFO - Blob upload gear active. 04:00:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:01 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 04:00:01 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:01 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:04 INFO - (blobuploader) - INFO - Done attempting. 04:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:05 INFO - (blobuploader) - INFO - Done attempting. 04:00:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:08 INFO - (blobuploader) - INFO - Done attempting. 04:00:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:08 INFO - Return code: 0 04:00:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d8a7657636c71652316a26e9fcaafc6144f3387bc871c34b1e7baa26e8e7913c313020743a60e5bbc84c9417f31ceee778b021832d9451229ac3f8b83f92455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce0eeeb4dcd211c6ecbee988ce57a3a455a18e6d2ae55925b3183326505d2b2db8f6ae9549d19fabaf93dae785a7f5b085dff963261e8b418811400c4c5dc2b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b45a3585df7cc50486fb7479380be3bc0e416650e0d07cada33b4201fe9783dce30c8783c15925163786b508c06f0864f0e20a226b1a42c3a7da43bf11357f57"} 04:00:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:08 INFO - Contents: 04:00:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d8a7657636c71652316a26e9fcaafc6144f3387bc871c34b1e7baa26e8e7913c313020743a60e5bbc84c9417f31ceee778b021832d9451229ac3f8b83f92455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce0eeeb4dcd211c6ecbee988ce57a3a455a18e6d2ae55925b3183326505d2b2db8f6ae9549d19fabaf93dae785a7f5b085dff963261e8b418811400c4c5dc2b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b45a3585df7cc50486fb7479380be3bc0e416650e0d07cada33b4201fe9783dce30c8783c15925163786b508c06f0864f0e20a226b1a42c3a7da43bf11357f57"} 04:00:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:08 INFO - Copying logs to upload dir... 04:00:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.778814 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-18 04:00:08.620655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 04:00:08.623858) ========= 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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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/Graphics/sha512/4d8a7657636c71652316a26e9fcaafc6144f3387bc871c34b1e7baa26e8e7913c313020743a60e5bbc84c9417f31ceee778b021832d9451229ac3f8b83f92455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce0eeeb4dcd211c6ecbee988ce57a3a455a18e6d2ae55925b3183326505d2b2db8f6ae9549d19fabaf93dae785a7f5b085dff963261e8b418811400c4c5dc2b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b45a3585df7cc50486fb7479380be3bc0e416650e0d07cada33b4201fe9783dce30c8783c15925163786b508c06f0864f0e20a226b1a42c3a7da43bf11357f57"} build_url:https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010717 build_url: 'https://queue.taskcluster.net/v1/task/BrYcj4i9TJezgu3mG4hf4g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d8a7657636c71652316a26e9fcaafc6144f3387bc871c34b1e7baa26e8e7913c313020743a60e5bbc84c9417f31ceee778b021832d9451229ac3f8b83f92455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce0eeeb4dcd211c6ecbee988ce57a3a455a18e6d2ae55925b3183326505d2b2db8f6ae9549d19fabaf93dae785a7f5b085dff963261e8b418811400c4c5dc2b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b45a3585df7cc50486fb7479380be3bc0e416650e0d07cada33b4201fe9783dce30c8783c15925163786b508c06f0864f0e20a226b1a42c3a7da43bf11357f57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 04:00:08.656120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:00:08.656494) ========= 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.KXzgdWLdh5/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.I0e7vYVtrY/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.005027 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:00:08.705684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 04:00:08.706007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 04:00:08.706385) ========= ========= Total master_lag: 0.17 =========