builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0132 starttime: 1475611019.64 results: success (0) buildid: 20161004115401 builduid: ea5f1e52cfa14611a38f0626657fcb60 revision: e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.636452) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.637138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.637596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.661868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.662172) ========= 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.yTqPvRM850/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.QqQFTBGZU4/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 12:56:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.30M=0.001s 2016-10-04 12:56:59 (8.30 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189876 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.875300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.875972) ========= 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.yTqPvRM850/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.QqQFTBGZU4/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.021276 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:56:59.924931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 12:56:59.925294) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yTqPvRM850/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.QqQFTBGZU4/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 12:56:59,996 truncating revision to first 12 chars 2016-10-04 12:56:59,996 Setting DEBUG logging. 2016-10-04 12:56:59,996 attempt 1/10 2016-10-04 12:56:59,996 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e0ef5898308b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 12:57:01,137 unpacking tar archive at: autoland-e0ef5898308b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.403992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 12:57:01.352430) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 12:57:01.352902) ========= script_repo_revision: e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 12:57:01.353572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 12:57:01.353940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 12:57:01.372447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 12:57:01.372778) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yTqPvRM850/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.QqQFTBGZU4/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:01 INFO - MultiFileLogger online at 20161004 12:57:01 in /builds/slave/test 12:57:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:57:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:57:01 INFO - {'append_to_log': False, 12:57:01 INFO - 'base_work_dir': '/builds/slave/test', 12:57:01 INFO - 'blob_upload_branch': 'Autoland', 12:57:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:57:01 INFO - 'branch': 'Autoland', 12:57:01 INFO - 'buildbot_json_path': 'buildprops.json', 12:57:01 INFO - 'config_files': ('talos/mac_config.py',), 12:57:01 INFO - 'default_actions': ('clobber', 12:57:01 INFO - 'read-buildbot-config', 12:57:01 INFO - 'download-and-extract', 12:57:01 INFO - 'populate-webroot', 12:57:01 INFO - 'create-virtualenv', 12:57:01 INFO - 'install', 12:57:01 INFO - 'run-tests'), 12:57:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:57:01 INFO - 'download_minidump_stackwalk': True, 12:57:01 INFO - 'download_symbols': 'ondemand', 12:57:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:57:01 INFO - 'tooltool.py': '/tools/tooltool.py', 12:57:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:57:01 INFO - '/tools/misc-python/virtualenv.py')}, 12:57:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:57:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:57:01 INFO - 'installer_path': 'installer.exe', 12:57:01 INFO - 'log_level': 'info', 12:57:01 INFO - 'log_name': 'talos', 12:57:01 INFO - 'log_to_console': True, 12:57:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:57:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:57:01 INFO - 'opt_config_files': (), 12:57:01 INFO - 'pip_index': False, 12:57:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:57:01 INFO - 'cmd': ('bash', 12:57:01 INFO - '-c', 12:57:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:57:01 INFO - 'enabled': True, 12:57:01 INFO - 'halt_on_failure': False, 12:57:01 INFO - 'name': 'check_screen_resolution'},), 12:57:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:57:01 INFO - 'cmd': ('bash', 12:57:01 INFO - '-c', 12:57:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:57:01 INFO - 'enabled': True, 12:57:01 INFO - 'halt_on_failure': False, 12:57:01 INFO - 'name': 'check_screen_resolution'},), 12:57:01 INFO - 'run_cmd_checks_enabled': True, 12:57:01 INFO - 'sps_profile': False, 12:57:01 INFO - 'sps_profile_interval': 0, 12:57:01 INFO - 'suite': 'dromaeojs', 12:57:01 INFO - 'system_bits': '32', 12:57:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:57:01 INFO - 'title': 't-yosemite-r7-0132', 12:57:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:57:01 INFO - 'use_talos_json': True, 12:57:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:57:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:57:01 INFO - 'work_dir': 'build'} 12:57:01 INFO - [mozharness: 2016-10-04 19:57:01.582517Z] Running clobber step. 12:57:01 INFO - Running pre-action listener: _resource_record_pre_action 12:57:01 INFO - Running main action method: clobber 12:57:01 INFO - rmtree: /builds/slave/test/build 12:57:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:57:02 INFO - Running post-action listener: _resource_record_post_action 12:57:02 INFO - [mozharness: 2016-10-04 19:57:02.620376Z] Finished clobber step (success) 12:57:02 INFO - [mozharness: 2016-10-04 19:57:02.620638Z] Running read-buildbot-config step. 12:57:02 INFO - Running pre-action listener: _resource_record_pre_action 12:57:02 INFO - Running main action method: read_buildbot_config 12:57:02 INFO - Using buildbot properties: 12:57:02 INFO - { 12:57:02 INFO - "project": "", 12:57:02 INFO - "product": "firefox", 12:57:02 INFO - "script_repo_revision": "production", 12:57:02 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 12:57:02 INFO - "repository": "", 12:57:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 12:57:02 INFO - "buildid": "20161004115401", 12:57:02 INFO - "pgo_build": "False", 12:57:02 INFO - "basedir": "/builds/slave/test", 12:57:02 INFO - "buildnumber": 220, 12:57:02 INFO - "slavename": "t-yosemite-r7-0132", 12:57:02 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 12:57:02 INFO - "platform": "yosemite_r7", 12:57:02 INFO - "scheduler": "tests-autoland-macosx64-talos", 12:57:02 INFO - "branch": "autoland", 12:57:02 INFO - "repo_path": "integration/autoland", 12:57:02 INFO - "revision": "e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7", 12:57:02 INFO - "stage_platform": "macosx64", 12:57:02 INFO - "builduid": "ea5f1e52cfa14611a38f0626657fcb60", 12:57:02 INFO - "slavebuilddir": "test" 12:57:02 INFO - } 12:57:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 12:57:02 INFO - Running post-action listener: _resource_record_post_action 12:57:02 INFO - [mozharness: 2016-10-04 19:57:02.626276Z] Finished read-buildbot-config step (success) 12:57:02 INFO - [mozharness: 2016-10-04 19:57:02.626479Z] Running download-and-extract step. 12:57:02 INFO - Running pre-action listener: _resource_record_pre_action 12:57:02 INFO - Running main action method: download_and_extract 12:57:02 INFO - mkdir: /builds/slave/test/build/tests 12:57:02 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')]} 12:57:02 INFO - trying https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 12:57:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 12:57:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 12:57:04 INFO - Downloaded 1057 bytes. 12:57:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 12:57:04 INFO - Using the following test package requirements: 12:57:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 12:57:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 12:57:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 12:57:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'jsshell-mac.zip'], 12:57:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 12:57:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 12:57:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 12:57:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 12:57:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 12:57:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 12:57:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:57:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 12:57:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:57:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 12:57:04 INFO - Http code: 200 12:57:04 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 12:57:04 INFO - x-amz-cf-id: p0v01Fg62QxN_zplmm-GxxfZlQA7QXoejqVhEjH4u-KHdDLRZ_fpwg== 12:57:04 INFO - x-amz-version-id: n5ZT_YDWs7GivApBAMfNid0WUbMf7u66 12:57:04 INFO - Expected file size: 16477094 12:57:04 INFO - Obtained file size: 16477094 12:57:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:57:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 12:57:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:57:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 12:57:12 INFO - Http code: 200 12:57:12 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 12:57:12 INFO - x-amz-cf-id: J-IpXs5c_KSM0LULV9xDnZI7r73s3z3tS0_XwMaOv_euG3X9g1aSfw== 12:57:12 INFO - x-amz-version-id: n5ZT_YDWs7GivApBAMfNid0WUbMf7u66 12:57:12 INFO - Expected file size: 16477094 12:57:12 INFO - Obtained file size: 16477094 12:57:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 12:57:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:57:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 12:57:19 INFO - Http code: 200 12:57:19 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 12:57:19 INFO - x-amz-cf-id: SWzuEEsBBGNHqRD0Ujn_EOBcj1BtRg2JYOip6LXjAFyt87-aCn_SXA== 12:57:19 INFO - x-amz-version-id: Qa6Crh3BN03oRTxgvA_xVYJ_D1_y7_eW 12:57:19 INFO - Expected file size: 14409006 12:57:19 INFO - Obtained file size: 14409006 12:57: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')]} 12:57:20 INFO - trying https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 12:57:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 12:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 12:57:22 INFO - Downloaded 111627246 bytes. 12:57:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 12:57:22 INFO - mkdir: /builds/slave/test/properties 12:57:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:57:22 INFO - Writing to file /builds/slave/test/properties/build_url 12:57:22 INFO - Contents: 12:57:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 12:57:23 INFO - Running post-action listener: _resource_record_post_action 12:57:23 INFO - Running post-action listener: set_extra_try_arguments 12:57:23 INFO - [mozharness: 2016-10-04 19:57:23.983134Z] Finished download-and-extract step (success) 12:57:23 INFO - [mozharness: 2016-10-04 19:57:23.983256Z] Running populate-webroot step. 12:57:23 INFO - Running pre-action listener: _resource_record_pre_action 12:57:23 INFO - Running main action method: populate_webroot 12:57:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:57:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:57:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:57:23 INFO - '--tppagecycles', 12:57:23 INFO - '7'], 12:57:23 INFO - 'tests': ['tsvgm']}}, 12:57:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:57:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:57:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:57:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:57:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:23 INFO - 'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:23 INFO - 'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['damp', 'tps']}, 12:57:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:23 INFO - 'tests': ['damp', 'tps']}, 12:57:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['dromaeo_dom']}, 12:57:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:57:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['basic_compositor_video']}, 12:57:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:57:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['a11yr', 12:57:23 INFO - 'ts_paint', 12:57:23 INFO - 'tpaint', 12:57:23 INFO - 'sessionrestore', 12:57:23 INFO - 'sessionrestore_no_auto_restore', 12:57:23 INFO - 'tabpaint']}, 12:57:23 INFO - 'other-e10s': {'tests': ['a11yr', 12:57:23 INFO - 'ts_paint', 12:57:23 INFO - 'tpaint', 12:57:23 INFO - 'sessionrestore', 12:57:23 INFO - 'sessionrestore_no_auto_restore', 12:57:23 INFO - 'tabpaint']}, 12:57:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:57:23 INFO - 'ts_paint', 12:57:23 INFO - 'tpaint', 12:57:23 INFO - 'sessionrestore', 12:57:23 INFO - 'sessionrestore_no_auto_restore', 12:57:23 INFO - 'tabpaint']}, 12:57:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:57:23 INFO - 'ts_paint', 12:57:23 INFO - 'tpaint', 12:57:23 INFO - 'sessionrestore', 12:57:23 INFO - 'sessionrestore_no_auto_restore', 12:57:23 INFO - 'tabpaint']}, 12:57:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['a11yr', 12:57:23 INFO - 'ts_paint', 12:57:23 INFO - 'tpaint', 12:57:23 INFO - 'sessionrestore', 12:57:23 INFO - 'sessionrestore_no_auto_restore', 12:57:23 INFO - 'tabpaint']}, 12:57:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['a11yr', 12:57:23 INFO - 'ts_paint', 12:57:23 INFO - 'tpaint', 12:57:23 INFO - 'sessionrestore', 12:57:23 INFO - 'sessionrestore_no_auto_restore', 12:57:23 INFO - 'tabpaint']}, 12:57:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:57:23 INFO - 'tests': ['tsvgx', 12:57:23 INFO - 'tsvgr_opacity', 12:57:23 INFO - 'tart', 12:57:23 INFO - 'tscrollx', 12:57:23 INFO - 'cart']}, 12:57:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:57:23 INFO - 'tsvgr_opacity', 12:57:23 INFO - 'tart', 12:57:23 INFO - 'tscrollx', 12:57:23 INFO - 'cart']}, 12:57:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:24 INFO - 'talos_options': ['--disable-e10s'], 12:57:24 INFO - 'tests': ['tp5o']}, 12:57:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:24 INFO - 'tests': ['tp5o']}, 12:57:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:24 INFO - 'talos_options': ['--disable-e10s', 12:57:24 INFO - '--xperf_path', 12:57:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:24 INFO - 'tests': ['tp5n']}, 12:57:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:24 INFO - 'talos_options': ['--xperf_path', 12:57:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:24 INFO - 'tests': ['tp5n']}}, 12:57:24 INFO - 'talos.zip': {'path': '', 12:57:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:57:24 INFO - Running post-action listener: _resource_record_post_action 12:57:24 INFO - [mozharness: 2016-10-04 19:57:24.001885Z] Finished populate-webroot step (success) 12:57:24 INFO - [mozharness: 2016-10-04 19:57:24.002024Z] Running create-virtualenv step. 12:57:24 INFO - Running pre-action listener: _resource_record_pre_action 12:57:24 INFO - Running main action method: create_virtualenv 12:57:24 INFO - Creating virtualenv /builds/slave/test/build/venv 12:57:24 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 12:57:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:57:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:57:24 INFO - Using real prefix '/tools/python27' 12:57:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:57:24 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:27 INFO - Installing pip.................done. 12:57:27 INFO - Return code: 0 12:57:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:57:27 INFO - Reading from file tmpfile_stdout 12:57:27 INFO - Output received: 12:57:27 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) 12:57:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:57:27 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')]} 12:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:27 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')]} 12:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:27 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:27 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 12:57:27 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 12:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:27 INFO - 'HOME': '/Users/cltbld', 12:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:27 INFO - 'LOGNAME': 'cltbld', 12:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:27 INFO - 'MOZ_NO_REMOTE': '1', 12:57:27 INFO - 'NO_EM_RESTART': '1', 12:57:27 INFO - 'PAGER': '/bin/cat', 12:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:27 INFO - 'PWD': '/builds/slave/test', 12:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:27 INFO - 'SHELL': '/bin/bash', 12:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:27 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:27 INFO - 'USER': 'cltbld', 12:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:27 INFO - 'XPC_FLAGS': '0x0', 12:57:27 INFO - 'XPC_SERVICE_NAME': '0', 12:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:28 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 12:57:28 INFO - Cleaning up... 12:57:28 INFO - Return code: 0 12:57:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', '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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:57: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 psutil>=3.1.1 12:57:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:28 INFO - 'HOME': '/Users/cltbld', 12:57:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:28 INFO - 'LOGNAME': 'cltbld', 12:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:28 INFO - 'MOZ_NO_REMOTE': '1', 12:57:28 INFO - 'NO_EM_RESTART': '1', 12:57:28 INFO - 'PAGER': '/bin/cat', 12:57:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:28 INFO - 'PWD': '/builds/slave/test', 12:57:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:28 INFO - 'SHELL': '/bin/bash', 12:57:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:28 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:28 INFO - 'USER': 'cltbld', 12:57:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:28 INFO - 'XPC_FLAGS': '0x0', 12:57:28 INFO - 'XPC_SERVICE_NAME': '0', 12:57:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:28 INFO - Downloading/unpacking psutil>=3.1.1 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:31 INFO - Installing collected packages: psutil 12:57:31 INFO - Running setup.py install for psutil 12:57:31 INFO - building 'psutil._psutil_osx' extension 12:57:31 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 INFO - building 'psutil._psutil_posix' extension 12:57:32 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 12:57:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:57:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:57:32 INFO - ^ 12:57:32 INFO - 1 warning generated. 12:57:32 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 12:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:32 INFO - Successfully installed psutil 12:57:32 INFO - Cleaning up... 12:57:32 INFO - Return code: 0 12:57:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:32 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:32 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 12:57:32 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 12:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:32 INFO - 'HOME': '/Users/cltbld', 12:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:32 INFO - 'LOGNAME': 'cltbld', 12:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:32 INFO - 'MOZ_NO_REMOTE': '1', 12:57:32 INFO - 'NO_EM_RESTART': '1', 12:57:32 INFO - 'PAGER': '/bin/cat', 12:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:32 INFO - 'PWD': '/builds/slave/test', 12:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:32 INFO - 'SHELL': '/bin/bash', 12:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:32 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:32 INFO - 'USER': 'cltbld', 12:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:32 INFO - 'XPC_FLAGS': '0x0', 12:57:32 INFO - 'XPC_SERVICE_NAME': '0', 12:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:57:35 INFO - Installing collected packages: mozsystemmonitor 12:57:35 INFO - Running setup.py install for mozsystemmonitor 12:57:35 INFO - Successfully installed mozsystemmonitor 12:57:35 INFO - Cleaning up... 12:57:35 INFO - Return code: 0 12:57:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:35 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:35 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 12:57:35 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 12:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:35 INFO - 'HOME': '/Users/cltbld', 12:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:35 INFO - 'LOGNAME': 'cltbld', 12:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:35 INFO - 'MOZ_NO_REMOTE': '1', 12:57:35 INFO - 'NO_EM_RESTART': '1', 12:57:35 INFO - 'PAGER': '/bin/cat', 12:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:35 INFO - 'PWD': '/builds/slave/test', 12:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:35 INFO - 'SHELL': '/bin/bash', 12:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:35 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:35 INFO - 'USER': 'cltbld', 12:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:35 INFO - 'XPC_FLAGS': '0x0', 12:57:35 INFO - 'XPC_SERVICE_NAME': '0', 12:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:36 INFO - Downloading/unpacking jsonschema==2.5.1 12:57:36 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 12:57:36 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 12:57:36 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 12:57:36 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 12:57:36 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 12:57:36 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 12:57:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:38 INFO - warning: no files found matching '*.txt' 12:57:38 INFO - no previously-included directories found matching 'build' 12:57:38 INFO - no previously-included directories found matching 'dist' 12:57:38 INFO - no previously-included directories found matching '.git*' 12:57:38 INFO - Installing collected packages: jsonschema, functools32 12:57:39 INFO - Running setup.py install for functools32 12:57:39 INFO - warning: no files found matching '*.txt' 12:57:39 INFO - no previously-included directories found matching 'build' 12:57:39 INFO - no previously-included directories found matching 'dist' 12:57:39 INFO - no previously-included directories found matching '.git*' 12:57:39 INFO - Successfully installed jsonschema functools32 12:57:39 INFO - Cleaning up... 12:57:39 INFO - Return code: 0 12:57:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:39 INFO - 'HOME': '/Users/cltbld', 12:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:39 INFO - 'LOGNAME': 'cltbld', 12:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:39 INFO - 'MOZ_NO_REMOTE': '1', 12:57:39 INFO - 'NO_EM_RESTART': '1', 12:57:39 INFO - 'PAGER': '/bin/cat', 12:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:39 INFO - 'PWD': '/builds/slave/test', 12:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:39 INFO - 'SHELL': '/bin/bash', 12:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:39 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:39 INFO - 'USER': 'cltbld', 12:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:39 INFO - 'XPC_FLAGS': '0x0', 12:57:39 INFO - 'XPC_SERVICE_NAME': '0', 12:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:57:39 INFO - Cleaning up... 12:57:39 INFO - Return code: 0 12:57:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:39 INFO - 'HOME': '/Users/cltbld', 12:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:39 INFO - 'LOGNAME': 'cltbld', 12:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:39 INFO - 'MOZ_NO_REMOTE': '1', 12:57:39 INFO - 'NO_EM_RESTART': '1', 12:57:39 INFO - 'PAGER': '/bin/cat', 12:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:39 INFO - 'PWD': '/builds/slave/test', 12:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:39 INFO - 'SHELL': '/bin/bash', 12:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:39 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:39 INFO - 'USER': 'cltbld', 12:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:39 INFO - 'XPC_FLAGS': '0x0', 12:57:39 INFO - 'XPC_SERVICE_NAME': '0', 12:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:42 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:57:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 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 12:57:42 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 12:57:43 INFO - Downloading docopt-0.6.1.tar.gz 12:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:43 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:43 INFO - Running setup.py install for blobuploader 12:57:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:57:43 INFO - Running setup.py install for requests 12:57:44 INFO - Running setup.py install for docopt 12:57:44 INFO - Successfully installed blobuploader requests docopt 12:57:44 INFO - Cleaning up... 12:57:44 INFO - Return code: 0 12:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:44 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:44 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 12:57:44 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 12:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:44 INFO - 'HOME': '/Users/cltbld', 12:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:44 INFO - 'LOGNAME': 'cltbld', 12:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:44 INFO - 'MOZ_NO_REMOTE': '1', 12:57:44 INFO - 'NO_EM_RESTART': '1', 12:57:44 INFO - 'PAGER': '/bin/cat', 12:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:44 INFO - 'PWD': '/builds/slave/test', 12:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:44 INFO - 'SHELL': '/bin/bash', 12:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:44 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:44 INFO - 'USER': 'cltbld', 12:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:44 INFO - 'XPC_FLAGS': '0x0', 12:57:44 INFO - 'XPC_SERVICE_NAME': '0', 12:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ZB2Fwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-p2iXrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-yrvzvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ybYE1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-nZHB8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-p1uSpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-eLto3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-F50SGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-glWma_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-6ArNAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-XVtqFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ClWXud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-U97G7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:46 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-NW_lpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:46 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-D8gSl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:46 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-CbCKGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:46 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-QabiME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:46 INFO - Running setup.py install for manifestparser 12:57:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:46 INFO - Running setup.py install for mozcrash 12:57:46 INFO - Running setup.py install for mozdebug 12:57:46 INFO - Running setup.py install for mozdevice 12:57:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Running setup.py install for mozfile 12:57:47 INFO - Running setup.py install for mozhttpd 12:57:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Running setup.py install for mozinfo 12:57:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Running setup.py install for mozInstall 12:57:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Running setup.py install for mozleak 12:57:47 INFO - Running setup.py install for mozlog 12:57:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:47 INFO - Running setup.py install for moznetwork 12:57:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:48 INFO - Running setup.py install for mozprocess 12:57:48 INFO - Running setup.py install for mozprofile 12:57:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:48 INFO - Running setup.py install for mozrunner 12:57:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:48 INFO - Running setup.py install for mozscreenshot 12:57:48 INFO - Running setup.py install for moztest 12:57:48 INFO - Running setup.py install for mozversion 12:57:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:48 INFO - Cleaning up... 12:57:49 INFO - Return code: 0 12:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:49 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')]} 12:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:49 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')]} 12:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:49 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:49 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 12:57:49 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 12:57:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:49 INFO - 'HOME': '/Users/cltbld', 12:57:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:49 INFO - 'LOGNAME': 'cltbld', 12:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:49 INFO - 'MOZ_NO_REMOTE': '1', 12:57:49 INFO - 'NO_EM_RESTART': '1', 12:57:49 INFO - 'PAGER': '/bin/cat', 12:57:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:49 INFO - 'PWD': '/builds/slave/test', 12:57:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:49 INFO - 'SHELL': '/bin/bash', 12:57:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:49 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:49 INFO - 'USER': 'cltbld', 12:57:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:49 INFO - 'XPC_FLAGS': '0x0', 12:57:49 INFO - 'XPC_SERVICE_NAME': '0', 12:57:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-cUIzeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:49 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)) 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-4jBFwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-9yYUuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:49 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)) 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-OTWxZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:49 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)) 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zwv_3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:49 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)) 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-XHuDrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:49 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)) 12:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TO2lll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-bG25xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-a0soJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-IeZkh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zGjPc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Izh_bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-C2Yrm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-LzaPPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-j2vEqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:50 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)) 12:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ednefG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:51 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)) 12:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:51 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-tn0pUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:51 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)) 12:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:51 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)) 12:57:51 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)) 12:57:51 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)) 12:57:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:53 INFO - Downloading blessings-1.6.tar.gz 12:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:53 INFO - Installing collected packages: blessings 12:57:53 INFO - Running setup.py install for blessings 12:57:53 INFO - Successfully installed blessings 12:57:53 INFO - Cleaning up... 12:57:53 INFO - Return code: 0 12:57:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:54 INFO - Reading from file tmpfile_stdout 12:57:54 INFO - Current package versions: 12:57:54 INFO - blessings == 1.6 12:57:54 INFO - blobuploader == 1.2.4 12:57:54 INFO - docopt == 0.6.1 12:57:54 INFO - functools32 == 3.2.3-2 12:57:54 INFO - jsonschema == 2.5.1 12:57:54 INFO - manifestparser == 1.1 12:57:54 INFO - mozInstall == 1.12 12:57:54 INFO - mozcrash == 0.17 12:57:54 INFO - mozdebug == 0.1 12:57:54 INFO - mozdevice == 0.48 12:57:54 INFO - mozfile == 1.2 12:57:54 INFO - mozhttpd == 0.7 12:57:54 INFO - mozinfo == 0.9 12:57:54 INFO - mozleak == 0.1 12:57:54 INFO - mozlog == 3.4 12:57:54 INFO - moznetwork == 0.27 12:57:54 INFO - mozprocess == 0.23 12:57:54 INFO - mozprofile == 0.28 12:57:54 INFO - mozrunner == 6.12 12:57:54 INFO - mozscreenshot == 0.1 12:57:54 INFO - mozsystemmonitor == 0.3 12:57:54 INFO - moztest == 0.7 12:57:54 INFO - mozversion == 1.4 12:57:54 INFO - psutil == 3.1.1 12:57:54 INFO - requests == 1.2.3 12:57:54 INFO - wsgiref == 0.1.2 12:57:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:54 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')]} 12:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:54 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')]} 12:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:54 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:54 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 12:57:54 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 12:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:54 INFO - 'HOME': '/Users/cltbld', 12:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:54 INFO - 'LOGNAME': 'cltbld', 12:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:54 INFO - 'MOZ_NO_REMOTE': '1', 12:57:54 INFO - 'NO_EM_RESTART': '1', 12:57:54 INFO - 'PAGER': '/bin/cat', 12:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:54 INFO - 'PWD': '/builds/slave/test', 12:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:54 INFO - 'SHELL': '/bin/bash', 12:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:54 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:54 INFO - 'USER': 'cltbld', 12:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:54 INFO - 'XPC_FLAGS': '0x0', 12:57:54 INFO - 'XPC_SERVICE_NAME': '0', 12:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 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)) 12:57:54 INFO - Cleaning up... 12:57:54 INFO - Return code: 0 12:57:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57:54 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')]} 12:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:54 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')]} 12:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:54 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 0x1070e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107058570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9fbd832f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, '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.yTqPvRM850/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.QqQFTBGZU4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:57:54 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 12:57:54 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 12:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:54 INFO - 'HOME': '/Users/cltbld', 12:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:54 INFO - 'LOGNAME': 'cltbld', 12:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:54 INFO - 'MOZ_NO_REMOTE': '1', 12:57:54 INFO - 'NO_EM_RESTART': '1', 12:57:54 INFO - 'PAGER': '/bin/cat', 12:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:54 INFO - 'PWD': '/builds/slave/test', 12:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:54 INFO - 'SHELL': '/bin/bash', 12:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:57:54 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:54 INFO - 'USER': 'cltbld', 12:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:54 INFO - 'XPC_FLAGS': '0x0', 12:57:54 INFO - 'XPC_SERVICE_NAME': '0', 12:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:57:54 INFO - Cleaning up... 12:57:54 INFO - Return code: 0 12:57:54 INFO - Running post-action listener: _resource_record_post_action 12:57:54 INFO - Running post-action listener: _start_resource_monitoring 12:57:54 INFO - Starting resource monitoring. 12:57:54 INFO - [mozharness: 2016-10-04 19:57:54.737790Z] Finished create-virtualenv step (success) 12:57:54 INFO - [mozharness: 2016-10-04 19:57:54.738894Z] Running install step. 12:57:54 INFO - Running pre-action listener: _resource_record_pre_action 12:57:54 INFO - Running main action method: install 12:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:54 INFO - Reading from file tmpfile_stdout 12:57:54 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:55 INFO - Reading from file tmpfile_stdout 12:57:55 INFO - Output received: 12:57:55 INFO - Usage: mozinstall [options] installer 12:57:55 INFO - Options: 12:57:55 INFO - -h, --help show this help message and exit 12:57:55 INFO - -d DEST, --destination=DEST 12:57:55 INFO - Directory to install application into. [default: 12:57:55 INFO - "/builds/slave/test"] 12:57:55 INFO - --app=APP Application being installed. [default: firefox] 12:57:55 INFO - mkdir: /builds/slave/test/build/application 12:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:58:29 INFO - Reading from file tmpfile_stdout 12:58:29 INFO - Output received: 12:58:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:58:29 INFO - Running post-action listener: _resource_record_post_action 12:58:29 INFO - [mozharness: 2016-10-04 19:58:29.897732Z] Finished install step (success) 12:58:29 INFO - [mozharness: 2016-10-04 19:58:29.897859Z] Running run-tests step. 12:58:29 INFO - Running pre-action listener: _resource_record_pre_action 12:58:29 INFO - Running main action method: run_tests 12:58:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:58:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:58:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:58:29 INFO - 2016-10-04 12:58:29.912 screenresolution[1933:10577] starting screenresolution argv=screenresolution get 12:58:29 INFO - 2016-10-04 12:58:29.915 screenresolution[1933:10577] Display 0: 1600x1200x32@60 12:58:29 INFO - 2016-10-04 12:58:29.920 screenresolution[1934:10579] starting screenresolution argv=screenresolution list 12:58:29 INFO - Available Modes on Display 0 12:58:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:58:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:58:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:58:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:58:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:58:30 INFO - Intel Iris: 12:58:30 INFO - Chipset Model: Intel Iris 12:58:30 INFO - Type: GPU 12:58:30 INFO - Bus: Built-In 12:58:30 INFO - VRAM (Dynamic, Max): 1536 MB 12:58:30 INFO - Vendor: Intel (0x8086) 12:58:30 INFO - Device ID: 0x0a2e 12:58:30 INFO - Revision ID: 0x0009 12:58:30 INFO - Displays: 12:58:30 INFO - Display: 12:58:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:58:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:58:30 INFO - Display Serial Number: 1600x1200 60 12:58:30 INFO - Main Display: Yes 12:58:30 INFO - Mirror: Off 12:58:30 INFO - Online: Yes 12:58:30 INFO - Rotation: Supported 12:58:30 INFO - Return code: 0 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:58:30 INFO - Python 2.7.3 12:58:30 INFO - Return code: 0 12:58:30 INFO - grabbing minidump binary from tooltool 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 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 0x106ef6d30>, '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 0x106d1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:58:30 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 12:58:30 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 12:58:30 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 12:58:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:58:30 INFO - Return code: 0 12:58:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:58:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:58:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:58:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:58:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --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 12:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTqPvRM850/Render', 12:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:30 INFO - 'HOME': '/Users/cltbld', 12:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:30 INFO - 'LOGNAME': 'cltbld', 12:58:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:58:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:30 INFO - 'MOZ_NO_REMOTE': '1', 12:58:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:58:30 INFO - 'NO_EM_RESTART': '1', 12:58:30 INFO - 'PAGER': '/bin/cat', 12:58:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:30 INFO - 'PWD': '/builds/slave/test', 12:58:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:30 INFO - 'SHELL': '/bin/bash', 12:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QqQFTBGZU4/Listeners', 12:58:30 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:30 INFO - 'USER': 'cltbld', 12:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:30 INFO - 'XPC_FLAGS': '0x0', 12:58:30 INFO - 'XPC_SERVICE_NAME': '0', 12:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 12:58:30 INFO - mozversion application_buildid: 20161004115401 12:58:30 INFO - mozversion application_changeset: e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7 12:58:30 INFO - mozversion application_display_name: Nightly 12:58:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:58:30 INFO - mozversion application_name: Firefox 12:58:30 INFO - mozversion application_remotingname: firefox 12:58:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:58:30 INFO - mozversion application_vendor: Mozilla 12:58:30 INFO - mozversion application_version: 52.0a1 12:58:30 INFO - mozversion platform_buildid: 20161004115401 12:58:30 INFO - mozversion platform_changeset: e0ef5898308b07ceb17f5bbf2192a5d496c7b6e7 12:58:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:58:30 INFO - mozversion platform_version: 52.0a1 12:58:30 INFO - using testdate: 1475611110 12:58:30 INFO - actual date: 1475611110 12:58:30 INFO - starting webserver on 'localhost:49772' 12:58:30 INFO - SUITE-START | Running 2 tests 12:58:30 INFO - TEST-START | dromaeo_css 12:58:30 INFO - operating with platform_type : mac_ 12:58:30 INFO - Initialising browser for dromaeo_css test... 12:58:30 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpd4rftn/profile http://localhost:49772/getInfo.html) 12:58:32 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 12:58:32 INFO - PROCESS | 1944 | colorDepth:24 12:58:32 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 12:58:32 INFO - PROCESS | 1944 | __metrics 12:58:33 INFO - PROCESS | 1944 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:58:33 INFO - PROCESS | 1944 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:34 INFO - TEST-INFO | 1944: exit 0 12:58:34 INFO - Browser initialized. 12:58:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:58:34 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpd4rftn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:46 INFO - PROCESS | 1946 | RSS: Main: 235687936 12:58:46 INFO - PROCESS | 1946 | 12:59:37 INFO - PROCESS | 1946 | 1475611177893 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] 13:01:50 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49772/tests/dromaeo/cssquery-ext.html) 13:01:51 INFO - PROCESS | 1946 | RSS: Main: 397967360 13:01:51 INFO - PROCESS | 1946 | 13:04:55 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49772/tests/dromaeo/cssquery-ext.html (next: http://localhost:49772/tests/dromaeo/cssquery-jquery.html) 13:04:55 INFO - PROCESS | 1946 | RSS: Main: 372527104 13:04:55 INFO - PROCESS | 1946 | 13:07:57 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49772/tests/dromaeo/cssquery-mootools.html) 13:07:58 INFO - PROCESS | 1946 | RSS: Main: 361521152 13:07:58 INFO - PROCESS | 1946 | 13:11:00 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49772/tests/dromaeo/cssquery-prototype.html) 13:11:01 INFO - PROCESS | 1946 | RSS: Main: 335405056 13:11:01 INFO - PROCESS | 1946 | 13:14:05 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49772/tests/dromaeo/cssquery-yui.html) 13:14:05 INFO - PROCESS | 1946 | RSS: Main: 331415552 13:14:05 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49772/tests/dromaeo/cssquery-yui.html (next: http://localhost:49772/tests/dromaeo/cssquery-dojo.html) 13:17:09 INFO - PROCESS | 1946 | RSS: Main: 391897088 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | __start_tp_report 13:17:09 INFO - PROCESS | 1946 | _x_x_mozilla_page_load 13:17:09 INFO - PROCESS | 1946 | _x_x_mozilla_page_load_details 13:17:09 INFO - PROCESS | 1946 | |i|pagename|runs| 13:17:09 INFO - PROCESS | 1946 | |0;dojo.html;3304.3060957198995;3307.3054658521714;3323.335332933414;3341.5655964724583;3365.6802603752635;5503.7798488060525;5591.664500129995;5617.325920889494;5657.123145912385;5716.456936591027;5589.469000444951;5617.466340697627;5670.0927851543765;5702.201691763156;5733.713314334277;4105.856295029675;5071.137906555894;5079.390473143228;5132.076226279269;5143.53708166265;4293.957060429387;4730.668853180278;5160.406553246387;5247.947520524784;5255.343082114736;5071.061853557104;5115.18157094863;5207.114790485626;5225.790968361261;5243.6067294952645;5130.769115389817;5140.74296285188;5156.020356132323;5159;5160.587153027749;5014.674046186986;5083.974580127113;5090.261912022773;5092.949070509285;5100.846974590731;5590.608657393984;5623.100303951389;5632.915506267409;5652.293463317085;5655.7454914528535;6166.07508873668;6185.134081228632;6186.9381306186815;6190.690465476753;6201.410865967771;6134.478569321613;6236.781712640081;6256.217972753406;6262.373762623747;6279.780207692755;5540.556755459554;5644.717764111778;5661.377248502661;5704.401037891044;5709.657420554739;6334.049892516159;6341.0805433212845;6355.428011478989;6372.617642941438;6388.2653494847755;6080.695965201722;6090.269167699905;6092.116643086816;6095.817125486243;6097.878042439126;6104.236970378703;6119.533019689859;6119.653521814353;6249.78125765596;6251.062340648939;6019.127226552213;6121.204243448323;6130.908036379458;6151.507879369639;6158.445739883342;6149.538784591174;6163.876722465526;6164.167837341902;6175.722092505848;6189.288231853305;4807.78364973577;4822.590079843182;4862.878428039327;4874.049560335771;4906.1659517881335;4339;4341.6526677865695;4379.49635791888;4385.561443855589;4387.517373088957;5705.030144875381;5708.628939118944;5711.600187986801;5713.885722285531;5761.193432919311;6239.157713708682;6261.78083767066;6261.780837670751;6263.467605253604;6266.686665666698;5587.469190426903;5635.915461268084;5638;5677.971610141923;5693.772249109989;5250.947490525045;5278.577713782888;5284.973575132177;5316.9202461963105;5326.121190003683;6306.49548036156;6312.589681670676;6320.304766475776;6323.430891219812;6346.746130154742;6099.007149910021;6117.938820611915;6130.846728831815;6254.186955695731;6272.5922815016875;6261;6294.433500984934;6345.746170153142;6347.238331400262;6348.047792831112;6120.571559990758;6134.969325153345;6137.263528376623;6150.50795936333;6157.84605384869;6062.393760624079;6219;6235;6241.500679945684;6249.781257656142;5934.9109763354445;5976.043832986875;5981.700914954322;6023.698815059141;6098;5879.588428809942;5884.823455296348;6052.757889684363;6056.939430605637;6074.878502429839;5755.453231942959;5773.595848290579;5896.823095307148;5902.38025007368;5908.05471124618;4943.382077240345;5882.1470886722045;5943;6018.247719035121;6039.667818270037;5830.737616807169;5838.591298609056;5839.416058394127;5872.706364681834;5895.557833162444 13:17:09 INFO - PROCESS | 1946 | |1;ext.html;504.4098404866306;520.5081198267637;526.9525742683157;529.3066083430706;551.7268951868825;29627;39074.60925390745;40133.598664013385;40190.39714404279;42332.36501452473;40651.390229146586;40932.5673601424;41014.38478422826;41026.38460423089;41032.38451423224;9576.425414475154;9763.658271960483;9771.413715177077;9772.413655180677;9773.853392199087;8666.176713212235;8880.555972201397;10833.187510936672;11246.606368777095;11713.765724685501;11681.182317237797;11782.116341274395;11860.406979651027;11966.82049769254;12000.939995300012;8687.913120868838;11911.523539058428;11986.220895641756;12014.098942579341;12021.218620789621;7380.261973802631;11382.430878456044;11651.359175245358;11684.357360345177;11843.407829608572;38930.80534597337;39220;39247.60752392468;39342.803285983675;39369.40945885814;3275.557799697034;3288.967110328914;3351.547541081947;3928.292907276689;4010.7393019453643;26178.9528418863;28559.714402855912;29598.70401295981;30080.548791768142;31277;2686.502996945552;3151.322465669892;3254.869805207789;3343.164208947763;3348.9497657535157;426076;431368;431581.8420907907;431960;432971;58743.706281469174;59089.11366329509;59140.11289830656;59160.7041964796;59227;61800.38199618036;62086.068708969404;62131;62136;62205.37794622086;15876.364945402285;16105;16110.194490275439;16121.67756644884;16136.919315403347;11212.49543770516;11530.192886497865;12386.876131238752;12455.875441245653;12503.374831258401;15866.889317747648;17934.820651793314;17985.11156328593;18352.541186470444;18424.539386515175;7474.626268686544;7529.832875904243;7602.201768814195;7671.34793542544;7716.228377162239;720.5208536323287;923.4874644572327;963.2631037256505;970.5001924009141;1080.5353697909975;26625.20124396271;28128.29679257994;28271.858640706665;28545.85727071393;28907.277318066797;1025.779457416659;1053.7576357437679;1059.7403636109202;1063.4310643805682;1109.1016276815806;12324.876751232552;14776.113433194043;14855.628609284855;15151.393944242107;15207.847921520864;659473;664939;665464;667398;671957;53959.46040539623;54400.727996360554;54423.72788136034;54516.18225726617;54560.72719636376;1334.766415877237;1380.2615600653603;1400.3348409505404;1402.4320150339129;1404.1434724817852;28258.434831302846;28366.716332836408;28614.57078143788;28648;28966.565501517074;46082.76958615185;46413.76793116013;46414.535854642374;46538.53461465342;46654;572336;573996.130019364;574958;575910;576191;22175.44561385978;24319;24643.87678061598;24714.752852471243;24775;42488;42627;42921.570784293006;44505;44658.106837863714;36443.817780910926;36733;37114.9144254283;37545;37734.81132594319;31528.684713153492;33198.66801332052;36694.266114677026;37744;37965.62034379621;35795.82102089473;36074.819625901706;36702.265954681294;37201.06997325089;37285.88142355734;31917.8404107978;32238.032859014267;32652.510212347308;32808.50787238146;33007.66992330046;20790.896045519676;24008.51982960296;24663.876680616482;24854;25015 13:17:09 INFO - PROCESS | 1946 | |2;jquery.html;347.30365616938036;364.266004001936;364.9507316512271;375.6919326152556;395.40688966550175;15043.323050462728;15406.61483462914;16169.676606467863;20319.593608127827;20701;19470;19912.402627921187;20535.38393848183;20620.278290259845;20661.793382066175;5571.774209673866;5647.463490968352;5713.342965558952;5784.103463963082;6105.847353816168;5685.545156387499;6056.818295451144;6131.172291740602;6134.141220229149;6140.53945954053;5713.428657134295;5972.104184372357;5974.193483879664;5987.311459182206;6099.81700548982;5718.799842005551;5754.942450575482;5801.187833703285;5802.65184088956;5812.680302583356;4940.7035577865445;5061.924071138936;5078.085944529983;5178.4562620924635;5257.842264732026;25342;25959.74040259611;26157.738422615912;26355.56788240186;26383;2440.9267721968367;2446.498467814094;2542.1992072497287;2542.9745702542923;2925.3417980954328;6903.5512691675385;6905.343992320772;6916.965415172942;6931.0643063186835;12543.184692994926;1787.6960916644202;1845;1857.6284743051444;1864;1902;110281;113661;114173;114348;115494;8595.785105372415;10063;10141.746456338504;10637.627683031056;10675.412852293042;11521.596744114084;12877.77661122192;12881;12886;12911.160774549624;6281.780137695158;7932.524048556989;7983.321417679446;8139.430239883151;8162.265396114378;8379.120192379834;8411.327093832479;8425.199606037539;8542;8583.356248281403;3787.3750831112557;3807.638274363931;3840.7695538267794;3842.0971071798103;3922.666573341241;1846.7100795014355;1876.634056358997;1880.6896862017888;1889.0271510172272;1891.3191251149576;868.847951608466;885.5129678676702;909.2271569166156;972.363102168081;984.0454758883872;20392.694109588072;21866;21987.450313741963;22168.002439890242;22388.440288992904;772.8492943876003;931.9440833550009;956.5217391304348;956.5647630328184;1029.3566520924421;7811.531308121531;10634.627788027381;11404.885951140548;11422.14333924959;11467.942660286646;558514;565846;565933;576063;579274;91190.54404728067;104681.07227295748;120598;127793;130114.69885301025;920.6593560382702;961.3318743473359;984.3109823123842;1030.7886883188928;1033.509083185481;19399.0300484978;19905.502362440475;20158.79841201569;20175.293864714666;20237;41366.345346185815;53245.733771332445;54991;55084.17373739317;55269.44730552643;77022.6148869252;78251.60874195592;79360.60319698596;80195;81195;7683.884741728767;7818.726344577913;8084.555349455836;8106.47307924983;8285.54429506383;8991.775205619912;12219.45012474423;12372.072094592762;12464.002879769416;12908.225506469642;10474.842877356694;10588.364698118137;11118;11212;11225.045871101049;10811.405372704578;10959.397233152253;10960.561577537128;11129.944350278196;11186.10511159089;11113.555457781598;11322.60370887015;11652.94173529127;11664;11687.76624467523;7783.6108194588915;7796.298333149817;7995.560244186626;8107.270345668918;8298.751037468886;8238.5056896584;10305.896941030795;10959.06847917936;11342.376169310437;11395.943020284845 13:17:09 INFO - PROCESS | 1946 | |3;mootools.html;1399.6850708590566;1412.4773833681538;1590.9204539773016;1812.9546761330973;1880.182120777462;8397.202265784748;8957.059508751569;8977.461352318856;8978.326625503081;8982.505962172077;7868.449208555404;8102.189781021895;8107.18928107189;8527.488350698963;8712.259457946082;2315.0971121262764;2360.563295790276;2361.421451744325;2362.55111528809;2363.8581685098948;2345.331580499558;2356.057576969209;2360.799332056777;2377.785999260066;2378.4410663494064;2336.532693461306;2350.7296660883962;2357.9882100589475;2358.1274928276475;2373.1575290771784;2330.6387509935817;2342.367560758603;2346.5541547105995;2353.752855950126;2355.328731311585;2326.1044497868443;2329.5340931813535;2335.614623587123;2336.5910965580956;2341.7658234176615;8741.475511469269;8844.513551754651;8856.690015849414;8919.197272245528;8920.8661870072;5080.61895357846;5236.947630523684;5237.816676416307;5238.397584277781;5247.9737601311745;3352.5474061001696;3422.469517224834;3563.1626567756557;3575.8212089395424;3579.49887015818;1053.6259627832085;1057.9523921423477;1058;1073.1166802262057;1079.8974097460728;11361;11525.423728813526;11545.769084618345;11548.191626586142;11554.826677599844;4417.447819022622;4481.865544033684;4642.605378542862;4676.181668208118;4677.321788340671;9725.319227653996;9742.366746161477;9745.951270243604;9748.512574371252;9750.317477776629;5197;5204.271402003723;5204.947950520522;5205.55752761012;5223.033738758342;4138.8551400700835;4274.2092712848225;4328.632066274339;4777.593904518155;4805.879853003633;3752.2120354725266;3754;3854;3856.46009558662;3892.824822882977;1166.6208482243135;1168.842845582884;1250.9311987840756;1261.2432540475825;1267.7337759070515;814.0597609760736;848.3001523742937;901.2564634176699;906.2206502407923;938.8497840345512;5398.217258497574;5546;5770.903528329688;6013.669248191304;6244.594101383486;944.1691311645845;946.8911075226437;960.9039096090474;964.3105179796339;1007.3351587951917;3861.6331448512346;3867.7679339239735;3989.202159568098;4007.458993035961;4081.918361632751;10226.6420675276;10548.47257637115;10652.467376631292;10788.46057697112;10816.242862999672;10583.84124238137;10611.787764244671;10700.839487407695;10728.195385346131;10740.140788736882;7774.455788094779;8162.265396114378;8170.632321545663;8170.714025009096;8173.18268173178;5864.179014937827;5883.852903677443;6032.8793424132145;6033.818985430444;6087.726052327567;9722.659706910224;9892.554835032297;9908.207343412365;9990.800183996425;9993.200543956611;9782.9021709782;10075.496225188857;10233.539490723084;10259.127974121984;10260.58957641686;6867.381935625817;6995.405390541658;7018.859622807413;7303.63481825896;7465.7013719450615;6214.9689251553455;6983.7206511741;8036;8298.792530186794;8309.542975136426;7244.927550724426;7302.196758356683;7349.926500734924;7379.778606641809;7486.101667799681;7164.570125792469;7169.068021157216;7193.136823581203;7196.820079497845;7248.456365772694;6785.219699734396;6798.7620433286575;6837.692303846239;6842.521023528305;6843.657817109224;4932.3094766731965;4982.377202849644;4998.950010499849;5010.949890501049;5093.694378337312;4200.264953633163;4989.775460104376;4990.50094990498;5188.0661480933795;5379.354477462573 13:17:09 INFO - PROCESS | 1946 | |4;prototype.html;292.0770365644563;300.7563873262657;305.5706732041482;307.8353081101611;311.6602902835908;5029.044481548508;5081.28861959326;5321.255024296597;5403.648762830413;5458.699771512565;4334.8699539013805;4892.681975671588;5342.2253773202865;5420.322459692538;5441.966026454971;3097.8141311521326;3281.6226133994655;3905.2970465316375;4012.2176175645614;4033.576474470168;4001.5798341174195;4031.810615868326;4061.1268577255883;4080.8571699990507;4092.7953602319767;3955.7626542407547;3981.86063487778;3994.4208089826957;3994.820233089518;4012.578679238667;3621.492990981265;3718.9628103718887;3795.7722536647752;3934.940975885364;4029.415734718464;3042.8326442045677;3176.078937108236;3484.5121682964404;3488.5639295088113;3505.9298814023578;3880.3403421418425;5042.1428357179;5111.897762044739;5137.922931156036;5205;4029.435878976946;4092.6725861930972;4597.9654577720075;4624.959384138576;4651.3023046543285;5470.370907345667;5565.6104072714925;5643.407442218549;5648.915266271009;5686.857828554278;3810.818646219681;3819.3316169670475;3824.7896365700153;3827.9617203827884;3831.7892515911612;5408.972955135199;5839.0949402842625;5952.940470595282;5961.837441698871;5961.9864623013755;2996.8501574921165;3472.461768425898;3855.383138697795;3866.284737323604;3867.5358956925347;3940.9802950985636;3944.2505923874373;3944.526656801202;3946.565877753445;3951.209758048402;4571.839985600488;4604.7927843247135;4608.631309495232;4623.56076172763;4629.444466664022;4372.475302963665;4856.434951145982;5250.291210686585;5315.840524784263;5617.92136909338;1309.8821106100497;1326.7213885084047;1326.8673132686847;1327.1240980952525;1330.1752913193882;697.7418355208605;824.2416976381743;832.5712258187039;834.6645367412092;860.6084231674573;4697.976510117427;5070.518300761496;5132.538071573502;5133.512316329943;5318.627696061239;4352.891177720582;4626.467956185082;5244.606654500928;5717.799877004285;5785.669296061845;4693.624510039189;4979.950200497949;5120.743962801845;5254.581263058953;5291.200991662853;2527.2670925431785;2769.0616568401797;2999.2651800309063;3015.427068856954;3025.3949210158057;4726.621870250372;5216.347956505437;5367.731613419313;5913.940860591425;6005.969970150209;4884.975575122173;5607.80372686954;5765.85585360361;5815.41845815415;5915.201447804578;4893.95106048942;4934.3338649282605;5267.841964741064;5894.381089985575;5966.31387390447;4692.7888245029735;5805.651660900359;5820.76716931318;5824.21373114641;5829;4858.63560232991;5698.800541981011;5700.828975130753;5755.165501002248;5904.996150654485;5948.702564871653;5973.970130149321;5984.431479009487;6017.909731354121;6044.24446944132;3537.646235376442;3577.606463289088;3630.2920930418313;3756.0985363512013;3845.2309538093054;4822.758862056953;5392.198500057529;5608.663480191201;5760.395158508296;5767.9711601443405;5594.524465420485;5625.353084395347;5641.464060914206;5646;5687.5449964001955;5477.384171669447;5591.30108736408;5642.492175704042;5663.7451314690115;5742.454466825645;5469.453054694499;5497.725113744217;5504.394516603251;5512.944870551243;5517.2551705519245;5302.946970530245;5496.378568322275;5535.916961245665;5572.749226284908;5671.574631902541;5031.698098114125;5142.012248119468;5433.836984890301;5480.698561579152;5576.553875689854 13:17:09 INFO - PROCESS | 1946 | |5;yui.html;711.7331000874675;765.3647472597744;773.5552057566898;801.4069588504508;810.1857633078757;15211;15359.078455292662;15786.289616967235;15802.446914357999;15809.525714228563;14185.361658725356;14295;14309;14353.569392918203;14361.784573231409;661.9702113404896;687.9656017199145;691.194758106805;822.7655118291289;845.5053793530792;839.1314988986401;845.8646616541355;847.4110493207223;847.7838151271417;848.6138806842872;895.3374502867863;898.6674930275807;899.3030401438872;901.1214066285385;901.1304091551651;695.3359541637724;716.0262043620671;722.3101937649585;894.6197865906996;896.2023798819056;534.794104269855;535.5528134008108;535.7455208775839;643.9710213040424;660.7918505670698;14779.113253204841;14866.033707809065;14866.479673211494;14867.70264594702;14890.627734306729;13752.724945501033;14002.299885005708;14006.159630422208;14122.152670839783;14397.20815355155;11097.778044439066;11116.722081947935;11545.884541154648;11559.94220028903;12999.545015924397;4585.656075794295;4600.217962946307;4735.313379559944;4786.425628924517;4822.204336284509;108402.3739643906;108906;111321;112106.43946780213;113292;10582.153427725763;10660.520276587573;10681.145508359312;10734.78530429387;11083.113350932068;20216.898915505328;20231.4942126448;20239.595208095754;20240.98795060241;20248.898755506423;7603;7757.069151701719;7948.562829044458;7977.60111994398;7995.720149794729;4362.10576831755;4500.4149460569915;4513.729176249435;4612.884677883013;4704.059188162381;3465.2722928184858;3619.040954147153;3620.8551657933913;3628.1836586768295;3629.709623230135;526.2369564132024;656.4879394072631;676.3878689785654;681.802277339566;683.1255992329826;565.5108331293484;587.5358466811257;588.855730346068;595.1816252652603;630.6625955113992;7702.345300649507;8060.234277743605;8637.654493820302;9323.813523729488;9526;582.6416753696531;595.312414161644;626.1296797451546;628.84593274648;681.6591704147926;4284.220484987328;4542.659300552472;4615.769211539409;4660;4739.099571081483;103448.48275758573;115470;137769.3111534436;171522;175000;124648;143251.2837435827;144751.5524844738;147917;154313;88417.15828417106;93790;97488;113964;128610;9476.573554190216;9543.47510886908;9675.419474831533;9928.106470417697;9940.701778946643;60925.39074609197;60940.39059609347;61125.69437152786;61571.692141539;62261;76083.61958190173;76705;79903;90764.09235907557;94009.58985615085;13392.995525335444;13402.530911418053;13419.396127174105;13684.043229498155;13686.726265474435;14848;15074.623134421727;15146;15153.071144057481;15294.77057844111;13522.391492383063;13795.931020345235;13879.444822207402;13907.443702251796;14592.781108283596;12452.688682783002;13237.470501179845;13719.725605487634;13866.306684665524;14166.858331416553;13539.526116585872;13547.322633868464;13824.723505530033;13842.100263482842;14463.987520873437;10982.176336774613;11242.10063194926;11551.595694150665;11561;11639.243449175776;9134.177923986874;11398.10827208267;11427.885721143015;11489;11689.123315751183 13:17:09 INFO - PROCESS | 1946 | __end_tp_report 13:17:09 INFO - PROCESS | 1946 | __start_cc_report 13:17:09 INFO - PROCESS | 1946 | _x_x_mozilla_cycle_collect,1942 13:17:09 INFO - PROCESS | 1946 | __end_cc_report 13:17:09 INFO - PROCESS | 1946 | __startTimestamp1475612229727__endTimestamp 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | ------- Summary: start ------- 13:17:09 INFO - PROCESS | 1946 | Number of tests: 6 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | [#0] dojo.html Cycles:165 Average:5673.15 Median:5879.59 stddev:669.31 (11.4%) stddev-sans-first:645.05 13:17:09 INFO - PROCESS | 1946 | Values: 3304.3 3307.3 3323.3 3341.6 3365.7 5503.8 5591.7 5617.3 5657.1 5716.5 5589.5 5617.5 5670.1 5702.2 5733.7 4105.9 5071.1 5079.4 5132.1 5143.5 4294.0 4730.7 5160.4 5247.9 5255.3 5071.1 5115.2 5207.1 5225.8 5243.6 5130.8 5140.7 5156.0 5159.0 5160.6 5014.7 5084.0 5090.3 5092.9 5100.8 5590.6 5623.1 5632.9 5652.3 5655.7 6166.1 6185.1 6186.9 6190.7 6201.4 6134.5 6236.8 6256.2 6262.4 6279.8 5540.6 5644.7 5661.4 5704.4 5709.7 6334.0 6341.1 6355.4 6372.6 6388.3 6080.7 6090.3 6092.1 6095.8 6097.9 6104.2 6119.5 6119.7 6249.8 6251.1 6019.1 6121.2 6130.9 6151.5 6158.4 6149.5 6163.9 6164.2 6175.7 6189.3 4807.8 4822.6 4862.9 4874.0 4906.2 4339.0 4341.7 4379.5 4385.6 4387.5 5705.0 5708.6 5711.6 5713.9 5761.2 6239.2 6261.8 6261.8 6263.5 6266.7 5587.5 5635.9 5638.0 5678.0 5693.8 5250.9 5278.6 5285.0 5316.9 5326.1 6306.5 6312.6 6320.3 6323.4 6346.7 6099.0 6117.9 6130.8 6254.2 6272.6 6261.0 6294.4 6345.7 6347.2 6348.0 6120.6 6135.0 6137.3 6150.5 6157.8 6062.4 6219.0 6235.0 6241.5 6249.8 5934.9 5976.0 5981.7 6023.7 6098.0 5879.6 5884.8 6052.8 6056.9 6074.9 5755.5 5773.6 5896.8 5902.4 5908.1 4943.4 5882.1 5943.0 6018.2 6039.7 5830.7 5838.6 5839.4 5872.7 5895.6 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | [#1] ext.html Cycles:180 Average:68418.30 Median:36569.04 stddev:151343.09 (413.9%) stddev-sans-first:151681.75 13:17:09 INFO - PROCESS | 1946 | Values: 504.4 520.5 527.0 529.3 551.7 29627.0 39074.6 40133.6 40190.4 42332.4 40651.4 40932.6 41014.4 41026.4 41032.4 9576.4 9763.7 9771.4 9772.4 9773.9 8666.2 8880.6 10833.2 11246.6 11713.8 11681.2 11782.1 11860.4 11966.8 12000.9 8687.9 11911.5 11986.2 12014.1 12021.2 7380.3 11382.4 11651.4 11684.4 11843.4 38930.8 39220.0 39247.6 39342.8 39369.4 3275.6 3289.0 3351.5 3928.3 4010.7 26179.0 28559.7 29598.7 30080.5 31277.0 2686.5 3151.3 3254.9 3343.2 3348.9 426076.0 431368.0 431581.8 431960.0 432971.0 58743.7 59089.1 59140.1 59160.7 59227.0 61800.4 62086.1 62131.0 62136.0 62205.4 15876.4 16105.0 16110.2 16121.7 16136.9 11212.5 11530.2 12386.9 12455.9 12503.4 15866.9 17934.8 17985.1 18352.5 18424.5 7474.6 7529.8 7602.2 7671.3 7716.2 720.5 923.5 963.3 970.5 1080.5 26625.2 28128.3 28271.9 28545.9 28907.3 1025.8 1053.8 1059.7 1063.4 1109.1 12324.9 14776.1 14855.6 15151.4 15207.8 659473.0 664939.0 665464.0 667398.0 671957.0 53959.5 54400.7 54423.7 54516.2 54560.7 1334.8 1380.3 1400.3 1402.4 1404.1 28258.4 28366.7 28614.6 28648.0 28966.6 46082.8 46413.8 46414.5 46538.5 46654.0 572336.0 573996.1 574958.0 575910.0 576191.0 22175.4 24319.0 24643.9 24714.8 24775.0 42488.0 42627.0 42921.6 44505.0 44658.1 36443.8 36733.0 37114.9 37545.0 37734.8 31528.7 33198.7 36694.3 37744.0 37965.6 35795.8 36074.8 36702.3 37201.1 37285.9 31917.8 32238.0 32652.5 32808.5 33007.7 20790.9 24008.5 24663.9 24854.0 25015.0 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | [#2] jquery.html Cycles:180 Average:33482.27 Median:364.61 stddev:94946.28 (26040.6%) stddev-sans-first:95180.04 13:17:09 INFO - PROCESS | 1946 | Values: 347.3 364.3 365.0 375.7 395.4 15043.3 15406.6 16169.7 20319.6 20701.0 19470.0 19912.4 20535.4 20620.3 20661.8 5571.8 5647.5 5713.3 5784.1 6105.8 5685.5 6056.8 6131.2 6134.1 6140.5 5713.4 5972.1 5974.2 5987.3 6099.8 5718.8 5754.9 5801.2 5802.7 5812.7 4940.7 5061.9 5078.1 5178.5 5257.8 25342.0 25959.7 26157.7 26355.6 26383.0 2440.9 2446.5 2542.2 2543.0 2925.3 6903.6 6905.3 6917.0 6931.1 12543.2 1787.7 1845.0 1857.6 1864.0 1902.0 110281.0 113661.0 114173.0 114348.0 115494.0 8595.8 10063.0 10141.7 10637.6 10675.4 11521.6 12877.8 12881.0 12886.0 12911.2 6281.8 7932.5 7983.3 8139.4 8162.3 8379.1 8411.3 8425.2 8542.0 8583.4 3787.4 3807.6 3840.8 3842.1 3922.7 1846.7 1876.6 1880.7 1889.0 1891.3 868.8 885.5 909.2 972.4 984.0 20392.7 21866.0 21987.5 22168.0 22388.4 772.8 931.9 956.5 956.6 1029.4 7811.5 10634.6 11404.9 11422.1 11467.9 558514.0 565846.0 565933.0 576063.0 579274.0 91190.5 104681.1 120598.0 127793.0 130114.7 920.7 961.3 984.3 1030.8 1033.5 19399.0 19905.5 20158.8 20175.3 20237.0 41366.3 53245.7 54991.0 55084.2 55269.4 77022.6 78251.6 79360.6 80195.0 81195.0 7683.9 7818.7 8084.6 8106.5 8285.5 8991.8 12219.5 12372.1 12464.0 12908.2 10474.8 10588.4 11118.0 11212.0 11225.0 10811.4 10959.4 10960.6 11129.9 11186.1 11113.6 11322.6 11652.9 11664.0 11687.8 7783.6 7796.3 7995.6 8107.3 8298.8 8238.5 10305.9 10959.1 11342.4 11395.9 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | [#3] mootools.html Cycles:180 Average:5629.55 Median:5004.95 stddev:3158.10 (63.1%) stddev-sans-first:3150.96 13:17:09 INFO - PROCESS | 1946 | Values: 1399.7 1412.5 1590.9 1813.0 1880.2 8397.2 8957.1 8977.5 8978.3 8982.5 7868.4 8102.2 8107.2 8527.5 8712.3 2315.1 2360.6 2361.4 2362.6 2363.9 2345.3 2356.1 2360.8 2377.8 2378.4 2336.5 2350.7 2358.0 2358.1 2373.2 2330.6 2342.4 2346.6 2353.8 2355.3 2326.1 2329.5 2335.6 2336.6 2341.8 8741.5 8844.5 8856.7 8919.2 8920.9 5080.6 5236.9 5237.8 5238.4 5248.0 3352.5 3422.5 3563.2 3575.8 3579.5 1053.6 1058.0 1058.0 1073.1 1079.9 11361.0 11525.4 11545.8 11548.2 11554.8 4417.4 4481.9 4642.6 4676.2 4677.3 9725.3 9742.4 9746.0 9748.5 9750.3 5197.0 5204.3 5204.9 5205.6 5223.0 4138.9 4274.2 4328.6 4777.6 4805.9 3752.2 3754.0 3854.0 3856.5 3892.8 1166.6 1168.8 1250.9 1261.2 1267.7 814.1 848.3 901.3 906.2 938.8 5398.2 5546.0 5770.9 6013.7 6244.6 944.2 946.9 960.9 964.3 1007.3 3861.6 3867.8 3989.2 4007.5 4081.9 10226.6 10548.5 10652.5 10788.5 10816.2 10583.8 10611.8 10700.8 10728.2 10740.1 7774.5 8162.3 8170.6 8170.7 8173.2 5864.2 5883.9 6032.9 6033.8 6087.7 9722.7 9892.6 9908.2 9990.8 9993.2 9782.9 10075.5 10233.5 10259.1 10260.6 6867.4 6995.4 7018.9 7303.6 7465.7 6215.0 6983.7 8036.0 8298.8 8309.5 7244.9 7302.2 7349.9 7379.8 7486.1 7164.6 7169.1 7193.1 7196.8 7248.5 6785.2 6798.8 6837.7 6842.5 6843.7 4932.3 4982.4 4999.0 5010.9 5093.7 4200.3 4989.8 4990.5 5188.1 5379.4 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | [#4] prototype.html Cycles:180 Average:4498.16 Median:5075.90 stddev:1408.84 (27.8%) stddev-sans-first:1376.97 13:17:09 INFO - PROCESS | 1946 | Values: 292.1 300.8 305.6 307.8 311.7 5029.0 5081.3 5321.3 5403.6 5458.7 4334.9 4892.7 5342.2 5420.3 5442.0 3097.8 3281.6 3905.3 4012.2 4033.6 4001.6 4031.8 4061.1 4080.9 4092.8 3955.8 3981.9 3994.4 3994.8 4012.6 3621.5 3719.0 3795.8 3934.9 4029.4 3042.8 3176.1 3484.5 3488.6 3505.9 3880.3 5042.1 5111.9 5137.9 5205.0 4029.4 4092.7 4598.0 4625.0 4651.3 5470.4 5565.6 5643.4 5648.9 5686.9 3810.8 3819.3 3824.8 3828.0 3831.8 5409.0 5839.1 5952.9 5961.8 5962.0 2996.9 3472.5 3855.4 3866.3 3867.5 3941.0 3944.3 3944.5 3946.6 3951.2 4571.8 4604.8 4608.6 4623.6 4629.4 4372.5 4856.4 5250.3 5315.8 5617.9 1309.9 1326.7 1326.9 1327.1 1330.2 697.7 824.2 832.6 834.7 860.6 4698.0 5070.5 5132.5 5133.5 5318.6 4352.9 4626.5 5244.6 5717.8 5785.7 4693.6 4980.0 5120.7 5254.6 5291.2 2527.3 2769.1 2999.3 3015.4 3025.4 4726.6 5216.3 5367.7 5913.9 6006.0 4885.0 5607.8 5765.9 5815.4 5915.2 4894.0 4934.3 5267.8 5894.4 5966.3 4692.8 5805.7 5820.8 5824.2 5829.0 4858.6 5698.8 5700.8 5755.2 5905.0 5948.7 5974.0 5984.4 6017.9 6044.2 3537.6 3577.6 3630.3 3756.1 3845.2 4822.8 5392.2 5608.7 5760.4 5768.0 5594.5 5625.4 5641.5 5646.0 5687.5 5477.4 5591.3 5642.5 5663.7 5742.5 5469.5 5497.7 5504.4 5512.9 5517.3 5302.9 5496.4 5535.9 5572.7 5671.6 5031.7 5142.0 5433.8 5480.7 5576.6 13:17:09 INFO - PROCESS | 1946 | 13:17:09 INFO - PROCESS | 1946 | [#5] yui.html Cycles:180 Average:24655.98 Median:3956.97 stddev:39741.79 (1004.4%) stddev-sans-first:39812.61 13:17:09 INFO - PROCESS | 1946 | Values: 711.7 765.4 773.6 801.4 810.2 15211.0 15359.1 15786.3 15802.4 15809.5 14185.4 14295.0 14309.0 14353.6 14361.8 662.0 688.0 691.2 822.8 845.5 839.1 845.9 847.4 847.8 848.6 895.3 898.7 899.3 901.1 901.1 695.3 716.0 722.3 894.6 896.2 534.8 535.6 535.7 644.0 660.8 14779.1 14866.0 14866.5 14867.7 14890.6 13752.7 14002.3 14006.2 14122.2 14397.2 11097.8 11116.7 11545.9 11559.9 12999.5 4585.7 4600.2 4735.3 4786.4 4822.2 108402.4 108906.0 111321.0 112106.4 113292.0 10582.2 10660.5 10681.1 10734.8 11083.1 20216.9 20231.5 20239.6 20241.0 20248.9 7603.0 7757.1 7948.6 7977.6 7995.7 4362.1 4500.4 4513.7 4612.9 4704.1 3465.3 3619.0 3620.9 3628.2 3629.7 526.2 656.5 676.4 681.8 683.1 565.5 587.5 588.9 595.2 630.7 7702.3 8060.2 8637.7 9323.8 9526.0 582.6 595.3 626.1 628.8 681.7 4284.2 4542.7 4615.8 4660.0 4739.1 103448.5 115470.0 137769.3 171522.0 175000.0 124648.0 143251.3 144751.6 147917.0 154313.0 88417.2 93790.0 97488.0 113964.0 128610.0 9476.6 9543.5 9675.4 9928.1 9940.7 60925.4 60940.4 61125.7 61571.7 62261.0 76083.6 76705.0 79903.0 90764.1 94009.6 13393.0 13402.5 13419.4 13684.0 13686.7 14848.0 15074.6 15146.0 15153.1 15294.8 13522.4 13795.9 13879.4 13907.4 14592.8 12452.7 13237.5 13719.7 13866.3 14166.9 13539.5 13547.3 13824.7 13842.1 14464.0 10982.2 11242.1 11551.6 11561.0 11639.2 9134.2 11398.1 11427.9 11489.0 11689.1 13:17:09 INFO - PROCESS | 1946 | -------- Summary: end -------- 13:17:09 INFO - PROCESS | 1946 | 13:17:10 INFO - TEST-INFO | 1946: exit 0 13:17:10 INFO - TEST-OK | dromaeo_css | took 1119899ms 13:17:10 INFO - TEST-START | kraken 13:17:10 INFO - operating with platform_type : mac_ 13:17:10 INFO - Initialising browser for kraken test... 13:17:10 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmp1P0uqE/profile http://localhost:49772/getInfo.html) 13:17:12 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 13:17:12 INFO - PROCESS | 1949 | colorDepth:24 13:17:12 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 13:17:12 INFO - PROCESS | 1949 | __metrics 13:17:12 INFO - PROCESS | 1949 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:17:12 INFO - PROCESS | 1949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:13 INFO - TEST-INFO | 1949: exit 0 13:17:13 INFO - Browser initialized. 13:17:13 INFO - Running cycle 1/1 for kraken test... 13:17:13 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmp1P0uqE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:25 INFO - PROCESS | 1950 | RSS: Main: 235622400 13:17:25 INFO - PROCESS | 1950 | 13:17:28 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49772/tests/kraken/driver.html?testName=audio-beat-detection) 13:17:28 INFO - PROCESS | 1950 | RSS: Main: 294285312 13:17:28 INFO - PROCESS | 1950 | 13:17:31 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49772/tests/kraken/driver.html?testName=audio-dft) 13:17:32 INFO - PROCESS | 1950 | RSS: Main: 293228544 13:17:32 INFO - PROCESS | 1950 | 13:17:35 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49772/tests/kraken/driver.html?testName=audio-fft) 13:17:36 INFO - PROCESS | 1950 | RSS: Main: 383094784 13:17:36 INFO - PROCESS | 1950 | 13:17:38 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49772/tests/kraken/driver.html?testName=audio-oscillator) 13:17:38 INFO - PROCESS | 1950 | RSS: Main: 288333824 13:17:38 INFO - PROCESS | 1950 | 13:17:40 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:41 INFO - PROCESS | 1950 | RSS: Main: 290123776 13:17:41 INFO - PROCESS | 1950 | 13:17:44 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49772/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:45 INFO - PROCESS | 1950 | RSS: Main: 327892992 13:17:45 INFO - PROCESS | 1950 | 13:17:47 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49772/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:48 INFO - PROCESS | 1950 | RSS: Main: 328650752 13:17:48 INFO - PROCESS | 1950 | 13:17:51 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49772/tests/kraken/driver.html?testName=json-parse-financial) 13:17:51 INFO - PROCESS | 1950 | RSS: Main: 326705152 13:17:51 INFO - PROCESS | 1950 | 13:17:53 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:54 INFO - PROCESS | 1950 | RSS: Main: 301338624 13:17:54 INFO - PROCESS | 1950 | 13:17:56 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:56 INFO - PROCESS | 1950 | RSS: Main: 305041408 13:17:56 INFO - PROCESS | 1950 | 13:17:58 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:17:59 INFO - PROCESS | 1950 | RSS: Main: 310411264 13:17:59 INFO - PROCESS | 1950 | 13:18:02 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:18:03 INFO - PROCESS | 1950 | RSS: Main: 320270336 13:18:03 INFO - PROCESS | 1950 | 13:18:06 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:18:07 INFO - PROCESS | 1950 | RSS: Main: 319655936 13:18:07 INFO - PROCESS | 1950 | 13:18:08 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:49772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49772/tests/kraken/driver.html?testName=ai-astar) 13:18:09 INFO - PROCESS | 1950 | RSS: Main: 363962368 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | __start_tp_report 13:18:09 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 13:18:09 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 13:18:09 INFO - PROCESS | 1950 | |i|pagename|runs| 13:18:09 INFO - PROCESS | 1950 | |0;ai-astar;113;115;115;114;113;114;113;114;113;113 13:18:09 INFO - PROCESS | 1950 | |1;audio-beat-detection;152;116;114;150;115;115;112;113;144;113 13:18:09 INFO - PROCESS | 1950 | |2;audio-dft;184;187;183;185;185;184;182;181;183;184 13:18:09 INFO - PROCESS | 1950 | |3;audio-fft;82;59;60;99;60;60;60;59;85;60 13:18:09 INFO - PROCESS | 1950 | |4;audio-oscillator;86;70;97;72;68;68;91;67;69;91 13:18:09 INFO - PROCESS | 1950 | |5;imaging-gaussian-blur;91;87;90;88;89;86;94;124;90;87 13:18:09 INFO - PROCESS | 1950 | |6;imaging-darkroom;129;142;96;95;94;95;96;96;95;94 13:18:09 INFO - PROCESS | 1950 | |7;imaging-desaturate;84;85;87;85;86;86;87;85;86;84 13:18:09 INFO - PROCESS | 1950 | |8;json-parse-financial;57;52;54;53;55;55;56;55;55;54 13:18:09 INFO - PROCESS | 1950 | |9;json-stringify-tinderbox;66;81;75;73;72;70;69;71;70;71 13:18:09 INFO - PROCESS | 1950 | |10;stanford-crypto-aes;88;90;87;90;102;105;106;93;91;90 13:18:09 INFO - PROCESS | 1950 | |11;stanford-crypto-ccm;148;145;154;159;164;155;153;150;212;146 13:18:09 INFO - PROCESS | 1950 | |12;stanford-crypto-pbkdf2;189;234;195;173;173;172;170;172;173;173 13:18:09 INFO - PROCESS | 1950 | |13;stanford-crypto-sha256-iterative;70;68;69;68;69;69;69;68;68;69 13:18:09 INFO - PROCESS | 1950 | __end_tp_report 13:18:09 INFO - PROCESS | 1950 | __start_cc_report 13:18:09 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,1969 13:18:09 INFO - PROCESS | 1950 | __end_cc_report 13:18:09 INFO - PROCESS | 1950 | __startTimestamp1475612289089__endTimestamp 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | ------- Summary: start ------- 13:18:09 INFO - PROCESS | 1950 | Number of tests: 14 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 13:18:09 INFO - PROCESS | 1950 | Values: 113.0 115.0 115.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:115.50 stddev:16.90 (14.6%) stddev-sans-first:14.68 13:18:09 INFO - PROCESS | 1950 | Values: 152.0 116.0 114.0 150.0 115.0 115.0 112.0 113.0 144.0 113.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.69 (0.9%) stddev-sans-first:1.79 13:18:09 INFO - PROCESS | 1950 | Values: 184.0 187.0 183.0 185.0 185.0 184.0 182.0 181.0 183.0 184.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#3] audio-fft Cycles:10 Average:68.40 Median:60.00 stddev:14.63 (24.4%) stddev-sans-first:14.67 13:18:09 INFO - PROCESS | 1950 | Values: 82.0 59.0 60.0 99.0 60.0 60.0 60.0 59.0 85.0 60.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.00 stddev:11.86 (15.0%) stddev-sans-first:12.21 13:18:09 INFO - PROCESS | 1950 | Values: 86.0 70.0 97.0 72.0 68.0 68.0 91.0 67.0 69.0 91.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:89.50 stddev:11.28 (12.6%) stddev-sans-first:11.95 13:18:09 INFO - PROCESS | 1950 | Values: 91.0 87.0 90.0 88.0 89.0 86.0 94.0 124.0 90.0 87.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:95.00 stddev:17.31 (18.2%) stddev-sans-first:15.64 13:18:09 INFO - PROCESS | 1950 | Values: 129.0 142.0 96.0 95.0 94.0 95.0 96.0 96.0 95.0 94.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.08 (1.3%) stddev-sans-first:1.00 13:18:09 INFO - PROCESS | 1950 | Values: 84.0 85.0 87.0 85.0 86.0 86.0 87.0 85.0 86.0 84.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.22 13:18:09 INFO - PROCESS | 1950 | Values: 57.0 52.0 54.0 53.0 55.0 55.0 56.0 55.0 55.0 54.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:4.02 (5.6%) stddev-sans-first:3.68 13:18:09 INFO - PROCESS | 1950 | Values: 66.0 81.0 75.0 73.0 72.0 70.0 69.0 71.0 70.0 71.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#10] stanford-crypto-aes Cycles:10 Average:94.20 Median:90.00 stddev:7.24 (8.0%) stddev-sans-first:7.32 13:18:09 INFO - PROCESS | 1950 | Values: 88.0 90.0 87.0 90.0 102.0 105.0 106.0 93.0 91.0 90.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:154.50 stddev:19.65 (12.7%) stddev-sans-first:20.47 13:18:09 INFO - PROCESS | 1950 | Values: 148.0 145.0 154.0 159.0 164.0 155.0 153.0 150.0 212.0 146.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.40 Median:173.00 stddev:19.97 (11.5%) stddev-sans-first:21.04 13:18:09 INFO - PROCESS | 1950 | Values: 189.0 234.0 195.0 173.0 173.0 172.0 170.0 172.0 173.0 173.0 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - PROCESS | 1950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 13:18:09 INFO - PROCESS | 1950 | Values: 70.0 68.0 69.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 13:18:09 INFO - PROCESS | 1950 | -------- Summary: end -------- 13:18:09 INFO - PROCESS | 1950 | 13:18:09 INFO - TEST-INFO | 1950: exit 0 13:18:09 INFO - TEST-OK | kraken | took 59574ms 13:18:09 INFO - SUITE-END | took 1179s 13:18:10 INFO - Completed test suite (00:19:39) 13:18:10 INFO - javascript benchmark 13:18:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.3060957198995, 3307.3054658521714, 3323.335332933414, 3341.5655964724583, 3365.6802603752635, 5503.7798488060525, 5591.664500129995, 5617.325920889494, 5657.123145912385, 5716.456936591027, 5589.469000444951, 5617.466340697627, 5670.0927851543765, 5702.201691763156, 5733.713314334277, 4105.856295029675, 5071.137906555894, 5079.390473143228, 5132.076226279269, 5143.53708166265, 4293.957060429387, 4730.668853180278, 5160.406553246387, 5247.947520524784, 5255.343082114736, 5071.061853557104, 5115.18157094863, 5207.114790485626, 5225.790968361261, 5243.6067294952645, 5130.769115389817, 5140.74296285188, 5156.020356132323, 5159.0, 5160.587153027749, 5014.674046186986, 5083.974580127113, 5090.261912022773, 5092.949070509285, 5100.846974590731, 5590.608657393984, 5623.100303951389, 5632.915506267409, 5652.293463317085, 5655.7454914528535, 6166.07508873668, 6185.134081228632, 6186.9381306186815, 6190.690465476753, 6201.410865967771, 6134.478569321613, 6236.781712640081, 6256.217972753406, 6262.373762623747, 6279.780207692755, 5540.556755459554, 5644.717764111778, 5661.377248502661, 5704.401037891044, 5709.657420554739, 6334.049892516159, 6341.0805433212845, 6355.428011478989, 6372.617642941438, 6388.2653494847755, 6080.695965201722, 6090.269167699905, 6092.116643086816, 6095.817125486243, 6097.878042439126, 6104.236970378703, 6119.533019689859, 6119.653521814353, 6249.78125765596, 6251.062340648939, 6019.127226552213, 6121.204243448323, 6130.908036379458, 6151.507879369639, 6158.445739883342, 6149.538784591174, 6163.876722465526, 6164.167837341902, 6175.722092505848, 6189.288231853305, 4807.78364973577, 4822.590079843182, 4862.878428039327, 4874.049560335771, 4906.1659517881335, 4339.0, 4341.6526677865695, 4379.49635791888, 4385.561443855589, 4387.517373088957, 5705.030144875381, 5708.628939118944, 5711.600187986801, 5713.885722285531, 5761.193432919311, 6239.157713708682, 6261.78083767066, 6261.780837670751, 6263.467605253604, 6266.686665666698, 5587.469190426903, 5635.915461268084, 5638.0, 5677.971610141923, 5693.772249109989, 5250.947490525045, 5278.577713782888, 5284.973575132177, 5316.9202461963105, 5326.121190003683, 6306.49548036156, 6312.589681670676, 6320.304766475776, 6323.430891219812, 6346.746130154742, 6099.007149910021, 6117.938820611915, 6130.846728831815, 6254.186955695731, 6272.5922815016875, 6261.0, 6294.433500984934, 6345.746170153142, 6347.238331400262, 6348.047792831112, 6120.571559990758, 6134.969325153345, 6137.263528376623, 6150.50795936333, 6157.84605384869, 6062.393760624079, 6219.0, 6235.0, 6241.500679945684, 6249.781257656142, 5934.9109763354445, 5976.043832986875, 5981.700914954322, 6023.698815059141, 6098.0, 5879.588428809942, 5884.823455296348, 6052.757889684363, 6056.939430605637, 6074.878502429839, 5755.453231942959, 5773.595848290579, 5896.823095307148, 5902.38025007368, 5908.05471124618, 4943.382077240345, 5882.1470886722045, 5943.0, 6018.247719035121, 6039.667818270037, 5830.737616807169, 5838.591298609056, 5839.416058394127, 5872.706364681834, 5895.557833162444], "value": 5628.713436672298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.4098404866306, 520.5081198267637, 526.9525742683157, 529.3066083430706, 551.7268951868825, 29627.0, 39074.60925390745, 40133.598664013385, 40190.39714404279, 42332.36501452473, 40651.390229146586, 40932.5673601424, 41014.38478422826, 41026.38460423089, 41032.38451423224, 9576.425414475154, 9763.658271960483, 9771.413715177077, 9772.413655180677, 9773.853392199087, 8666.176713212235, 8880.555972201397, 10833.187510936672, 11246.606368777095, 11713.765724685501, 11681.182317237797, 11782.116341274395, 11860.406979651027, 11966.82049769254, 12000.939995300012, 8687.913120868838, 11911.523539058428, 11986.220895641756, 12014.098942579341, 12021.218620789621, 7380.261973802631, 11382.430878456044, 11651.359175245358, 11684.357360345177, 11843.407829608572, 38930.80534597337, 39220.0, 39247.60752392468, 39342.803285983675, 39369.40945885814, 3275.557799697034, 3288.967110328914, 3351.547541081947, 3928.292907276689, 4010.7393019453643, 26178.9528418863, 28559.714402855912, 29598.70401295981, 30080.548791768142, 31277.0, 2686.502996945552, 3151.322465669892, 3254.869805207789, 3343.164208947763, 3348.9497657535157, 426076.0, 431368.0, 431581.8420907907, 431960.0, 432971.0, 58743.706281469174, 59089.11366329509, 59140.11289830656, 59160.7041964796, 59227.0, 61800.38199618036, 62086.068708969404, 62131.0, 62136.0, 62205.37794622086, 15876.364945402285, 16105.0, 16110.194490275439, 16121.67756644884, 16136.919315403347, 11212.49543770516, 11530.192886497865, 12386.876131238752, 12455.875441245653, 12503.374831258401, 15866.889317747648, 17934.820651793314, 17985.11156328593, 18352.541186470444, 18424.539386515175, 7474.626268686544, 7529.832875904243, 7602.201768814195, 7671.34793542544, 7716.228377162239, 720.5208536323287, 923.4874644572327, 963.2631037256505, 970.5001924009141, 1080.5353697909975, 26625.20124396271, 28128.29679257994, 28271.858640706665, 28545.85727071393, 28907.277318066797, 1025.779457416659, 1053.7576357437679, 1059.7403636109202, 1063.4310643805682, 1109.1016276815806, 12324.876751232552, 14776.113433194043, 14855.628609284855, 15151.393944242107, 15207.847921520864, 659473.0, 664939.0, 665464.0, 667398.0, 671957.0, 53959.46040539623, 54400.727996360554, 54423.72788136034, 54516.18225726617, 54560.72719636376, 1334.766415877237, 1380.2615600653603, 1400.3348409505404, 1402.4320150339129, 1404.1434724817852, 28258.434831302846, 28366.716332836408, 28614.57078143788, 28648.0, 28966.565501517074, 46082.76958615185, 46413.76793116013, 46414.535854642374, 46538.53461465342, 46654.0, 572336.0, 573996.130019364, 574958.0, 575910.0, 576191.0, 22175.44561385978, 24319.0, 24643.87678061598, 24714.752852471243, 24775.0, 42488.0, 42627.0, 42921.570784293006, 44505.0, 44658.106837863714, 36443.817780910926, 36733.0, 37114.9144254283, 37545.0, 37734.81132594319, 31528.684713153492, 33198.66801332052, 36694.266114677026, 37744.0, 37965.62034379621, 35795.82102089473, 36074.819625901706, 36702.265954681294, 37201.06997325089, 37285.88142355734, 31917.8404107978, 32238.032859014267, 32652.510212347308, 32808.50787238146, 33007.66992330046, 20790.896045519676, 24008.51982960296, 24663.876680616482, 24854.0, 25015.0], "value": 19676.301670476514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.30365616938036, 364.266004001936, 364.9507316512271, 375.6919326152556, 395.40688966550175, 15043.323050462728, 15406.61483462914, 16169.676606467863, 20319.593608127827, 20701.0, 19470.0, 19912.402627921187, 20535.38393848183, 20620.278290259845, 20661.793382066175, 5571.774209673866, 5647.463490968352, 5713.342965558952, 5784.103463963082, 6105.847353816168, 5685.545156387499, 6056.818295451144, 6131.172291740602, 6134.141220229149, 6140.53945954053, 5713.428657134295, 5972.104184372357, 5974.193483879664, 5987.311459182206, 6099.81700548982, 5718.799842005551, 5754.942450575482, 5801.187833703285, 5802.65184088956, 5812.680302583356, 4940.7035577865445, 5061.924071138936, 5078.085944529983, 5178.4562620924635, 5257.842264732026, 25342.0, 25959.74040259611, 26157.738422615912, 26355.56788240186, 26383.0, 2440.9267721968367, 2446.498467814094, 2542.1992072497287, 2542.9745702542923, 2925.3417980954328, 6903.5512691675385, 6905.343992320772, 6916.965415172942, 6931.0643063186835, 12543.184692994926, 1787.6960916644202, 1845.0, 1857.6284743051444, 1864.0, 1902.0, 110281.0, 113661.0, 114173.0, 114348.0, 115494.0, 8595.785105372415, 10063.0, 10141.746456338504, 10637.627683031056, 10675.412852293042, 11521.596744114084, 12877.77661122192, 12881.0, 12886.0, 12911.160774549624, 6281.780137695158, 7932.524048556989, 7983.321417679446, 8139.430239883151, 8162.265396114378, 8379.120192379834, 8411.327093832479, 8425.199606037539, 8542.0, 8583.356248281403, 3787.3750831112557, 3807.638274363931, 3840.7695538267794, 3842.0971071798103, 3922.666573341241, 1846.7100795014355, 1876.634056358997, 1880.6896862017888, 1889.0271510172272, 1891.3191251149576, 868.847951608466, 885.5129678676702, 909.2271569166156, 972.363102168081, 984.0454758883872, 20392.694109588072, 21866.0, 21987.450313741963, 22168.002439890242, 22388.440288992904, 772.8492943876003, 931.9440833550009, 956.5217391304348, 956.5647630328184, 1029.3566520924421, 7811.531308121531, 10634.627788027381, 11404.885951140548, 11422.14333924959, 11467.942660286646, 558514.0, 565846.0, 565933.0, 576063.0, 579274.0, 91190.54404728067, 104681.07227295748, 120598.0, 127793.0, 130114.69885301025, 920.6593560382702, 961.3318743473359, 984.3109823123842, 1030.7886883188928, 1033.509083185481, 19399.0300484978, 19905.502362440475, 20158.79841201569, 20175.293864714666, 20237.0, 41366.345346185815, 53245.733771332445, 54991.0, 55084.17373739317, 55269.44730552643, 77022.6148869252, 78251.60874195592, 79360.60319698596, 80195.0, 81195.0, 7683.884741728767, 7818.726344577913, 8084.555349455836, 8106.47307924983, 8285.54429506383, 8991.775205619912, 12219.45012474423, 12372.072094592762, 12464.002879769416, 12908.225506469642, 10474.842877356694, 10588.364698118137, 11118.0, 11212.0, 11225.045871101049, 10811.405372704578, 10959.397233152253, 10960.561577537128, 11129.944350278196, 11186.10511159089, 11113.555457781598, 11322.60370887015, 11652.94173529127, 11664.0, 11687.76624467523, 7783.6108194588915, 7796.298333149817, 7995.560244186626, 8107.270345668918, 8298.751037468886, 8238.5056896584, 10305.896941030795, 10959.06847917936, 11342.376169310437, 11395.943020284845], "value": 9255.6663518134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.6850708590566, 1412.4773833681538, 1590.9204539773016, 1812.9546761330973, 1880.182120777462, 8397.202265784748, 8957.059508751569, 8977.461352318856, 8978.326625503081, 8982.505962172077, 7868.449208555404, 8102.189781021895, 8107.18928107189, 8527.488350698963, 8712.259457946082, 2315.0971121262764, 2360.563295790276, 2361.421451744325, 2362.55111528809, 2363.8581685098948, 2345.331580499558, 2356.057576969209, 2360.799332056777, 2377.785999260066, 2378.4410663494064, 2336.532693461306, 2350.7296660883962, 2357.9882100589475, 2358.1274928276475, 2373.1575290771784, 2330.6387509935817, 2342.367560758603, 2346.5541547105995, 2353.752855950126, 2355.328731311585, 2326.1044497868443, 2329.5340931813535, 2335.614623587123, 2336.5910965580956, 2341.7658234176615, 8741.475511469269, 8844.513551754651, 8856.690015849414, 8919.197272245528, 8920.8661870072, 5080.61895357846, 5236.947630523684, 5237.816676416307, 5238.397584277781, 5247.9737601311745, 3352.5474061001696, 3422.469517224834, 3563.1626567756557, 3575.8212089395424, 3579.49887015818, 1053.6259627832085, 1057.9523921423477, 1058.0, 1073.1166802262057, 1079.8974097460728, 11361.0, 11525.423728813526, 11545.769084618345, 11548.191626586142, 11554.826677599844, 4417.447819022622, 4481.865544033684, 4642.605378542862, 4676.181668208118, 4677.321788340671, 9725.319227653996, 9742.366746161477, 9745.951270243604, 9748.512574371252, 9750.317477776629, 5197.0, 5204.271402003723, 5204.947950520522, 5205.55752761012, 5223.033738758342, 4138.8551400700835, 4274.2092712848225, 4328.632066274339, 4777.593904518155, 4805.879853003633, 3752.2120354725266, 3754.0, 3854.0, 3856.46009558662, 3892.824822882977, 1166.6208482243135, 1168.842845582884, 1250.9311987840756, 1261.2432540475825, 1267.7337759070515, 814.0597609760736, 848.3001523742937, 901.2564634176699, 906.2206502407923, 938.8497840345512, 5398.217258497574, 5546.0, 5770.903528329688, 6013.669248191304, 6244.594101383486, 944.1691311645845, 946.8911075226437, 960.9039096090474, 964.3105179796339, 1007.3351587951917, 3861.6331448512346, 3867.7679339239735, 3989.202159568098, 4007.458993035961, 4081.918361632751, 10226.6420675276, 10548.47257637115, 10652.467376631292, 10788.46057697112, 10816.242862999672, 10583.84124238137, 10611.787764244671, 10700.839487407695, 10728.195385346131, 10740.140788736882, 7774.455788094779, 8162.265396114378, 8170.632321545663, 8170.714025009096, 8173.18268173178, 5864.179014937827, 5883.852903677443, 6032.8793424132145, 6033.818985430444, 6087.726052327567, 9722.659706910224, 9892.554835032297, 9908.207343412365, 9990.800183996425, 9993.200543956611, 9782.9021709782, 10075.496225188857, 10233.539490723084, 10259.127974121984, 10260.58957641686, 6867.381935625817, 6995.405390541658, 7018.859622807413, 7303.63481825896, 7465.7013719450615, 6214.9689251553455, 6983.7206511741, 8036.0, 8298.792530186794, 8309.542975136426, 7244.927550724426, 7302.196758356683, 7349.926500734924, 7379.778606641809, 7486.101667799681, 7164.570125792469, 7169.068021157216, 7193.136823581203, 7196.820079497845, 7248.456365772694, 6785.219699734396, 6798.7620433286575, 6837.692303846239, 6842.521023528305, 6843.657817109224, 4932.3094766731965, 4982.377202849644, 4998.950010499849, 5010.949890501049, 5093.694378337312, 4200.264953633163, 4989.775460104376, 4990.50094990498, 5188.0661480933795, 5379.354477462573], "value": 4531.7821582075585, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.0770365644563, 300.7563873262657, 305.5706732041482, 307.8353081101611, 311.6602902835908, 5029.044481548508, 5081.28861959326, 5321.255024296597, 5403.648762830413, 5458.699771512565, 4334.8699539013805, 4892.681975671588, 5342.2253773202865, 5420.322459692538, 5441.966026454971, 3097.8141311521326, 3281.6226133994655, 3905.2970465316375, 4012.2176175645614, 4033.576474470168, 4001.5798341174195, 4031.810615868326, 4061.1268577255883, 4080.8571699990507, 4092.7953602319767, 3955.7626542407547, 3981.86063487778, 3994.4208089826957, 3994.820233089518, 4012.578679238667, 3621.492990981265, 3718.9628103718887, 3795.7722536647752, 3934.940975885364, 4029.415734718464, 3042.8326442045677, 3176.078937108236, 3484.5121682964404, 3488.5639295088113, 3505.9298814023578, 3880.3403421418425, 5042.1428357179, 5111.897762044739, 5137.922931156036, 5205.0, 4029.435878976946, 4092.6725861930972, 4597.9654577720075, 4624.959384138576, 4651.3023046543285, 5470.370907345667, 5565.6104072714925, 5643.407442218549, 5648.915266271009, 5686.857828554278, 3810.818646219681, 3819.3316169670475, 3824.7896365700153, 3827.9617203827884, 3831.7892515911612, 5408.972955135199, 5839.0949402842625, 5952.940470595282, 5961.837441698871, 5961.9864623013755, 2996.8501574921165, 3472.461768425898, 3855.383138697795, 3866.284737323604, 3867.5358956925347, 3940.9802950985636, 3944.2505923874373, 3944.526656801202, 3946.565877753445, 3951.209758048402, 4571.839985600488, 4604.7927843247135, 4608.631309495232, 4623.56076172763, 4629.444466664022, 4372.475302963665, 4856.434951145982, 5250.291210686585, 5315.840524784263, 5617.92136909338, 1309.8821106100497, 1326.7213885084047, 1326.8673132686847, 1327.1240980952525, 1330.1752913193882, 697.7418355208605, 824.2416976381743, 832.5712258187039, 834.6645367412092, 860.6084231674573, 4697.976510117427, 5070.518300761496, 5132.538071573502, 5133.512316329943, 5318.627696061239, 4352.891177720582, 4626.467956185082, 5244.606654500928, 5717.799877004285, 5785.669296061845, 4693.624510039189, 4979.950200497949, 5120.743962801845, 5254.581263058953, 5291.200991662853, 2527.2670925431785, 2769.0616568401797, 2999.2651800309063, 3015.427068856954, 3025.3949210158057, 4726.621870250372, 5216.347956505437, 5367.731613419313, 5913.940860591425, 6005.969970150209, 4884.975575122173, 5607.80372686954, 5765.85585360361, 5815.41845815415, 5915.201447804578, 4893.95106048942, 4934.3338649282605, 5267.841964741064, 5894.381089985575, 5966.31387390447, 4692.7888245029735, 5805.651660900359, 5820.76716931318, 5824.21373114641, 5829.0, 4858.63560232991, 5698.800541981011, 5700.828975130753, 5755.165501002248, 5904.996150654485, 5948.702564871653, 5973.970130149321, 5984.431479009487, 6017.909731354121, 6044.24446944132, 3537.646235376442, 3577.606463289088, 3630.2920930418313, 3756.0985363512013, 3845.2309538093054, 4822.758862056953, 5392.198500057529, 5608.663480191201, 5760.395158508296, 5767.9711601443405, 5594.524465420485, 5625.353084395347, 5641.464060914206, 5646.0, 5687.5449964001955, 5477.384171669447, 5591.30108736408, 5642.492175704042, 5663.7451314690115, 5742.454466825645, 5469.453054694499, 5497.725113744217, 5504.394516603251, 5512.944870551243, 5517.2551705519245, 5302.946970530245, 5496.378568322275, 5535.916961245665, 5572.749226284908, 5671.574631902541, 5031.698098114125, 5142.012248119468, 5433.836984890301, 5480.698561579152, 5576.553875689854], "value": 4045.4257428438436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7331000874675, 765.3647472597744, 773.5552057566898, 801.4069588504508, 810.1857633078757, 15211.0, 15359.078455292662, 15786.289616967235, 15802.446914357999, 15809.525714228563, 14185.361658725356, 14295.0, 14309.0, 14353.569392918203, 14361.784573231409, 661.9702113404896, 687.9656017199145, 691.194758106805, 822.7655118291289, 845.5053793530792, 839.1314988986401, 845.8646616541355, 847.4110493207223, 847.7838151271417, 848.6138806842872, 895.3374502867863, 898.6674930275807, 899.3030401438872, 901.1214066285385, 901.1304091551651, 695.3359541637724, 716.0262043620671, 722.3101937649585, 894.6197865906996, 896.2023798819056, 534.794104269855, 535.5528134008108, 535.7455208775839, 643.9710213040424, 660.7918505670698, 14779.113253204841, 14866.033707809065, 14866.479673211494, 14867.70264594702, 14890.627734306729, 13752.724945501033, 14002.299885005708, 14006.159630422208, 14122.152670839783, 14397.20815355155, 11097.778044439066, 11116.722081947935, 11545.884541154648, 11559.94220028903, 12999.545015924397, 4585.656075794295, 4600.217962946307, 4735.313379559944, 4786.425628924517, 4822.204336284509, 108402.3739643906, 108906.0, 111321.0, 112106.43946780213, 113292.0, 10582.153427725763, 10660.520276587573, 10681.145508359312, 10734.78530429387, 11083.113350932068, 20216.898915505328, 20231.4942126448, 20239.595208095754, 20240.98795060241, 20248.898755506423, 7603.0, 7757.069151701719, 7948.562829044458, 7977.60111994398, 7995.720149794729, 4362.10576831755, 4500.4149460569915, 4513.729176249435, 4612.884677883013, 4704.059188162381, 3465.2722928184858, 3619.040954147153, 3620.8551657933913, 3628.1836586768295, 3629.709623230135, 526.2369564132024, 656.4879394072631, 676.3878689785654, 681.802277339566, 683.1255992329826, 565.5108331293484, 587.5358466811257, 588.855730346068, 595.1816252652603, 630.6625955113992, 7702.345300649507, 8060.234277743605, 8637.654493820302, 9323.813523729488, 9526.0, 582.6416753696531, 595.312414161644, 626.1296797451546, 628.84593274648, 681.6591704147926, 4284.220484987328, 4542.659300552472, 4615.769211539409, 4660.0, 4739.099571081483, 103448.48275758573, 115470.0, 137769.3111534436, 171522.0, 175000.0, 124648.0, 143251.2837435827, 144751.5524844738, 147917.0, 154313.0, 88417.15828417106, 93790.0, 97488.0, 113964.0, 128610.0, 9476.573554190216, 9543.47510886908, 9675.419474831533, 9928.106470417697, 9940.701778946643, 60925.39074609197, 60940.39059609347, 61125.69437152786, 61571.692141539, 62261.0, 76083.61958190173, 76705.0, 79903.0, 90764.09235907557, 94009.58985615085, 13392.995525335444, 13402.530911418053, 13419.396127174105, 13684.043229498155, 13686.726265474435, 14848.0, 15074.623134421727, 15146.0, 15153.071144057481, 15294.77057844111, 13522.391492383063, 13795.931020345235, 13879.444822207402, 13907.443702251796, 14592.781108283596, 12452.688682783002, 13237.470501179845, 13719.725605487634, 13866.306684665524, 14166.858331416553, 13539.526116585872, 13547.322633868464, 13824.723505530033, 13842.100263482842, 14463.987520873437, 10982.176336774613, 11242.10063194926, 11551.595694150665, 11561.0, 11639.243449175776, 9134.177923986874, 11398.10827208267, 11427.885721143015, 11489.0, 11689.123315751183], "value": 7751.91320642558, "unit": "score"}], "name": "dromaeo_css", "value": 7253.953468040782, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 114.0, 150.0, 115.0, 115.0, 112.0, 113.0, 144.0, 113.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 183.0, 185.0, 185.0, 184.0, 182.0, 181.0, 183.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 99.0, 60.0, 60.0, 60.0, 59.0, 85.0, 60.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 97.0, 72.0, 68.0, 68.0, 91.0, 67.0, 69.0, 91.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 88.0, 89.0, 86.0, 94.0, 124.0, 90.0, 87.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 142.0, 96.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 94.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 87.0, 85.0, 86.0, 86.0, 87.0, 85.0, 86.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 54.0, 53.0, 55.0, 55.0, 56.0, 55.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 75.0, 73.0, 72.0, 70.0, 69.0, 71.0, 70.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 87.0, 90.0, 102.0, 105.0, 106.0, 93.0, 91.0, 90.0], "value": 94.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 154.0, 159.0, 164.0, 155.0, 153.0, 150.0, 212.0, 146.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 234.0, 195.0, 173.0, 173.0, 172.0, 170.0, 172.0, 173.0, 173.0], "value": 182.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1479.8000000000002, "alertThreshold": 2.0}]} 13:18:10 INFO - Return code: 0 13:18:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:18:10 INFO - # TBPL SUCCESS # 13:18:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:10 INFO - 2016-10-04 13:18:10.427 screenresolution[1954:12533] starting screenresolution argv=screenresolution get 13:18:10 INFO - 2016-10-04 13:18:10.430 screenresolution[1954:12533] Display 0: 1600x1200x32@60 13:18:10 INFO - 2016-10-04 13:18:10.436 screenresolution[1955:12536] starting screenresolution argv=screenresolution list 13:18:10 INFO - Available Modes on Display 0 13:18:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:10 INFO - Intel Iris: 13:18:10 INFO - Chipset Model: Intel Iris 13:18:10 INFO - Type: GPU 13:18:10 INFO - Bus: Built-In 13:18:10 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:10 INFO - Vendor: Intel (0x8086) 13:18:10 INFO - Device ID: 0x0a2e 13:18:10 INFO - Revision ID: 0x0009 13:18:10 INFO - Displays: 13:18:10 INFO - Display: 13:18:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:10 INFO - Display Serial Number: 1600x1200 60 13:18:10 INFO - Main Display: Yes 13:18:10 INFO - Mirror: Off 13:18:10 INFO - Online: Yes 13:18:10 INFO - Rotation: Supported 13:18:10 INFO - Return code: 0 13:18:10 INFO - Running post-action listener: _resource_record_post_action 13:18:10 INFO - [mozharness: 2016-10-04 20:18:10.679718Z] Finished run-tests step (success) 13:18:10 INFO - Running post-run listener: _resource_record_post_run 13:18:10 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 110592; Write bytes: 703877632; Read time: 5; Write time: 2034 13:18:10 INFO - TinderboxPrint: CPU usage
53.6% 13:18:10 INFO - TinderboxPrint: I/O read bytes / time
110,592 / 5 13:18:10 INFO - TinderboxPrint: I/O write bytes / time
703,877,632 / 2,034 13:18:10 INFO - TinderboxPrint: CPU idle
2,254.9 (46.4%) 13:18:10 INFO - TinderboxPrint: CPU system
977.7 (20.1%) 13:18:10 INFO - TinderboxPrint: CPU user
1,629.1 (33.5%) 13:18:10 INFO - TinderboxPrint: Swap in / out
407,314,432 / 0 13:18:10 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407947776; Write bytes: 409098240; Read time: 30830; Write time: 731 13:18:10 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 110592; Write bytes: 293390848; Read time: 5; Write time: 1295 13:18:11 INFO - Running post-run listener: _upload_blobber_files 13:18:11 INFO - Blob upload gear active. 13:18:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:18:11 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 13:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:18:11 INFO - (blobuploader) - INFO - Open directory for files ... 13:18:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:18:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:18:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:12 INFO - (blobuploader) - INFO - Done attempting. 13:18:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:18:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:18:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:14 INFO - (blobuploader) - INFO - Done attempting. 13:18:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:18:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:18:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:16 INFO - (blobuploader) - INFO - Done attempting. 13:18:16 INFO - (blobuploader) - INFO - Iteration through files over. 13:18:16 INFO - Return code: 0 13:18:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:18:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:18:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6698888c563af8fe6ac7676c83d5ad1164331d26f5b4e57b5a154044bf1f7efc8f69c860394af8d2b2a9a41d2737b55fbc88e45d72ad4f2c1441ac4fafeff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a90eb38122a7097698319ec62f2a5d4352161f6e9e3569b8be17be0b55cd5eb1451e072ee5220d6d7c8d0e5782b97b5c3ad68c615cf0fef5770e4a502fc53310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79ada34afafd3e0edac5c83ce1e188a90b1382c7d9f9f6cd643a0a5d2241837fae626f6beeefc6d9cc324fe16b976d5c1fae7ad7cac89857393946d1b2ff3c6b"} 13:18:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:18:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:18:16 INFO - Contents: 13:18:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6698888c563af8fe6ac7676c83d5ad1164331d26f5b4e57b5a154044bf1f7efc8f69c860394af8d2b2a9a41d2737b55fbc88e45d72ad4f2c1441ac4fafeff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a90eb38122a7097698319ec62f2a5d4352161f6e9e3569b8be17be0b55cd5eb1451e072ee5220d6d7c8d0e5782b97b5c3ad68c615cf0fef5770e4a502fc53310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79ada34afafd3e0edac5c83ce1e188a90b1382c7d9f9f6cd643a0a5d2241837fae626f6beeefc6d9cc324fe16b976d5c1fae7ad7cac89857393946d1b2ff3c6b"} 13:18:16 INFO - Running post-run listener: copy_logs_to_upload_dir 13:18:16 INFO - Copying logs to upload dir... 13:18:16 INFO - mkdir: /builds/slave/test/build/upload/logs 13:18:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.152487 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 13:18:16.564416) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 13:18:16.568423) ========= 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.yTqPvRM850/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.QqQFTBGZU4/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6698888c563af8fe6ac7676c83d5ad1164331d26f5b4e57b5a154044bf1f7efc8f69c860394af8d2b2a9a41d2737b55fbc88e45d72ad4f2c1441ac4fafeff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a90eb38122a7097698319ec62f2a5d4352161f6e9e3569b8be17be0b55cd5eb1451e072ee5220d6d7c8d0e5782b97b5c3ad68c615cf0fef5770e4a502fc53310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79ada34afafd3e0edac5c83ce1e188a90b1382c7d9f9f6cd643a0a5d2241837fae626f6beeefc6d9cc324fe16b976d5c1fae7ad7cac89857393946d1b2ff3c6b"} build_url:https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/Kliean0ySsGwSJtOs_2JfQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6698888c563af8fe6ac7676c83d5ad1164331d26f5b4e57b5a154044bf1f7efc8f69c860394af8d2b2a9a41d2737b55fbc88e45d72ad4f2c1441ac4fafeff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a90eb38122a7097698319ec62f2a5d4352161f6e9e3569b8be17be0b55cd5eb1451e072ee5220d6d7c8d0e5782b97b5c3ad68c615cf0fef5770e4a502fc53310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/79ada34afafd3e0edac5c83ce1e188a90b1382c7d9f9f6cd643a0a5d2241837fae626f6beeefc6d9cc324fe16b976d5c1fae7ad7cac89857393946d1b2ff3c6b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 13:18:16.601326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 13:18:16.601714) ========= 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.yTqPvRM850/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.QqQFTBGZU4/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005166 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 13:18:16.651151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 13:18:16.651491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 13:18:16.651874) ========= ========= Total master_lag: 0.18 =========