builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0355 starttime: 1476781259.5 results: success (0) buildid: 20161018003248 builduid: 557e42379cdf4759843445baedac7f82 revision: a879c89b5446b9699b6765fa05f1fc1a8d8d989f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 02:00:59.504034) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 02:00:59.504611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 02:00:59.504888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 02:00:59.756475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 02:00:59.756723) ========= 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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-18 02:00: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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.0M=0.001s 2016-10-18 02:01:00 (23.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.499275 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:00.327355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:00.327622) ========= 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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027587 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:00.450927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 02:01:00.451224) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a879c89b5446b9699b6765fa05f1fc1a8d8d989f --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 a879c89b5446b9699b6765fa05f1fc1a8d8d989f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-18 02:01:00,670 truncating revision to first 12 chars 2016-10-18 02:01:00,670 Setting DEBUG logging. 2016-10-18 02:01:00,670 attempt 1/10 2016-10-18 02:01:00,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a879c89b5446?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 02:01:01,440 unpacking tar archive at: autoland-a879c89b5446/testing/mozharness/ program finished with exit code 0 elapsedTime=1.057164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 02:01:01.531766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:01.532190) ========= script_repo_revision: a879c89b5446b9699b6765fa05f1fc1a8d8d989f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:01.532755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:01.533167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 02:01:01.551591) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-18 02:01:01.552240) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:01:01 INFO - MultiFileLogger online at 20161018 02:01:01 in /builds/slave/test 02:01:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 02:01:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:01 INFO - {'append_to_log': False, 02:01:01 INFO - 'base_work_dir': '/builds/slave/test', 02:01:01 INFO - 'blob_upload_branch': 'Autoland', 02:01:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:01 INFO - 'branch': 'Autoland', 02:01:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:01 INFO - 'config_files': ('talos/mac_config.py',), 02:01:01 INFO - 'default_actions': ('clobber', 02:01:01 INFO - 'read-buildbot-config', 02:01:01 INFO - 'download-and-extract', 02:01:01 INFO - 'populate-webroot', 02:01:01 INFO - 'create-virtualenv', 02:01:01 INFO - 'install', 02:01:01 INFO - 'run-tests'), 02:01:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:01 INFO - 'download_minidump_stackwalk': True, 02:01:01 INFO - 'download_symbols': 'ondemand', 02:01:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:01 INFO - 'installer_path': 'installer.exe', 02:01:01 INFO - 'log_level': 'info', 02:01:01 INFO - 'log_name': 'talos', 02:01:01 INFO - 'log_to_console': True, 02:01:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:01 INFO - 'opt_config_files': (), 02:01:01 INFO - 'pip_index': False, 02:01:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:01 INFO - 'cmd': ('bash', 02:01:01 INFO - '-c', 02:01:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:01 INFO - 'enabled': True, 02:01:01 INFO - 'halt_on_failure': False, 02:01:01 INFO - 'name': 'check_screen_resolution'},), 02:01:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:01 INFO - 'cmd': ('bash', 02:01:01 INFO - '-c', 02:01:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:01 INFO - 'enabled': True, 02:01:01 INFO - 'halt_on_failure': False, 02:01:01 INFO - 'name': 'check_screen_resolution'},), 02:01:01 INFO - 'run_cmd_checks_enabled': True, 02:01:01 INFO - 'sps_profile': False, 02:01:01 INFO - 'sps_profile_interval': 0, 02:01:01 INFO - 'suite': 'dromaeojs-e10s', 02:01:01 INFO - 'system_bits': '32', 02:01:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:01 INFO - 'title': 't-yosemite-r7-0355', 02:01:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:01 INFO - 'use_talos_json': True, 02:01:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:01 INFO - 'work_dir': 'build'} 02:01:01 INFO - [mozharness: 2016-10-18 09:01:01.895139Z] Running clobber step. 02:01:01 INFO - Running pre-action listener: _resource_record_pre_action 02:01:01 INFO - Running main action method: clobber 02:01:01 INFO - rmtree: /builds/slave/test/build 02:01:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:03 INFO - Running post-action listener: _resource_record_post_action 02:01:03 INFO - [mozharness: 2016-10-18 09:01:03.908315Z] Finished clobber step (success) 02:01:03 INFO - [mozharness: 2016-10-18 09:01:03.908480Z] Running read-buildbot-config step. 02:01:03 INFO - Running pre-action listener: _resource_record_pre_action 02:01:03 INFO - Running main action method: read_buildbot_config 02:01:03 INFO - Using buildbot properties: 02:01:03 INFO - { 02:01:03 INFO - "project": "", 02:01:03 INFO - "product": "firefox", 02:01:03 INFO - "script_repo_revision": "production", 02:01:03 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 02:01:03 INFO - "repository": "", 02:01:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 02:01:03 INFO - "buildid": "20161018003248", 02:01:03 INFO - "pgo_build": "False", 02:01:03 INFO - "basedir": "/builds/slave/test", 02:01:03 INFO - "buildnumber": 217, 02:01:03 INFO - "slavename": "t-yosemite-r7-0355", 02:01:03 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:01:03 INFO - "platform": "yosemite_r7", 02:01:03 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 02:01:03 INFO - "branch": "autoland", 02:01:03 INFO - "repo_path": "integration/autoland", 02:01:03 INFO - "revision": "a879c89b5446b9699b6765fa05f1fc1a8d8d989f", 02:01:03 INFO - "stage_platform": "macosx64", 02:01:03 INFO - "builduid": "557e42379cdf4759843445baedac7f82", 02:01:03 INFO - "slavebuilddir": "test" 02:01:03 INFO - } 02:01:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 02:01:03 INFO - Running post-action listener: _resource_record_post_action 02:01:03 INFO - [mozharness: 2016-10-18 09:01:03.912047Z] Finished read-buildbot-config step (success) 02:01:03 INFO - [mozharness: 2016-10-18 09:01:03.912157Z] Running download-and-extract step. 02:01:03 INFO - Running pre-action listener: _resource_record_pre_action 02:01:03 INFO - Running main action method: download_and_extract 02:01:03 INFO - mkdir: /builds/slave/test/build/tests 02:01:03 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')]} 02:01:03 INFO - trying https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 02:01:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/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 02:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/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 02:01:05 INFO - Downloaded 1199 bytes. 02:01:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 02:01:05 INFO - Using the following test package requirements: 02:01:05 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 02:01:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 02:01:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 02:01:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'jsshell-mac.zip'], 02:01:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 02:01:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 02:01:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 02:01:05 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 02:01:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 02:01:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:01:05 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 02:01:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:01:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 02:01:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:01:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 02:01:05 INFO - Http code: 200 02:01:05 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 02:01:05 INFO - x-amz-cf-id: etnm2fl2pOcPt-5CMViy37_5_KEulYiLY_dJtPCKRQJeehFPVIsfkA== 02:01:05 INFO - x-amz-version-id: FQjlWmRBstNN1Vj4q2ztMKqrsA2VkkvO 02:01:06 INFO - Expected file size: 16483841 02:01:06 INFO - Obtained file size: 16483841 02:01:12 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 02:01:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 02:01:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:01:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 02:01:13 INFO - Http code: 200 02:01:13 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 02:01:13 INFO - x-amz-cf-id: Js9dzGJeRG7vHzQscWxSmoTqdr3FveRksgejo5m-IWO51_-mlDQ1DA== 02:01:13 INFO - x-amz-version-id: FQjlWmRBstNN1Vj4q2ztMKqrsA2VkkvO 02:01:13 INFO - Expected file size: 16483841 02:01:13 INFO - Obtained file size: 16483841 02:01:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 02:01:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:01:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 02:01:20 INFO - Http code: 200 02:01:20 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 02:01:20 INFO - x-amz-cf-id: m9MDKjx8nUCP6wTTJ-2JH2wuMEEBg2UUyMGRY7XNHTSSQdIeWWBGFg== 02:01:20 INFO - x-amz-version-id: lj51RNUXdC17VW9XSokHgDy_mZKuCVzl 02:01:21 INFO - Expected file size: 14409028 02:01:21 INFO - Obtained file size: 14409028 02:01:21 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')]} 02:01:21 INFO - trying https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 02:01:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 02:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/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 02:01:24 INFO - Downloaded 111638583 bytes. 02:01:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 02:01:24 INFO - mkdir: /builds/slave/test/properties 02:01:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:24 INFO - Contents: 02:01:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 02:01:24 INFO - Running post-action listener: _resource_record_post_action 02:01:24 INFO - Running post-action listener: set_extra_try_arguments 02:01:24 INFO - [mozharness: 2016-10-18 09:01:24.981602Z] Finished download-and-extract step (success) 02:01:24 INFO - [mozharness: 2016-10-18 09:01:24.981727Z] Running populate-webroot step. 02:01:24 INFO - Running pre-action listener: _resource_record_pre_action 02:01:24 INFO - Running main action method: populate_webroot 02:01:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:24 INFO - '--tppagecycles', 02:01:24 INFO - '7'], 02:01:24 INFO - 'tests': ['tsvgm']}}, 02:01:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:01:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:01:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['damp', 'tps']}, 02:01:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'tests': ['damp', 'tps']}, 02:01:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['dromaeo_dom']}, 02:01:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:01:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['basic_compositor_video']}, 02:01:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:01:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['a11yr', 02:01:24 INFO - 'ts_paint', 02:01:24 INFO - 'tpaint', 02:01:24 INFO - 'sessionrestore', 02:01:24 INFO - 'sessionrestore_no_auto_restore', 02:01:24 INFO - 'tabpaint']}, 02:01:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:01:24 INFO - 'ts_paint', 02:01:24 INFO - 'tpaint', 02:01:24 INFO - 'sessionrestore', 02:01:24 INFO - 'sessionrestore_no_auto_restore', 02:01:24 INFO - 'tabpaint']}, 02:01:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:01:24 INFO - 'ts_paint', 02:01:24 INFO - 'tpaint', 02:01:24 INFO - 'sessionrestore', 02:01:24 INFO - 'sessionrestore_no_auto_restore', 02:01:24 INFO - 'tabpaint']}, 02:01:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:01:24 INFO - 'ts_paint', 02:01:24 INFO - 'tpaint', 02:01:24 INFO - 'sessionrestore', 02:01:24 INFO - 'sessionrestore_no_auto_restore', 02:01:24 INFO - 'tabpaint']}, 02:01:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['a11yr', 02:01:24 INFO - 'ts_paint', 02:01:24 INFO - 'tpaint', 02:01:24 INFO - 'sessionrestore', 02:01:24 INFO - 'sessionrestore_no_auto_restore', 02:01:24 INFO - 'tabpaint']}, 02:01:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['a11yr', 02:01:24 INFO - 'ts_paint', 02:01:24 INFO - 'tpaint', 02:01:24 INFO - 'sessionrestore', 02:01:24 INFO - 'sessionrestore_no_auto_restore', 02:01:24 INFO - 'tabpaint']}, 02:01:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['tsvgx', 02:01:24 INFO - 'tsvgr_opacity', 02:01:24 INFO - 'tart', 02:01:24 INFO - 'tscrollx', 02:01:24 INFO - 'cart']}, 02:01:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:01:24 INFO - 'tsvgr_opacity', 02:01:24 INFO - 'tart', 02:01:24 INFO - 'tscrollx', 02:01:24 INFO - 'cart']}, 02:01:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'talos_options': ['--disable-e10s'], 02:01:24 INFO - 'tests': ['tp5o']}, 02:01:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'tests': ['tp5o']}, 02:01:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:24 INFO - 'talos_options': ['--disable-e10s', 02:01:24 INFO - '--xperf_path', 02:01:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:25 INFO - 'tests': ['tp5n']}, 02:01:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:25 INFO - 'talos_options': ['--xperf_path', 02:01:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:25 INFO - 'tests': ['tp5n']}}, 02:01:25 INFO - 'talos.zip': {'path': '', 02:01:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:25 INFO - Running post-action listener: _resource_record_post_action 02:01:25 INFO - [mozharness: 2016-10-18 09:01:25.001117Z] Finished populate-webroot step (success) 02:01:25 INFO - [mozharness: 2016-10-18 09:01:25.001232Z] Running create-virtualenv step. 02:01:25 INFO - Running pre-action listener: _resource_record_pre_action 02:01:25 INFO - Running main action method: create_virtualenv 02:01:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:25 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 02:01:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:25 INFO - Using real prefix '/tools/python27' 02:01:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:28 INFO - Installing pip.................done. 02:01:28 INFO - Return code: 0 02:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:01:29 INFO - Reading from file tmpfile_stdout 02:01:29 INFO - Output received: 02:01:29 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) 02:01:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:29 INFO - 'HOME': '/Users/cltbld', 02:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:29 INFO - 'LOGNAME': 'cltbld', 02:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:29 INFO - 'MOZ_NO_REMOTE': '1', 02:01:29 INFO - 'NO_EM_RESTART': '1', 02:01:29 INFO - 'PAGER': '/bin/cat', 02:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:29 INFO - 'PWD': '/builds/slave/test', 02:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:29 INFO - 'SHELL': '/bin/bash', 02:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:29 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:29 INFO - 'USER': 'cltbld', 02:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:29 INFO - 'XPC_FLAGS': '0x0', 02:01:29 INFO - 'XPC_SERVICE_NAME': '0', 02:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:29 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 02:01:29 INFO - Cleaning up... 02:01:29 INFO - Return code: 0 02:01:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:29 INFO - 'HOME': '/Users/cltbld', 02:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:29 INFO - 'LOGNAME': 'cltbld', 02:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:29 INFO - 'MOZ_NO_REMOTE': '1', 02:01:29 INFO - 'NO_EM_RESTART': '1', 02:01:29 INFO - 'PAGER': '/bin/cat', 02:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:29 INFO - 'PWD': '/builds/slave/test', 02:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:29 INFO - 'SHELL': '/bin/bash', 02:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:29 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:29 INFO - 'USER': 'cltbld', 02:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:29 INFO - 'XPC_FLAGS': '0x0', 02:01:29 INFO - 'XPC_SERVICE_NAME': '0', 02:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:29 INFO - Downloading/unpacking psutil>=3.1.1 02:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:33 INFO - Installing collected packages: psutil 02:01:33 INFO - Running setup.py install for psutil 02:01:33 INFO - building 'psutil._psutil_osx' extension 02:01:33 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 02:01:34 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 02:01:34 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 02:01:34 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 02:01:34 INFO - building 'psutil._psutil_posix' extension 02:01:34 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 02:01:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:01:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:01:34 INFO - ^ 02:01:34 INFO - 1 warning generated. 02:01:34 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 02:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:34 INFO - Successfully installed psutil 02:01:34 INFO - Cleaning up... 02:01:34 INFO - Return code: 0 02:01:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:34 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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:34 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 02:01:34 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 02:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:34 INFO - 'HOME': '/Users/cltbld', 02:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:34 INFO - 'LOGNAME': 'cltbld', 02:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:34 INFO - 'MOZ_NO_REMOTE': '1', 02:01:34 INFO - 'NO_EM_RESTART': '1', 02:01:34 INFO - 'PAGER': '/bin/cat', 02:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:34 INFO - 'PWD': '/builds/slave/test', 02:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:34 INFO - 'SHELL': '/bin/bash', 02:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:34 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:34 INFO - 'USER': 'cltbld', 02:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:34 INFO - 'XPC_FLAGS': '0x0', 02:01:34 INFO - 'XPC_SERVICE_NAME': '0', 02:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:34 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 02:01:34 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 02:01:34 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 02:01:34 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 02:01:34 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 02:01:34 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 02:01:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:37 INFO - Installing collected packages: mozsystemmonitor 02:01:37 INFO - Running setup.py install for mozsystemmonitor 02:01:37 INFO - Successfully installed mozsystemmonitor 02:01:37 INFO - Cleaning up... 02:01:37 INFO - Return code: 0 02:01:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:01:37 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')]} 02:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:37 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')]} 02:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:37 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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:37 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 02:01:37 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 02:01:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:37 INFO - 'HOME': '/Users/cltbld', 02:01:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:37 INFO - 'LOGNAME': 'cltbld', 02:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:37 INFO - 'MOZ_NO_REMOTE': '1', 02:01:37 INFO - 'NO_EM_RESTART': '1', 02:01:37 INFO - 'PAGER': '/bin/cat', 02:01:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:37 INFO - 'PWD': '/builds/slave/test', 02:01:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:37 INFO - 'SHELL': '/bin/bash', 02:01:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:37 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:37 INFO - 'USER': 'cltbld', 02:01:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:37 INFO - 'XPC_FLAGS': '0x0', 02:01:37 INFO - 'XPC_SERVICE_NAME': '0', 02:01:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:37 INFO - Downloading/unpacking jsonschema==2.5.1 02:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:01:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:40 INFO - Downloading functools32-3.2.3-2.tar.gz 02:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:01:40 INFO - warning: no files found matching '*.txt' 02:01:40 INFO - no previously-included directories found matching 'build' 02:01:40 INFO - no previously-included directories found matching 'dist' 02:01:40 INFO - no previously-included directories found matching '.git*' 02:01:40 INFO - Installing collected packages: jsonschema, functools32 02:01:40 INFO - Running setup.py install for functools32 02:01:41 INFO - warning: no files found matching '*.txt' 02:01:41 INFO - no previously-included directories found matching 'build' 02:01:41 INFO - no previously-included directories found matching 'dist' 02:01:41 INFO - no previously-included directories found matching '.git*' 02:01:41 INFO - Successfully installed jsonschema functools32 02:01:41 INFO - Cleaning up... 02:01:41 INFO - Return code: 0 02:01:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:01:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:41 INFO - 'HOME': '/Users/cltbld', 02:01:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:41 INFO - 'LOGNAME': 'cltbld', 02:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:41 INFO - 'MOZ_NO_REMOTE': '1', 02:01:41 INFO - 'NO_EM_RESTART': '1', 02:01:41 INFO - 'PAGER': '/bin/cat', 02:01:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:41 INFO - 'PWD': '/builds/slave/test', 02:01:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:41 INFO - 'SHELL': '/bin/bash', 02:01:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:41 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:41 INFO - 'USER': 'cltbld', 02:01:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:41 INFO - 'XPC_FLAGS': '0x0', 02:01:41 INFO - 'XPC_SERVICE_NAME': '0', 02:01:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:01:41 INFO - Cleaning up... 02:01:41 INFO - Return code: 0 02:01:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:01:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:41 INFO - 'HOME': '/Users/cltbld', 02:01:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:41 INFO - 'LOGNAME': 'cltbld', 02:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:41 INFO - 'MOZ_NO_REMOTE': '1', 02:01:41 INFO - 'NO_EM_RESTART': '1', 02:01:41 INFO - 'PAGER': '/bin/cat', 02:01:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:41 INFO - 'PWD': '/builds/slave/test', 02:01:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:41 INFO - 'SHELL': '/bin/bash', 02:01:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:41 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:41 INFO - 'USER': 'cltbld', 02:01:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:41 INFO - 'XPC_FLAGS': '0x0', 02:01:41 INFO - 'XPC_SERVICE_NAME': '0', 02:01:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:44 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 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 02:01:44 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 02:01:45 INFO - Downloading docopt-0.6.1.tar.gz 02:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:45 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:45 INFO - Running setup.py install for blobuploader 02:01:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:45 INFO - Running setup.py install for requests 02:01:46 INFO - Running setup.py install for docopt 02:01:46 INFO - Successfully installed blobuploader requests docopt 02:01:46 INFO - Cleaning up... 02:01:46 INFO - Return code: 0 02:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:46 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 02:01:46 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 02:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:46 INFO - 'HOME': '/Users/cltbld', 02:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:46 INFO - 'LOGNAME': 'cltbld', 02:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:46 INFO - 'MOZ_NO_REMOTE': '1', 02:01:46 INFO - 'NO_EM_RESTART': '1', 02:01:46 INFO - 'PAGER': '/bin/cat', 02:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:46 INFO - 'PWD': '/builds/slave/test', 02:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:46 INFO - 'SHELL': '/bin/bash', 02:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:46 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:46 INFO - 'USER': 'cltbld', 02:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:46 INFO - 'XPC_FLAGS': '0x0', 02:01:46 INFO - 'XPC_SERVICE_NAME': '0', 02:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:46 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-_7oEst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:46 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-HLubk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:46 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-LXPkmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-jRpwVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-cvDp7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-tv6OVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-O0Ofwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-_8oPm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-D_REwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-3zNShc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-MDyB1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-dRFNL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:47 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-2_5XtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:48 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-_DgXzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:48 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-bg0YUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:48 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-hHIQ_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:48 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-3iAHDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:48 INFO - Running setup.py install for manifestparser 02:01:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:48 INFO - Running setup.py install for mozcrash 02:01:48 INFO - Running setup.py install for mozdebug 02:01:48 INFO - Running setup.py install for mozdevice 02:01:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Running setup.py install for mozfile 02:01:49 INFO - Running setup.py install for mozhttpd 02:01:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Running setup.py install for mozinfo 02:01:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Running setup.py install for mozInstall 02:01:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Running setup.py install for mozleak 02:01:49 INFO - Running setup.py install for mozlog 02:01:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:49 INFO - Running setup.py install for moznetwork 02:01:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:50 INFO - Running setup.py install for mozprocess 02:01:50 INFO - Running setup.py install for mozprofile 02:01:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:50 INFO - Running setup.py install for mozrunner 02:01:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:50 INFO - Running setup.py install for mozscreenshot 02:01:50 INFO - Running setup.py install for moztest 02:01:50 INFO - Running setup.py install for mozversion 02:01:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:01:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:01:51 INFO - Cleaning up... 02:01:51 INFO - Return code: 0 02:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:51 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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:51 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 02:01:51 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 02:01:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:51 INFO - 'HOME': '/Users/cltbld', 02:01:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:51 INFO - 'LOGNAME': 'cltbld', 02:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:51 INFO - 'MOZ_NO_REMOTE': '1', 02:01:51 INFO - 'NO_EM_RESTART': '1', 02:01:51 INFO - 'PAGER': '/bin/cat', 02:01:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:51 INFO - 'PWD': '/builds/slave/test', 02:01:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:51 INFO - 'SHELL': '/bin/bash', 02:01:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:51 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:51 INFO - 'USER': 'cltbld', 02:01:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:51 INFO - 'XPC_FLAGS': '0x0', 02:01:51 INFO - 'XPC_SERVICE_NAME': '0', 02:01:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-EHkdoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:51 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)) 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-py6_i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:51 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)) 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Jc0uPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:51 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)) 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-xKpwRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:51 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)) 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-kV_mSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:51 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)) 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-aKMkRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:51 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)) 02:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:51 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-MozrBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-rOlYSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Tg6XUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-aZYqyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-O1RBRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-BiW1jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-lObjRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-w0MDIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-FobBlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:52 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)) 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:52 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-o9q3aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:53 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)) 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:53 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-lJ5eVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:53 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)) 02:01:53 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)) 02:01:53 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)) 02:01:53 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)) 02:01:53 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)) 02:01:53 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)) 02:01:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:01:53 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 02:01:53 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 02:01:53 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 02:01:53 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 02:01:53 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 02:01:53 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 02:01:55 INFO - Downloading blessings-1.6.tar.gz 02:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:01:55 INFO - Installing collected packages: blessings 02:01:55 INFO - Running setup.py install for blessings 02:01:55 INFO - Successfully installed blessings 02:01:55 INFO - Cleaning up... 02:01:56 INFO - Return code: 0 02:01:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:56 INFO - Reading from file tmpfile_stdout 02:01:56 INFO - Current package versions: 02:01:56 INFO - blessings == 1.6 02:01:56 INFO - blobuploader == 1.2.4 02:01:56 INFO - docopt == 0.6.1 02:01:56 INFO - functools32 == 3.2.3-2 02:01:56 INFO - jsonschema == 2.5.1 02:01:56 INFO - manifestparser == 1.1 02:01:56 INFO - mozInstall == 1.12 02:01:56 INFO - mozcrash == 0.17 02:01:56 INFO - mozdebug == 0.1 02:01:56 INFO - mozdevice == 0.48 02:01:56 INFO - mozfile == 1.2 02:01:56 INFO - mozhttpd == 0.7 02:01:56 INFO - mozinfo == 0.9 02:01:56 INFO - mozleak == 0.1 02:01:56 INFO - mozlog == 3.4 02:01:56 INFO - moznetwork == 0.27 02:01:56 INFO - mozprocess == 0.23 02:01:56 INFO - mozprofile == 0.28 02:01:56 INFO - mozrunner == 6.12 02:01:56 INFO - mozscreenshot == 0.1 02:01:56 INFO - mozsystemmonitor == 0.3 02:01:56 INFO - moztest == 0.7 02:01:56 INFO - mozversion == 1.4 02:01:56 INFO - psutil == 3.1.1 02:01:56 INFO - requests == 1.2.3 02:01:56 INFO - wsgiref == 0.1.2 02:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:56 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')]} 02:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:56 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')]} 02:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:56 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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:56 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 02:01:56 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 02:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:56 INFO - 'HOME': '/Users/cltbld', 02:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:56 INFO - 'LOGNAME': 'cltbld', 02:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:56 INFO - 'MOZ_NO_REMOTE': '1', 02:01:56 INFO - 'NO_EM_RESTART': '1', 02:01:56 INFO - 'PAGER': '/bin/cat', 02:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:56 INFO - 'PWD': '/builds/slave/test', 02:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:56 INFO - 'SHELL': '/bin/bash', 02:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:56 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:56 INFO - 'USER': 'cltbld', 02:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:56 INFO - 'XPC_FLAGS': '0x0', 02:01:56 INFO - 'XPC_SERVICE_NAME': '0', 02:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 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)) 02:01:56 INFO - Cleaning up... 02:01:56 INFO - Return code: 0 02:01:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:01:56 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')]} 02:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:56 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')]} 02:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:56 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 0x1008d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad15535e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:56 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 02:01:56 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 02:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:56 INFO - 'HOME': '/Users/cltbld', 02:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:56 INFO - 'LOGNAME': 'cltbld', 02:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:56 INFO - 'MOZ_NO_REMOTE': '1', 02:01:56 INFO - 'NO_EM_RESTART': '1', 02:01:56 INFO - 'PAGER': '/bin/cat', 02:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:56 INFO - 'PWD': '/builds/slave/test', 02:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:56 INFO - 'SHELL': '/bin/bash', 02:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:01:56 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:56 INFO - 'USER': 'cltbld', 02:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:56 INFO - 'XPC_FLAGS': '0x0', 02:01:56 INFO - 'XPC_SERVICE_NAME': '0', 02:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:01:56 INFO - Cleaning up... 02:01:56 INFO - Return code: 0 02:01:56 INFO - Running post-action listener: _resource_record_post_action 02:01:56 INFO - Running post-action listener: _start_resource_monitoring 02:01:56 INFO - Starting resource monitoring. 02:01:56 INFO - [mozharness: 2016-10-18 09:01:56.863732Z] Finished create-virtualenv step (success) 02:01:56 INFO - [mozharness: 2016-10-18 09:01:56.864720Z] Running install step. 02:01:56 INFO - Running pre-action listener: _resource_record_pre_action 02:01:56 INFO - Running main action method: install 02:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:57 INFO - Reading from file tmpfile_stdout 02:01:57 INFO - Detecting whether we're running mozinstall >=1.0... 02:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:01:57 INFO - Reading from file tmpfile_stdout 02:01:57 INFO - Output received: 02:01:57 INFO - Usage: mozinstall [options] installer 02:01:57 INFO - Options: 02:01:57 INFO - -h, --help show this help message and exit 02:01:57 INFO - -d DEST, --destination=DEST 02:01:57 INFO - Directory to install application into. [default: 02:01:57 INFO - "/builds/slave/test"] 02:01:57 INFO - --app=APP Application being installed. [default: firefox] 02:01:57 INFO - mkdir: /builds/slave/test/build/application 02:01:57 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'] 02:01:57 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 02:02:31 INFO - Reading from file tmpfile_stdout 02:02:31 INFO - Output received: 02:02:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:02:31 INFO - Running post-action listener: _resource_record_post_action 02:02:31 INFO - [mozharness: 2016-10-18 09:02:31.532492Z] Finished install step (success) 02:02:31 INFO - [mozharness: 2016-10-18 09:02:31.532628Z] Running run-tests step. 02:02:31 INFO - Running pre-action listener: _resource_record_pre_action 02:02:31 INFO - Running main action method: run_tests 02:02:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:31 INFO - 2016-10-18 02:02:31.547 screenresolution[1651:9496] starting screenresolution argv=screenresolution get 02:02:31 INFO - 2016-10-18 02:02:31.550 screenresolution[1651:9496] Display 0: 1600x1200x32@60 02:02:31 INFO - 2016-10-18 02:02:31.555 screenresolution[1652:9498] starting screenresolution argv=screenresolution list 02:02:31 INFO - Available Modes on Display 0 02:02:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:31 INFO - Intel Iris: 02:02:31 INFO - Chipset Model: Intel Iris 02:02:31 INFO - Type: GPU 02:02:31 INFO - Bus: Built-In 02:02:31 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:31 INFO - Vendor: Intel (0x8086) 02:02:31 INFO - Device ID: 0x0a2e 02:02:31 INFO - Revision ID: 0x0009 02:02:31 INFO - Displays: 02:02:31 INFO - Display: 02:02:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:31 INFO - Display Serial Number: 1600x1200 60 02:02:31 INFO - Main Display: Yes 02:02:31 INFO - Mirror: Off 02:02:31 INFO - Online: Yes 02:02:31 INFO - Rotation: Supported 02:02:31 INFO - Return code: 0 02:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:31 INFO - Python 2.7.3 02:02:31 INFO - Return code: 0 02:02:31 INFO - grabbing minidump binary from tooltool 02:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9d30>, '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 0x10050fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:02:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:02:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:02:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:31 INFO - Return code: 0 02:02:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:02:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:02:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0355 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P3NQlZ32Zo/Render', 02:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:31 INFO - 'HOME': '/Users/cltbld', 02:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:31 INFO - 'LOGNAME': 'cltbld', 02:02:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:31 INFO - 'MOZ_NO_REMOTE': '1', 02:02:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:31 INFO - 'NO_EM_RESTART': '1', 02:02:31 INFO - 'PAGER': '/bin/cat', 02:02:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:31 INFO - 'PWD': '/builds/slave/test', 02:02:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:31 INFO - 'SHELL': '/bin/bash', 02:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVJ7Ahx7oi/Listeners', 02:02:31 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 02:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:31 INFO - 'USER': 'cltbld', 02:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:31 INFO - 'XPC_FLAGS': '0x0', 02:02:31 INFO - 'XPC_SERVICE_NAME': '0', 02:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:02:32 INFO - mozversion application_buildid: 20161018003248 02:02:32 INFO - mozversion application_changeset: a879c89b5446b9699b6765fa05f1fc1a8d8d989f 02:02:32 INFO - mozversion application_display_name: Nightly 02:02:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:32 INFO - mozversion application_name: Firefox 02:02:32 INFO - mozversion application_remotingname: firefox 02:02:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:02:32 INFO - mozversion application_vendor: Mozilla 02:02:32 INFO - mozversion application_version: 52.0a1 02:02:32 INFO - mozversion platform_buildid: 20161018003248 02:02:32 INFO - mozversion platform_changeset: a879c89b5446b9699b6765fa05f1fc1a8d8d989f 02:02:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:02:32 INFO - mozversion platform_version: 52.0a1 02:02:32 INFO - using testdate: 1476781352 02:02:32 INFO - actual date: 1476781352 02:02:32 INFO - starting webserver on 'localhost:49267' 02:02:32 INFO - SUITE-START | Running 2 tests 02:02:32 INFO - TEST-START | dromaeo_css 02:02:32 INFO - operating with platform_type : mac_ 02:02:32 INFO - Initialising browser for dromaeo_css test... 02:02:32 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpJwTYJL/profile http://localhost:49267/getInfo.html) 02:02:34 INFO - PROCESS | 1662 | 2016-10-18 02:02:34.965 plugin-container[1664:9669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 02:02:34 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:34 INFO - PROCESS | 1662 | 2016-10-18 02:02:34.968 plugin-container[1664:9669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 02:02:34 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:34 INFO - PROCESS | 1662 | 2016-10-18 02:02:34.968 plugin-container[1664:9669] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:02:35 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 02:02:35 INFO - PROCESS | 1662 | colorDepth:24 02:02:35 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 02:02:35 INFO - PROCESS | 1662 | __metrics 02:02:35 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 02:02:35 INFO - TEST-INFO | 1662: exit 0 02:02:35 INFO - Browser initialized. 02:02:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:02:35 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpJwTYJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:38 INFO - PROCESS | 1666 | 2016-10-18 02:02:38.297 plugin-container[1667:9793] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 02:02:38 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:38 INFO - PROCESS | 1666 | 2016-10-18 02:02:38.298 plugin-container[1667:9793] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 02:02:38 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:02:38 INFO - PROCESS | 1666 | 2016-10-18 02:02:38.298 plugin-container[1667:9793] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:02:48 INFO - PROCESS | 1666 | RSS: Main: 236863488 02:02:48 INFO - PROCESS | 1666 | 02:03:37 INFO - PROCESS | 1666 | 1476781417650 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] 02:05:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 02:05:53 INFO - PROCESS | 1666 | RSS: Main: 249630720 02:05:53 INFO - PROCESS | 1666 | 02:08:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 02:08:56 INFO - PROCESS | 1666 | RSS: Main: 264663040 02:08:56 INFO - PROCESS | 1666 | 02:11:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 02:11:58 INFO - PROCESS | 1666 | RSS: Main: 269443072 02:11:58 INFO - PROCESS | 1666 | 02:15:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 02:15:01 INFO - PROCESS | 1666 | RSS: Main: 269242368 02:15:01 INFO - PROCESS | 1666 | 02:18:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 02:18:04 INFO - PROCESS | 1666 | RSS: Main: 274763776 02:18:04 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 02:21:07 INFO - PROCESS | 1666 | RSS: Main: 278364160 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | __start_tp_report 02:21:07 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 02:21:07 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 02:21:07 INFO - PROCESS | 1666 | |i|pagename|runs| 02:21:07 INFO - PROCESS | 1666 | |0;dojo.html;3285.7864238824473;3430.8627654893808;3474.4267195912676;3477.982610086949;3481.2515309208516;5779;5811.912821307684;5856.2094117294155;5956.0172571525645;6007.819765407034;5817.534597232222;5873;5943.554233432499;5959.374265702093;6068.968275393183;5275.155975043994;5302.072137375943;5328;5428.077226871422;5438.510534051935;5405.297311349519;5460.399356070829;5464.371597266306;5478.287822583078;5527.972360138194;5274.446183150791;5408.35099788024;5414.972925135369;5436.021516127095;5495.203195536625;5271.499207575274;5305.363356397218;5343.973280133613;5368.114261146906;5408.810691625774;5267.3152490176035;5295.179247216687;5317.813876514303;5317.893642127175;5340.973295133499;4912.926306105412;5751.424857514216;5977.252843394575;5979.5515336349945;5987.311459182162;5425.891482170335;6183.897474858525;6228.470580000705;6256.343083976208;6298.716557754912;6303.968480157616;6312.337204593543;6312.495000399957;6314.71583778731;6337.493000559944;6023.427774361428;6035.758569657209;6049.939500605025;6062.757489700451;6065.363136870653;6199.256089269316;6305.621662700252;6353.3329000455215;6364.109024736541;6498.675066246668;6192.752289908353;6241.875162496724;6242.906356404657;6264.812055638338;6292.748290068346;6174.320824709278;6304.716287767062;6338;6338.873222535523;6355.269144048401;6171.444569988723;6192.504599632019;6193.876122477525;6235.594686345373;6269.7178626961895;6222.533310001678;6233.0338797486465;6248.875022499525;6258.655773932386;6279.937200628026;4989.90020199594;5055.570276526463;5082.110630639697;5084.593232541388;5084.949150508448;4441.933370999438;4486.685931984795;4495.752733599684;4543.34121552373;4585.312203169551;5806.245188125601;6054.364291749391;6058.454739073504;6135.938640613626;6155.692215389213;6334.239891212992;6359.8092057238355;6362.77730279438;6379.106925030499;6381.712822922979;5951.256092988377;5970.8655355482315;6037.909431358533;6072.787452439144;6094.786682466181;5530.723463826873;5591.496765291144;5599.440055994368;5616.9157462638095;5638.915416268677;6478.963365861439;6551.1155993941165;6576.802695919035;6587.374199451045;6597.505187111082;6189.226346706661;6211.720472578654;6303.275123360872;6309.022101574264;6378.968105159444;6427.646479443675;6533.314002029719;6555.180602424697;6588.04473351371;6604.735810567524;6255.687215639291;6270.529710271657;6284.905726414199;6298.779542715983;6314.747410103728;5253.343332083489;6175.536834737502;6186.4741496971465;6352.587081839665;6354.491640668828;5140.717260550556;5548.667079975215;6185.628862268099;6191.19514463135;6207.131001659862;5551.25058117149;5882.323532793784;6037.15479832815;6141;6201.410865967726;6040.6677632730625;6099.664518451527;6101.217066730222;6122.785702500391;6129.3564175762685;6133.76314253068;6156.26124865019;6171.56799024064;6188.319284878569;6189.04069869171;6096.969515152396;6120.60216085953;6154.3845615438095;6154.846128846635;6182.814515564541 02:21:07 INFO - PROCESS | 1666 | |1;ext.html;490.3894651159305;509.90821652102625;518.0907507324645;544.7960008381476;573.3607028163598;38258.61741382585;40336.59663403369;40511.59488405111;40561.59438405615;43065.35401968965;41846;42383;42583;42589.14821703564;42629.57370426295;9505.334626576125;9575.808483830318;9585.568649410758;9691.176250018756;9692.757681057994;9468.526573671323;9537.427754334762;9573.377730447499;9577.80844383112;9582.760430989247;7705.267999540035;9517.714468565953;9538.761530961747;9567.425954442755;9582.760430989212;9485.193758530533;9526.285528585384;9543.618255269781;9543.952280238589;9547.236221102296;8860.955695221483;8950.104989501064;8955.776105597348;8956.910430895672;8968.327375446803;40178;40218.59781402207;40329.596704032876;40541.39187912184;40624.796876015724;3573.26748016656;3606.783592984429;3750.456183853353;4028.979855100735;4158.979205103986;27667.861660691568;28565.57151642727;29316.413671726445;30633.324001120007;30887.691123088705;3130.2487403023338;3171.3815805917857;3265;3328.916777080568;3330.7002369786837;504212;508550.45724771137;514717;515136.8486315126;516047;56177.71911140418;56823.71588142033;56845.43154568484;56937.145942810894;56983;51280.23079653808;52720.20919686208;57699;58121.8375632485;59179.70410147922;15051;15150.54548363551;15291.006084604465;15296.388144474096;15317.004394714308;12229.69425764363;12313.938430307791;12356.814647780291;12360.44378002992;12381.195222310522;14374.921880858978;14631.487897923522;14727.779083313759;14798.964072515037;14959;3196.872125115016;6209.875802483925;6579.631332720217;6808.353206445379;7046.964765176142;896.9327300452362;936.3819878879907;1019.4647809899861;1031.7626945802508;1066.2269854355686;22892.542149156925;26748.59877101845;30165.09504714862;30436.086917392513;30870.228244293623;1089.3028461784463;1097.9011888929874;1099.2085698297212;1105.4141305108144;1155.156735583029;15524.92237538805;15589.454369097028;15638.905276630527;15755.921220393824;15898.76151857723;578900;581839.0908045432;582334;583727;588425;57543.42456575464;57833.421665783644;57913.8417231653;57920;57920.71039644775;1361.2104979112091;1400.2578633324354;1421.7725163973714;1423.814904062486;1424.7862820576788;28986;29667.96162134315;29727.810887564254;30196.698033020268;30747.53878691866;48890.75554622204;49124;49248.26127608017;49254;49311.75344123256;542324.2883785556;547838;549844;551266;551410;25482;25621.231363059138;25953.6106958392;26025.958961642078;26117.347066323495;45354.54645453503;46319.07361852811;46501.767491162325;47050.29424558703;47186.528134719585;37793.433098502996;38698.61301387063;39791.40312895251;40611.59388406078;40832.591674082876;37130.44304335491;38930.0267493315;39840;40072.198556029296;40188.397174043;37513.249735005695;37877.621223787406;38146.8092659546;38448;38554.22891542209;32613;34278.14304642304;34667.47998780071;34963.12592185216;35293.117672058404;24778.628320574844;25177.3634713743;25314.114006010437;25414.364640884127;25665 02:21:07 INFO - PROCESS | 1666 | |2;jquery.html;349.57526605174706;370.35558128855797;376.674176837036;383.0232906089471;399.87004223627326;19725.408237752872;20041.59916801663;20336.69494957577;20494.590108197845;20599.794002059974;20273.290434834784;20560.383188504333;20926.790732092675;21099.47251318718;21287.36137915861;4681.46163191234;5710.114932185507;6011.458968692817;6021.277446706401;6030.155778191057;5880.735366908478;6005.579609427342;6013.6993150342305;6022.337542870281;6022.367651396606;5711.885762284752;5858.091995740667;5931;5935.406459354073;5954.583179177459;5623.718814059322;5906.320773111082;5906.822795316169;5914.852128696774;5920.2007728956905;5117.48825117489;5143.971205758863;5150.072986862363;5154.587632989389;5157.355330583677;20463;25604.74395256042;25619.871900640377;25728.614070788954;25880.96476140952;2157.5792720419527;2245.86524808512;2252;2326.139328448468;2379.4646204604;15261.542153735405;15403.614909627237;15625.374985000586;15664.765028524467;15990;1366.9111507751963;1776.3072401763322;1794.676958147533;1818.690822560168;1899.819517145869;116430.41784791107;121380.39309803482;121399;121505;121863.3906830469;10593.258471906893;10606.257561970742;10938.835917461245;11008.834867476995;11220.775584488265;13895.58313250604;13903.652408689864;13906.51327203543;13910.234937078558;13922.303884805719;8095.190480951976;8417.747467575982;8427.41008129425;8467.195616416431;8556.529390883561;6384.585001974857;8096.878546821802;8149.348052155813;8252.876206856901;8431.789205269917;6650.767223147167;6703.960886062668;6842.832572797709;6850.280720524373;6929.029935808991;1529.8546638069365;1651.3559711712442;1839.2183322088058;1852.935147269839;1854.4807453912927;795.121390863088;849.3417601358873;949.4588084791602;949.7368499895123;996.4071377530358;16719.6656066878;20061.699074513894;21404.143834246457;22311.549749266247;22911.88544057269;1026.9486525673688;1029.6499190275342;1053.1574740207802;1083.4907593431076;1093.4478088565224;10939.617113400993;11131.944340278409;11986.460609272604;11992.280463172237;12079.094067944763;528747;551486;564787.3452022051;578850;596845;118249;122054;122858.77141228651;138725.3063734695;144148;959.2326139088701;994.7065615643257;1003.7340104872361;1008.6520150548049;1010.2372708604956;19576;19820.70268945938;20008.39974800758;20038.99805009773;20131.798682013577;45378;54245.915081698935;54373;54404.455955441525;54974.17538736842;74666;81501;82423;82508;82677;7963.243491868263;8101.594920254081;8192.344612430872;8260.008798943925;8300.08699043117;11553.653390398302;12870.742585148431;12899.677508061997;13070;13073.477060917838;11145.498452569816;11271.211015228855;11329.263597866113;11426.657200284004;11561.942190288995;9330.95334523323;11114.38870862078;11269.267497612629;11394.601188958346;11426.542938282375;9507.572159252712;11500.884991149982;11608.419579020847;11669.316057306698;11869.465874035517;7990.760277191694;8004.799880002814;8111.675532978615;8172.8365432689825;8218.096009438837;9782.777152855893;10813.729656758644;11297.548098075986;11370.54517819278;11492.253003554742 02:21:07 INFO - PROCESS | 1666 | |3;mootools.html;1540.4146424358742;1560.1809050248619;1829.5700510380059;1904.628597423503;1942;6298.7165577549;7012.474064445174;8476.915230847697;9051.592678329474;9133.725988220347;7016.543924644894;7214.314640109194;8789.121087891208;8956.507392093432;8966.641334346617;2341.239097293378;2371.620540713486;2376.1802178248477;2377.3105799318264;2380.642903564462;2022.8078332558457;2316.884155792212;2335.789778919897;2345.0971376020184;2389.3429306940557;2346.026399044403;2349.0955981946904;2350.7061617297836;2365.089440565386;2381.6427535869584;2307.746147923727;2321.3036089173265;2338.462153704649;2342.2621874109773;2355.163916809542;2306.7693230676796;2323.802476789475;2336.38085907233;2336.836421450499;2340.33300509354;8863.379563430562;8907.153820387053;8978.50618215998;8981.506017169053;9049.638014479413;5291.708956007418;5311.2298716686255;5480.835574932718;5487.862803429906;5493.450654934514;3558.7508874378805;3588.282343531278;3632.4732913727626;3653.6894363979095;3673.963260367389;1034.2811745836646;1076.95692172313;1082.0910435234362;1094.950727217277;1101.1961268274204;11642.825357619642;11758.706032349173;11787.469563869647;11846.940765296205;11886.702832429259;4567.451905771262;4667.789949452283;4819.867331177171;4842;4867.221244600847;9908.900910990798;10043.799124017625;10095.495225238708;10098;10117.988201179824;5446.21029950655;5464.7814087436855;5474.233607294982;5482.23248745176;5485.561155107582;4171.520275168334;4476;4643.094596553708;4770.76146192689;5023.949760502422;3484.738644601665;3813.237352529505;3951.2887680217837;4091.7749523775883;4127.318992366226;1138.6925530106826;1312.875276848698;1328.774108401574;1335.0787956310114;1335.3123141582093;799.2686691677167;897.5280539914545;917.2157805076697;919.6022046489298;951.9095685909828;5689.061304884648;5721.713914304268;5850.822022510024;5946.226990491208;6038.486728628028;437.2784904906929;441.99558004420186;447.29550957242475;988.8813342398959;996.1234113979651;2839.843808590506;3780.2061567070673;3915.1778126593736;3949.111449923744;3955.0310174006977;10520.263581549218;10950.945245273722;10962.671119866416;10962.890371096188;10976.506057227443;10897.237193396386;10899.400532970763;10914.181436392302;10915.126789856793;10919.290246133976;8051.4766540174705;8068.233517815798;8191.95904020488;8264.297534709496;8306.958465207756;4967.230079337708;5696.287964004499;5744;5817.970910145422;5948.881022379442;9500.144986951207;9811.411315321104;9855.556499957376;9964.750881228027;10088.041636044563;10024.298299119284;10074.69775906724;10166.339187952759;10207.59169633236;10337.431441270803;6392.648404337806;7141.214466408587;7322.96338518304;7489.962550187214;7655.157932627518;8268.793280168044;8504.702335418231;8535.53054582004;8536.274416674652;8575.31397488187;6968.303169682991;7301.671424785791;7486.625668716433;7497.400207983457;7567.31894129531;5594.328680558359;7569.243075692387;7621.161672215941;7673.961630191813;7778.14440411543;6816;6956.756513522205;7037.788866334018;7039.472039596948;7042.929570704432;4206.990322322559;5063.443021267584;5130.948690513047;5188.507091826271;5242.816501422432;4386.64906807461;4420.469543654782;5177.974110129425;5291.153415453509;5336.332958380202 02:21:07 INFO - PROCESS | 1666 | |4;prototype.html;263.5466996765563;289.77976737679364;301.6681650184797;310.16720106514003;314.38694545636014;4028.7784171870535;4702.341672165895;5214.0614689356;5347.0909945309295;5447.046766815806;4346.956530434694;5290.365156181264;5384.461553844623;5385.919211211825;5402.837914862551;3538.9115272118147;4019.7387169834014;4129.2567337879245;4148.008955701265;4159.459270294858;3072.4776787946103;3399.694027537521;4026.5772093930154;4180.749155050691;4189.937150942723;3504.3867323218333;3813.3898576227807;4076.612721791425;4083.6523947097385;4085.7957102144924;3437.845296961655;3623.963760362389;3634.4548317752283;3892.746971446847;4064.0652649890394;3159.7092108221586;3472.770323599052;3610.6930910872607;3613.927721445583;3618.113562177257;4691.061787642485;4949.307097006422;5078.923816142761;5206.76569554371;5234.293370395024;4472.373867658531;4739.3838800955655;4751.64362672801;4752.833650822205;4764.380630518011;4958.404991401055;5695.316562012544;5705.515031222351;5751.626144300607;5758.2514273144225;3541.9468707969145;3544.759334232998;3781.565120011179;3981.960180398217;3997.120633460634;5892.440218179266;6001.939980600182;6026.9095963560585;6042.15409842618;6107.877842443127;3929.941050884239;3934.9803250983564;3937.2125574884567;3943.38877473992;3965.504311961005;3670.1925576373155;3894.2990261753157;3997.5003124609425;4014.571184433376;4037.454943582579;4227.408162857202;4640.373549570765;4645.790939407735;4652.836431059573;4674.182018146811;5031.52200540948;5759.963206622848;5791.536677065825;5824.3302020267365;5838.489449536655;1153.6366044695894;1277.201748906933;1312.5734136405706;1346.4748747988292;1352.499575157198;780.2548566119342;789.0294937227128;879.9868001979976;904.8054668246227;920.5765347939889;4307.504636966726;5413.675179489243;5441.83674489766;5449.455054494519;5456.536194423439;4788.61691064721;5020.849374518771;5481.506664400223;5851.97590421683;5903.35063143054;5062.620303477254;5150.201718733602;5383.461653834585;5393.298871146726;5396.298481197419;2579.2520169150735;2592.4296654735926;2607.674040744907;2621.934451638724;2628.895863737235;3901.258760835489;4175.016866988217;4252.702310838274;4640.95359046412;5338.786448542015;5026.824061157915;5826.077394459818;6094.695265236721;6115.449609535163;6184.876302474016;5383.946160538345;5814.418558144152;5913.526917846562;6235.438810507076;6243.37566243372;4701.435827700561;4965.8013679452415;5686.516646085129;5960.523158147251;6137.539684523589;4904.779284932115;4939.28380384835;5421.376541697755;5621.634593751393;5694.772209111589;5291.915157392802;5907.822765317047;6237.781677641261;6247.281562620356;6281.937180628135;3741.746514917424;3849.72866009056;3928.7446315990514;3937.9015524612114;3938.5273767148124;4956.529129732669;5437.700926449083;5623.831285061455;5939.4951429129005;5994.885217078642;4957.851264462072;5018.548330650259;5619.611665042423;5834.7082645866685;5841.970790146022;5302.469753024667;5598.580106492111;5817.0983497557945;5829.358770535153;5904.734286957183;5011.997600479992;5039.722815245197;5181.611379146504;5329.866753331198;5694.601377903507;5007.47421520735;5781.624194427349;5808.419158084158;5845.386234445492;5869.325027621878;5310.6813591184655;5674.971625141848;5696.686682232351;5705.572082093942;5718.912596902018 02:21:07 INFO - PROCESS | 1666 | |5;yui.html;729.4346881167096;758.9430792690549;779.4504874063786;793.984120317594;866.0257210638032;14945.775813362794;15790.289436975336;15793.28930198141;17274.56813579658;18064.916105033673;16930.661386772288;16999.980001199936;17108.401205957794;17126.914365428154;17147.314107435686;868.8566386546212;901.3870568013748;904.900460949295;907.5371560504158;907.9046700096461;695.1067877777058;716.0798374089296;870.8737233101197;889.2619126125301;902.4314681750488;917.2891009467683;933.3000249812641;944.9338546301761;946.2288235088415;947.1996163242084;902.0573500691793;909.5043201455156;929.0987741890356;936.5598168860658;942.0814705661993;689.1076056506836;700.1493185779302;702.6135625406006;703.3037293079865;705.3651713457929;14509.129452232793;14659;14711;14771.187584682839;14935.701285974328;14089.71820563583;14146.858531414657;14181.929090354586;14204.431822727078;14395.280235988159;11390.25963312382;11460.770784584345;11581.305121692641;11615;11758.412079396081;3697.2235830475634;3790.298794722985;3806.71449641278;3807.866724664651;3932.5674175840636;111744;111828.44085779518;113246;114055.42972285085;115226.42386788096;10816.351018938889;10862.945685271523;10949.288296260718;10981.231313807957;11077.944610276896;21544.892275538834;21865.67201491979;21875.453113672287;21886;21890.89054554717;7748.6125693715085;7767;7802.375809935192;7946.205379462008;8040.195980401913;4240.406343111967;4272.273713468718;4279.7251370593885;4291.077418355007;4392.165488557164;3661.212839239576;3733;3760.4735337052834;3781.9432708509394;3786.0156359346215;632.2918331468784;654.656305439648;659.673461636493;667.216021175127;687.2817905288985;620.6183197333697;634.9492040636738;638.6423602782364;666.4068978609042;669.7488441834312;9102.7698213938;9509.476978766234;9617.902511668826;10219.540120694586;10349.534270957825;548.4241546376289;564.3312674480753;574.3681949855126;644.2494493914537;674.3020973292619;4907.901841963212;4936.679115857458;4986.526280003394;4986.850394488171;5102.489751024942;94099.52950235204;106395;107102.46448767862;129190;143447;75753.86369204466;114952;116732.41633791776;117649;118204.40897795456;86788;101813.49093254487;102818.48590756998;103225;104397.91204175874;8037;8823.676448532771;9878.16035636979;9896.653617123655;10051.145652619609;42980.78509607557;53978.73010634922;56141.43858561526;57479;58360;71374.92937606043;72904.27095728974;79951.2004879967;83681.58159209165;87991.56004219937;13083.215007099605;13100.934495327463;13120.449127277736;13161.53934612284;13632.318384080954;14339.354729037426;14460.06009609372;14585.489507867174;14784.852151478777;14990.925045374703;13346.799798002843;13512.797308040585;13544.458221671417;13582.388792504558;13797.037044384944;13557.389917453935;13859.237741923887;13928.860711392756;14159.929200354345;14224.715505690036;10754.139668826632;13220.202662112299;13564.38960246811;13755.79366309526;13836.37736301889;11055.668329950115;11064.28082174656;11370.31778093317;11506.597269095542;11512.366819824654;7011.964940175267;9128.406653567497;9166.22087122602;10993.450327483433;11420.257683250562 02:21:07 INFO - PROCESS | 1666 | __end_tp_report 02:21:07 INFO - PROCESS | 1666 | __start_cc_report 02:21:07 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,367 02:21:07 INFO - PROCESS | 1666 | __end_cc_report 02:21:07 INFO - PROCESS | 1666 | __startTimestamp1476782467772__endTimestamp 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | ------- Summary: start ------- 02:21:07 INFO - PROCESS | 1666 | Number of tests: 6 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5854.20 Median:6099.66 stddev:641.23 (10.5%) stddev-sans-first:610.72 02:21:07 INFO - PROCESS | 1666 | Values: 3285.8 3430.9 3474.4 3478.0 3481.3 5779.0 5811.9 5856.2 5956.0 6007.8 5817.5 5873.0 5943.6 5959.4 6069.0 5275.2 5302.1 5328.0 5428.1 5438.5 5405.3 5460.4 5464.4 5478.3 5528.0 5274.4 5408.4 5415.0 5436.0 5495.2 5271.5 5305.4 5344.0 5368.1 5408.8 5267.3 5295.2 5317.8 5317.9 5341.0 4912.9 5751.4 5977.3 5979.6 5987.3 5425.9 6183.9 6228.5 6256.3 6298.7 6304.0 6312.3 6312.5 6314.7 6337.5 6023.4 6035.8 6049.9 6062.8 6065.4 6199.3 6305.6 6353.3 6364.1 6498.7 6192.8 6241.9 6242.9 6264.8 6292.7 6174.3 6304.7 6338.0 6338.9 6355.3 6171.4 6192.5 6193.9 6235.6 6269.7 6222.5 6233.0 6248.9 6258.7 6279.9 4989.9 5055.6 5082.1 5084.6 5084.9 4441.9 4486.7 4495.8 4543.3 4585.3 5806.2 6054.4 6058.5 6135.9 6155.7 6334.2 6359.8 6362.8 6379.1 6381.7 5951.3 5970.9 6037.9 6072.8 6094.8 5530.7 5591.5 5599.4 5616.9 5638.9 6479.0 6551.1 6576.8 6587.4 6597.5 6189.2 6211.7 6303.3 6309.0 6379.0 6427.6 6533.3 6555.2 6588.0 6604.7 6255.7 6270.5 6284.9 6298.8 6314.7 5253.3 6175.5 6186.5 6352.6 6354.5 5140.7 5548.7 6185.6 6191.2 6207.1 5551.3 5882.3 6037.2 6141.0 6201.4 6040.7 6099.7 6101.2 6122.8 6129.4 6133.8 6156.3 6171.6 6188.3 6189.0 6097.0 6120.6 6154.4 6154.8 6182.8 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:67898.40 Median:40424.10 stddev:146379.43 (362.1%) stddev-sans-first:146702.57 02:21:07 INFO - PROCESS | 1666 | Values: 490.4 509.9 518.1 544.8 573.4 38258.6 40336.6 40511.6 40561.6 43065.4 41846.0 42383.0 42583.0 42589.1 42629.6 9505.3 9575.8 9585.6 9691.2 9692.8 9468.5 9537.4 9573.4 9577.8 9582.8 7705.3 9517.7 9538.8 9567.4 9582.8 9485.2 9526.3 9543.6 9544.0 9547.2 8861.0 8950.1 8955.8 8956.9 8968.3 40178.0 40218.6 40329.6 40541.4 40624.8 3573.3 3606.8 3750.5 4029.0 4159.0 27667.9 28565.6 29316.4 30633.3 30887.7 3130.2 3171.4 3265.0 3328.9 3330.7 504212.0 508550.5 514717.0 515136.8 516047.0 56177.7 56823.7 56845.4 56937.1 56983.0 51280.2 52720.2 57699.0 58121.8 59179.7 15051.0 15150.5 15291.0 15296.4 15317.0 12229.7 12313.9 12356.8 12360.4 12381.2 14374.9 14631.5 14727.8 14799.0 14959.0 3196.9 6209.9 6579.6 6808.4 7047.0 896.9 936.4 1019.5 1031.8 1066.2 22892.5 26748.6 30165.1 30436.1 30870.2 1089.3 1097.9 1099.2 1105.4 1155.2 15524.9 15589.5 15638.9 15755.9 15898.8 578900.0 581839.1 582334.0 583727.0 588425.0 57543.4 57833.4 57913.8 57920.0 57920.7 1361.2 1400.3 1421.8 1423.8 1424.8 28986.0 29668.0 29727.8 30196.7 30747.5 48890.8 49124.0 49248.3 49254.0 49311.8 542324.3 547838.0 549844.0 551266.0 551410.0 25482.0 25621.2 25953.6 26026.0 26117.3 45354.5 46319.1 46501.8 47050.3 47186.5 37793.4 38698.6 39791.4 40611.6 40832.6 37130.4 38930.0 39840.0 40072.2 40188.4 37513.2 37877.6 38146.8 38448.0 38554.2 32613.0 34278.1 34667.5 34963.1 35293.1 24778.6 25177.4 25314.1 25414.4 25665.0 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34436.24 Median:12278.71 stddev:94673.11 (771.0%) stddev-sans-first:94904.09 02:21:07 INFO - PROCESS | 1666 | Values: 349.6 370.4 376.7 383.0 399.9 19725.4 20041.6 20336.7 20494.6 20599.8 20273.3 20560.4 20926.8 21099.5 21287.4 4681.5 5710.1 6011.5 6021.3 6030.2 5880.7 6005.6 6013.7 6022.3 6022.4 5711.9 5858.1 5931.0 5935.4 5954.6 5623.7 5906.3 5906.8 5914.9 5920.2 5117.5 5144.0 5150.1 5154.6 5157.4 20463.0 25604.7 25619.9 25728.6 25881.0 2157.6 2245.9 2252.0 2326.1 2379.5 15261.5 15403.6 15625.4 15664.8 15990.0 1366.9 1776.3 1794.7 1818.7 1899.8 116430.4 121380.4 121399.0 121505.0 121863.4 10593.3 10606.3 10938.8 11008.8 11220.8 13895.6 13903.7 13906.5 13910.2 13922.3 8095.2 8417.7 8427.4 8467.2 8556.5 6384.6 8096.9 8149.3 8252.9 8431.8 6650.8 6704.0 6842.8 6850.3 6929.0 1529.9 1651.4 1839.2 1852.9 1854.5 795.1 849.3 949.5 949.7 996.4 16719.7 20061.7 21404.1 22311.5 22911.9 1026.9 1029.6 1053.2 1083.5 1093.4 10939.6 11131.9 11986.5 11992.3 12079.1 528747.0 551486.0 564787.3 578850.0 596845.0 118249.0 122054.0 122858.8 138725.3 144148.0 959.2 994.7 1003.7 1008.7 1010.2 19576.0 19820.7 20008.4 20039.0 20131.8 45378.0 54245.9 54373.0 54404.5 54974.2 74666.0 81501.0 82423.0 82508.0 82677.0 7963.2 8101.6 8192.3 8260.0 8300.1 11553.7 12870.7 12899.7 13070.0 13073.5 11145.5 11271.2 11329.3 11426.7 11561.9 9331.0 11114.4 11269.3 11394.6 11426.5 9507.6 11500.9 11608.4 11669.3 11869.5 7990.8 8004.8 8111.7 8172.8 8218.1 9782.8 10813.7 11297.5 11370.5 11492.3 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5677.83 Median:4719.28 stddev:3225.57 (68.3%) stddev-sans-first:3219.64 02:21:07 INFO - PROCESS | 1666 | Values: 1540.4 1560.2 1829.6 1904.6 1942.0 6298.7 7012.5 8476.9 9051.6 9133.7 7016.5 7214.3 8789.1 8956.5 8966.6 2341.2 2371.6 2376.2 2377.3 2380.6 2022.8 2316.9 2335.8 2345.1 2389.3 2346.0 2349.1 2350.7 2365.1 2381.6 2307.7 2321.3 2338.5 2342.3 2355.2 2306.8 2323.8 2336.4 2336.8 2340.3 8863.4 8907.2 8978.5 8981.5 9049.6 5291.7 5311.2 5480.8 5487.9 5493.5 3558.8 3588.3 3632.5 3653.7 3674.0 1034.3 1077.0 1082.1 1095.0 1101.2 11642.8 11758.7 11787.5 11846.9 11886.7 4567.5 4667.8 4819.9 4842.0 4867.2 9908.9 10043.8 10095.5 10098.0 10118.0 5446.2 5464.8 5474.2 5482.2 5485.6 4171.5 4476.0 4643.1 4770.8 5023.9 3484.7 3813.2 3951.3 4091.8 4127.3 1138.7 1312.9 1328.8 1335.1 1335.3 799.3 897.5 917.2 919.6 951.9 5689.1 5721.7 5850.8 5946.2 6038.5 437.3 442.0 447.3 988.9 996.1 2839.8 3780.2 3915.2 3949.1 3955.0 10520.3 10950.9 10962.7 10962.9 10976.5 10897.2 10899.4 10914.2 10915.1 10919.3 8051.5 8068.2 8192.0 8264.3 8307.0 4967.2 5696.3 5744.0 5818.0 5948.9 9500.1 9811.4 9855.6 9964.8 10088.0 10024.3 10074.7 10166.3 10207.6 10337.4 6392.6 7141.2 7323.0 7490.0 7655.2 8268.8 8504.7 8535.5 8536.3 8575.3 6968.3 7301.7 7486.6 7497.4 7567.3 5594.3 7569.2 7621.2 7674.0 7778.1 6816.0 6956.8 7037.8 7039.5 7042.9 4207.0 5063.4 5130.9 5188.5 5242.8 4386.6 4420.5 5178.0 5291.2 5336.3 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4536.52 Median:5019.70 stddev:1441.86 (28.7%) stddev-sans-first:1409.78 02:21:07 INFO - PROCESS | 1666 | Values: 263.5 289.8 301.7 310.2 314.4 4028.8 4702.3 5214.1 5347.1 5447.0 4347.0 5290.4 5384.5 5385.9 5402.8 3538.9 4019.7 4129.3 4148.0 4159.5 3072.5 3399.7 4026.6 4180.7 4189.9 3504.4 3813.4 4076.6 4083.7 4085.8 3437.8 3624.0 3634.5 3892.7 4064.1 3159.7 3472.8 3610.7 3613.9 3618.1 4691.1 4949.3 5078.9 5206.8 5234.3 4472.4 4739.4 4751.6 4752.8 4764.4 4958.4 5695.3 5705.5 5751.6 5758.3 3541.9 3544.8 3781.6 3982.0 3997.1 5892.4 6001.9 6026.9 6042.2 6107.9 3929.9 3935.0 3937.2 3943.4 3965.5 3670.2 3894.3 3997.5 4014.6 4037.5 4227.4 4640.4 4645.8 4652.8 4674.2 5031.5 5760.0 5791.5 5824.3 5838.5 1153.6 1277.2 1312.6 1346.5 1352.5 780.3 789.0 880.0 904.8 920.6 4307.5 5413.7 5441.8 5449.5 5456.5 4788.6 5020.8 5481.5 5852.0 5903.4 5062.6 5150.2 5383.5 5393.3 5396.3 2579.3 2592.4 2607.7 2621.9 2628.9 3901.3 4175.0 4252.7 4641.0 5338.8 5026.8 5826.1 6094.7 6115.4 6184.9 5383.9 5814.4 5913.5 6235.4 6243.4 4701.4 4965.8 5686.5 5960.5 6137.5 4904.8 4939.3 5421.4 5621.6 5694.8 5291.9 5907.8 6237.8 6247.3 6281.9 3741.7 3849.7 3928.7 3937.9 3938.5 4956.5 5437.7 5623.8 5939.5 5994.9 4957.9 5018.5 5619.6 5834.7 5842.0 5302.5 5598.6 5817.1 5829.4 5904.7 5012.0 5039.7 5181.6 5329.9 5694.6 5007.5 5781.6 5808.4 5845.4 5869.3 5310.7 5675.0 5696.7 5705.6 5718.9 02:21:07 INFO - PROCESS | 1666 | 02:21:07 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:22704.28 Median:3771.21 stddev:34476.52 (914.2%) stddev-sans-first:34533.75 02:21:07 INFO - PROCESS | 1666 | Values: 729.4 758.9 779.5 794.0 866.0 14945.8 15790.3 15793.3 17274.6 18064.9 16930.7 17000.0 17108.4 17126.9 17147.3 868.9 901.4 904.9 907.5 907.9 695.1 716.1 870.9 889.3 902.4 917.3 933.3 944.9 946.2 947.2 902.1 909.5 929.1 936.6 942.1 689.1 700.1 702.6 703.3 705.4 14509.1 14659.0 14711.0 14771.2 14935.7 14089.7 14146.9 14181.9 14204.4 14395.3 11390.3 11460.8 11581.3 11615.0 11758.4 3697.2 3790.3 3806.7 3807.9 3932.6 111744.0 111828.4 113246.0 114055.4 115226.4 10816.4 10862.9 10949.3 10981.2 11077.9 21544.9 21865.7 21875.5 21886.0 21890.9 7748.6 7767.0 7802.4 7946.2 8040.2 4240.4 4272.3 4279.7 4291.1 4392.2 3661.2 3733.0 3760.5 3781.9 3786.0 632.3 654.7 659.7 667.2 687.3 620.6 634.9 638.6 666.4 669.7 9102.8 9509.5 9617.9 10219.5 10349.5 548.4 564.3 574.4 644.2 674.3 4907.9 4936.7 4986.5 4986.9 5102.5 94099.5 106395.0 107102.5 129190.0 143447.0 75753.9 114952.0 116732.4 117649.0 118204.4 86788.0 101813.5 102818.5 103225.0 104397.9 8037.0 8823.7 9878.2 9896.7 10051.1 42980.8 53978.7 56141.4 57479.0 58360.0 71374.9 72904.3 79951.2 83681.6 87991.6 13083.2 13100.9 13120.4 13161.5 13632.3 14339.4 14460.1 14585.5 14784.9 14990.9 13346.8 13512.8 13544.5 13582.4 13797.0 13557.4 13859.2 13928.9 14159.9 14224.7 10754.1 13220.2 13564.4 13755.8 13836.4 11055.7 11064.3 11370.3 11506.6 11512.4 7012.0 9128.4 9166.2 10993.5 11420.3 02:21:07 INFO - PROCESS | 1666 | -------- Summary: end -------- 02:21:07 INFO - PROCESS | 1666 | 02:21:08 INFO - TEST-INFO | 1666: exit 0 02:21:08 INFO - TEST-OK | dromaeo_css | took 1116280ms 02:21:08 INFO - TEST-START | kraken 02:21:08 INFO - operating with platform_type : mac_ 02:21:08 INFO - Initialising browser for kraken test... 02:21:08 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpzQ41aw/profile http://localhost:49267/getInfo.html) 02:21:11 INFO - PROCESS | 1673 | 2016-10-18 02:21:11.123 plugin-container[1674:11764] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 02:21:11 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:21:11 INFO - PROCESS | 1673 | 2016-10-18 02:21:11.125 plugin-container[1674:11764] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 02:21:11 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:21:11 INFO - PROCESS | 1673 | 2016-10-18 02:21:11.125 plugin-container[1674:11764] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:21:11 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 02:21:11 INFO - PROCESS | 1673 | colorDepth:24 02:21:11 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 02:21:11 INFO - PROCESS | 1673 | __metrics 02:21:11 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 02:21:11 INFO - TEST-INFO | 1673: exit 0 02:21:11 INFO - Browser initialized. 02:21:11 INFO - Running cycle 1/1 for kraken test... 02:21:11 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpzQ41aw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:14 INFO - PROCESS | 1675 | 2016-10-18 02:21:14.162 plugin-container[1676:11877] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 02:21:14 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:21:14 INFO - PROCESS | 1675 | 2016-10-18 02:21:14.162 plugin-container[1676:11877] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 02:21:14 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:21:14 INFO - PROCESS | 1675 | 2016-10-18 02:21:14.162 plugin-container[1676:11877] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:21:23 INFO - PROCESS | 1675 | RSS: Main: 237293568 02:21:23 INFO - PROCESS | 1675 | 02:21:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:27 INFO - PROCESS | 1675 | RSS: Main: 249446400 02:21:27 INFO - PROCESS | 1675 | 02:21:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 02:21:31 INFO - PROCESS | 1675 | RSS: Main: 258154496 02:21:31 INFO - PROCESS | 1675 | 02:21:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 02:21:35 INFO - PROCESS | 1675 | RSS: Main: 260296704 02:21:35 INFO - PROCESS | 1675 | 02:21:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 02:21:37 INFO - PROCESS | 1675 | RSS: Main: 261128192 02:21:37 INFO - PROCESS | 1675 | 02:21:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:21:40 INFO - PROCESS | 1675 | RSS: Main: 261533696 02:21:40 INFO - PROCESS | 1675 | 02:21:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 02:21:43 INFO - PROCESS | 1675 | RSS: Main: 263819264 02:21:43 INFO - PROCESS | 1675 | 02:21:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 02:21:46 INFO - PROCESS | 1675 | RSS: Main: 263675904 02:21:46 INFO - PROCESS | 1675 | 02:21:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 02:21:50 INFO - PROCESS | 1675 | RSS: Main: 264126464 02:21:50 INFO - PROCESS | 1675 | 02:21:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:21:52 INFO - PROCESS | 1675 | RSS: Main: 263360512 02:21:52 INFO - PROCESS | 1675 | 02:21:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:21:55 INFO - PROCESS | 1675 | RSS: Main: 263671808 02:21:55 INFO - PROCESS | 1675 | 02:21:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:21:58 INFO - PROCESS | 1675 | RSS: Main: 263516160 02:21:58 INFO - PROCESS | 1675 | 02:22:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:01 INFO - PROCESS | 1675 | RSS: Main: 263368704 02:22:01 INFO - PROCESS | 1675 | 02:22:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:05 INFO - PROCESS | 1675 | RSS: Main: 263745536 02:22:05 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 02:22:07 INFO - PROCESS | 1675 | RSS: Main: 265347072 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | __start_tp_report 02:22:07 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 02:22:07 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 02:22:07 INFO - PROCESS | 1675 | |i|pagename|runs| 02:22:07 INFO - PROCESS | 1675 | |0;ai-astar;106;117;116;118;115;116;118;117;116;119 02:22:07 INFO - PROCESS | 1675 | |1;audio-beat-detection;146;137;144;181;117;118;148;138;141;118 02:22:07 INFO - PROCESS | 1675 | |2;audio-dft;196;200;204;219;193;193;195;199;196;195 02:22:07 INFO - PROCESS | 1675 | |3;audio-fft;86;61;60;85;61;66;52;70;100;50 02:22:07 INFO - PROCESS | 1675 | |4;audio-oscillator;92;73;87;74;71;72;88;70;74;87 02:22:07 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;91;90;90;88;94;87;92;88;89;87 02:22:07 INFO - PROCESS | 1675 | |6;imaging-darkroom;94;97;97;96;95;96;98;96;97;96 02:22:07 INFO - PROCESS | 1675 | |7;imaging-desaturate;88;90;85;86;89;92;94;150;136;78 02:22:07 INFO - PROCESS | 1675 | |8;json-parse-financial;59;58;58;58;56;59;58;58;57;56 02:22:07 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;69;76;59;100;115;108;101;79;72;72 02:22:07 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;88;89;86;89;87;88;94;90;92;94 02:22:07 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;146;149;146;170;168;159;147;146;194;153 02:22:07 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;175;178;178;175;170;173;170;172;171;173 02:22:07 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;71;71;70;71;70;68;70;70;85;92 02:22:07 INFO - PROCESS | 1675 | __end_tp_report 02:22:07 INFO - PROCESS | 1675 | __start_cc_report 02:22:07 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,942 02:22:07 INFO - PROCESS | 1675 | __end_cc_report 02:22:07 INFO - PROCESS | 1675 | __startTimestamp1476782527396__endTimestamp 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | ------- Summary: start ------- 02:22:07 INFO - PROCESS | 1675 | Number of tests: 14 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:3.65 (3.1%) stddev-sans-first:1.27 02:22:07 INFO - PROCESS | 1675 | Values: 106.0 117.0 116.0 118.0 115.0 116.0 118.0 117.0 116.0 119.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:142.50 stddev:19.13 (13.4%) stddev-sans-first:20.11 02:22:07 INFO - PROCESS | 1675 | Values: 146.0 137.0 144.0 181.0 117.0 118.0 148.0 138.0 141.0 118.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:199.00 Median:197.50 stddev:7.80 (4.0%) stddev-sans-first:8.20 02:22:07 INFO - PROCESS | 1675 | Values: 196.0 200.0 204.0 219.0 193.0 193.0 195.0 199.0 196.0 195.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:69.10 Median:63.50 stddev:16.24 (25.6%) stddev-sans-first:16.04 02:22:07 INFO - PROCESS | 1675 | Values: 86.0 61.0 60.0 85.0 61.0 66.0 52.0 70.0 100.0 50.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:80.50 stddev:8.55 (10.6%) stddev-sans-first:7.62 02:22:07 INFO - PROCESS | 1675 | Values: 92.0 73.0 87.0 74.0 71.0 72.0 88.0 70.0 74.0 87.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:90.00 stddev:2.27 (2.5%) stddev-sans-first:2.35 02:22:07 INFO - PROCESS | 1675 | Values: 91.0 90.0 90.0 88.0 94.0 87.0 92.0 88.0 89.0 87.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.50 stddev:1.14 (1.2%) stddev-sans-first:0.88 02:22:07 INFO - PROCESS | 1675 | Values: 94.0 97.0 97.0 96.0 95.0 96.0 98.0 96.0 97.0 96.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:88.50 stddev:23.92 (27.0%) stddev-sans-first:25.05 02:22:07 INFO - PROCESS | 1675 | Values: 88.0 90.0 85.0 86.0 89.0 92.0 94.0 150.0 136.0 78.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.06 (1.8%) stddev-sans-first:1.01 02:22:07 INFO - PROCESS | 1675 | Values: 59.0 58.0 58.0 58.0 56.0 59.0 58.0 58.0 57.0 56.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:85.10 Median:70.50 stddev:19.14 (27.1%) stddev-sans-first:19.39 02:22:07 INFO - PROCESS | 1675 | Values: 69.0 76.0 59.0 100.0 115.0 108.0 101.0 79.0 72.0 72.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:89.50 stddev:2.79 (3.1%) stddev-sans-first:2.89 02:22:07 INFO - PROCESS | 1675 | Values: 88.0 89.0 86.0 89.0 87.0 88.0 94.0 90.0 92.0 94.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:157.80 Median:156.00 stddev:15.63 (10.0%) stddev-sans-first:15.99 02:22:07 INFO - PROCESS | 1675 | Values: 146.0 149.0 146.0 170.0 168.0 159.0 147.0 146.0 194.0 153.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.00 stddev:2.95 (1.7%) stddev-sans-first:3.08 02:22:07 INFO - PROCESS | 1675 | Values: 175.0 178.0 178.0 175.0 170.0 173.0 170.0 172.0 171.0 173.0 02:22:07 INFO - PROCESS | 1675 | 02:22:07 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:71.00 stddev:7.97 (11.2%) stddev-sans-first:8.39 02:22:07 INFO - PROCESS | 1675 | Values: 71.0 71.0 70.0 71.0 70.0 68.0 70.0 70.0 85.0 92.0 02:22:07 INFO - PROCESS | 1675 | -------- Summary: end -------- 02:22:07 INFO - PROCESS | 1675 | 02:22:08 INFO - TEST-INFO | 1675: exit 0 02:22:08 INFO - TEST-OK | kraken | took 59843ms 02:22:08 INFO - SUITE-END | took 1176s 02:22:08 INFO - Completed test suite (00:19:36) 02:22:08 INFO - javascript benchmark 02:22:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7352.110748885363, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.7864238824473, 3430.8627654893808, 3474.4267195912676, 3477.982610086949, 3481.2515309208516, 5779.0, 5811.912821307684, 5856.2094117294155, 5956.0172571525645, 6007.819765407034, 5817.534597232222, 5873.0, 5943.554233432499, 5959.374265702093, 6068.968275393183, 5275.155975043994, 5302.072137375943, 5328.0, 5428.077226871422, 5438.510534051935, 5405.297311349519, 5460.399356070829, 5464.371597266306, 5478.287822583078, 5527.972360138194, 5274.446183150791, 5408.35099788024, 5414.972925135369, 5436.021516127095, 5495.203195536625, 5271.499207575274, 5305.363356397218, 5343.973280133613, 5368.114261146906, 5408.810691625774, 5267.3152490176035, 5295.179247216687, 5317.813876514303, 5317.893642127175, 5340.973295133499, 4912.926306105412, 5751.424857514216, 5977.252843394575, 5979.5515336349945, 5987.311459182162, 5425.891482170335, 6183.897474858525, 6228.470580000705, 6256.343083976208, 6298.716557754912, 6303.968480157616, 6312.337204593543, 6312.495000399957, 6314.71583778731, 6337.493000559944, 6023.427774361428, 6035.758569657209, 6049.939500605025, 6062.757489700451, 6065.363136870653, 6199.256089269316, 6305.621662700252, 6353.3329000455215, 6364.109024736541, 6498.675066246668, 6192.752289908353, 6241.875162496724, 6242.906356404657, 6264.812055638338, 6292.748290068346, 6174.320824709278, 6304.716287767062, 6338.0, 6338.873222535523, 6355.269144048401, 6171.444569988723, 6192.504599632019, 6193.876122477525, 6235.594686345373, 6269.7178626961895, 6222.533310001678, 6233.0338797486465, 6248.875022499525, 6258.655773932386, 6279.937200628026, 4989.90020199594, 5055.570276526463, 5082.110630639697, 5084.593232541388, 5084.949150508448, 4441.933370999438, 4486.685931984795, 4495.752733599684, 4543.34121552373, 4585.312203169551, 5806.245188125601, 6054.364291749391, 6058.454739073504, 6135.938640613626, 6155.692215389213, 6334.239891212992, 6359.8092057238355, 6362.77730279438, 6379.106925030499, 6381.712822922979, 5951.256092988377, 5970.8655355482315, 6037.909431358533, 6072.787452439144, 6094.786682466181, 5530.723463826873, 5591.496765291144, 5599.440055994368, 5616.9157462638095, 5638.915416268677, 6478.963365861439, 6551.1155993941165, 6576.802695919035, 6587.374199451045, 6597.505187111082, 6189.226346706661, 6211.720472578654, 6303.275123360872, 6309.022101574264, 6378.968105159444, 6427.646479443675, 6533.314002029719, 6555.180602424697, 6588.04473351371, 6604.735810567524, 6255.687215639291, 6270.529710271657, 6284.905726414199, 6298.779542715983, 6314.747410103728, 5253.343332083489, 6175.536834737502, 6186.4741496971465, 6352.587081839665, 6354.491640668828, 5140.717260550556, 5548.667079975215, 6185.628862268099, 6191.19514463135, 6207.131001659862, 5551.25058117149, 5882.323532793784, 6037.15479832815, 6141.0, 6201.410865967726, 6040.6677632730625, 6099.664518451527, 6101.217066730222, 6122.785702500391, 6129.3564175762685, 6133.76314253068, 6156.26124865019, 6171.56799024064, 6188.319284878569, 6189.04069869171, 6096.969515152396, 6120.60216085953, 6154.3845615438095, 6154.846128846635, 6182.814515564541], "value": 5814.509611684541, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.3894651159305, 509.90821652102625, 518.0907507324645, 544.7960008381476, 573.3607028163598, 38258.61741382585, 40336.59663403369, 40511.59488405111, 40561.59438405615, 43065.35401968965, 41846.0, 42383.0, 42583.0, 42589.14821703564, 42629.57370426295, 9505.334626576125, 9575.808483830318, 9585.568649410758, 9691.176250018756, 9692.757681057994, 9468.526573671323, 9537.427754334762, 9573.377730447499, 9577.80844383112, 9582.760430989247, 7705.267999540035, 9517.714468565953, 9538.761530961747, 9567.425954442755, 9582.760430989212, 9485.193758530533, 9526.285528585384, 9543.618255269781, 9543.952280238589, 9547.236221102296, 8860.955695221483, 8950.104989501064, 8955.776105597348, 8956.910430895672, 8968.327375446803, 40178.0, 40218.59781402207, 40329.596704032876, 40541.39187912184, 40624.796876015724, 3573.26748016656, 3606.783592984429, 3750.456183853353, 4028.979855100735, 4158.979205103986, 27667.861660691568, 28565.57151642727, 29316.413671726445, 30633.324001120007, 30887.691123088705, 3130.2487403023338, 3171.3815805917857, 3265.0, 3328.916777080568, 3330.7002369786837, 504212.0, 508550.45724771137, 514717.0, 515136.8486315126, 516047.0, 56177.71911140418, 56823.71588142033, 56845.43154568484, 56937.145942810894, 56983.0, 51280.23079653808, 52720.20919686208, 57699.0, 58121.8375632485, 59179.70410147922, 15051.0, 15150.54548363551, 15291.006084604465, 15296.388144474096, 15317.004394714308, 12229.69425764363, 12313.938430307791, 12356.814647780291, 12360.44378002992, 12381.195222310522, 14374.921880858978, 14631.487897923522, 14727.779083313759, 14798.964072515037, 14959.0, 3196.872125115016, 6209.875802483925, 6579.631332720217, 6808.353206445379, 7046.964765176142, 896.9327300452362, 936.3819878879907, 1019.4647809899861, 1031.7626945802508, 1066.2269854355686, 22892.542149156925, 26748.59877101845, 30165.09504714862, 30436.086917392513, 30870.228244293623, 1089.3028461784463, 1097.9011888929874, 1099.2085698297212, 1105.4141305108144, 1155.156735583029, 15524.92237538805, 15589.454369097028, 15638.905276630527, 15755.921220393824, 15898.76151857723, 578900.0, 581839.0908045432, 582334.0, 583727.0, 588425.0, 57543.42456575464, 57833.421665783644, 57913.8417231653, 57920.0, 57920.71039644775, 1361.2104979112091, 1400.2578633324354, 1421.7725163973714, 1423.814904062486, 1424.7862820576788, 28986.0, 29667.96162134315, 29727.810887564254, 30196.698033020268, 30747.53878691866, 48890.75554622204, 49124.0, 49248.26127608017, 49254.0, 49311.75344123256, 542324.2883785556, 547838.0, 549844.0, 551266.0, 551410.0, 25482.0, 25621.231363059138, 25953.6106958392, 26025.958961642078, 26117.347066323495, 45354.54645453503, 46319.07361852811, 46501.767491162325, 47050.29424558703, 47186.528134719585, 37793.433098502996, 38698.61301387063, 39791.40312895251, 40611.59388406078, 40832.591674082876, 37130.44304335491, 38930.0267493315, 39840.0, 40072.198556029296, 40188.397174043, 37513.249735005695, 37877.621223787406, 38146.8092659546, 38448.0, 38554.22891542209, 32613.0, 34278.14304642304, 34667.47998780071, 34963.12592185216, 35293.117672058404, 24778.628320574844, 25177.3634713743, 25314.114006010437, 25414.364640884127, 25665.0], "value": 19534.342244825722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.57526605174706, 370.35558128855797, 376.674176837036, 383.0232906089471, 399.87004223627326, 19725.408237752872, 20041.59916801663, 20336.69494957577, 20494.590108197845, 20599.794002059974, 20273.290434834784, 20560.383188504333, 20926.790732092675, 21099.47251318718, 21287.36137915861, 4681.46163191234, 5710.114932185507, 6011.458968692817, 6021.277446706401, 6030.155778191057, 5880.735366908478, 6005.579609427342, 6013.6993150342305, 6022.337542870281, 6022.367651396606, 5711.885762284752, 5858.091995740667, 5931.0, 5935.406459354073, 5954.583179177459, 5623.718814059322, 5906.320773111082, 5906.822795316169, 5914.852128696774, 5920.2007728956905, 5117.48825117489, 5143.971205758863, 5150.072986862363, 5154.587632989389, 5157.355330583677, 20463.0, 25604.74395256042, 25619.871900640377, 25728.614070788954, 25880.96476140952, 2157.5792720419527, 2245.86524808512, 2252.0, 2326.139328448468, 2379.4646204604, 15261.542153735405, 15403.614909627237, 15625.374985000586, 15664.765028524467, 15990.0, 1366.9111507751963, 1776.3072401763322, 1794.676958147533, 1818.690822560168, 1899.819517145869, 116430.41784791107, 121380.39309803482, 121399.0, 121505.0, 121863.3906830469, 10593.258471906893, 10606.257561970742, 10938.835917461245, 11008.834867476995, 11220.775584488265, 13895.58313250604, 13903.652408689864, 13906.51327203543, 13910.234937078558, 13922.303884805719, 8095.190480951976, 8417.747467575982, 8427.41008129425, 8467.195616416431, 8556.529390883561, 6384.585001974857, 8096.878546821802, 8149.348052155813, 8252.876206856901, 8431.789205269917, 6650.767223147167, 6703.960886062668, 6842.832572797709, 6850.280720524373, 6929.029935808991, 1529.8546638069365, 1651.3559711712442, 1839.2183322088058, 1852.935147269839, 1854.4807453912927, 795.121390863088, 849.3417601358873, 949.4588084791602, 949.7368499895123, 996.4071377530358, 16719.6656066878, 20061.699074513894, 21404.143834246457, 22311.549749266247, 22911.88544057269, 1026.9486525673688, 1029.6499190275342, 1053.1574740207802, 1083.4907593431076, 1093.4478088565224, 10939.617113400993, 11131.944340278409, 11986.460609272604, 11992.280463172237, 12079.094067944763, 528747.0, 551486.0, 564787.3452022051, 578850.0, 596845.0, 118249.0, 122054.0, 122858.77141228651, 138725.3063734695, 144148.0, 959.2326139088701, 994.7065615643257, 1003.7340104872361, 1008.6520150548049, 1010.2372708604956, 19576.0, 19820.70268945938, 20008.39974800758, 20038.99805009773, 20131.798682013577, 45378.0, 54245.915081698935, 54373.0, 54404.455955441525, 54974.17538736842, 74666.0, 81501.0, 82423.0, 82508.0, 82677.0, 7963.243491868263, 8101.594920254081, 8192.344612430872, 8260.008798943925, 8300.08699043117, 11553.653390398302, 12870.742585148431, 12899.677508061997, 13070.0, 13073.477060917838, 11145.498452569816, 11271.211015228855, 11329.263597866113, 11426.657200284004, 11561.942190288995, 9330.95334523323, 11114.38870862078, 11269.267497612629, 11394.601188958346, 11426.542938282375, 9507.572159252712, 11500.884991149982, 11608.419579020847, 11669.316057306698, 11869.465874035517, 7990.760277191694, 8004.799880002814, 8111.675532978615, 8172.8365432689825, 8218.096009438837, 9782.777152855893, 10813.729656758644, 11297.548098075986, 11370.54517819278, 11492.253003554742], "value": 9732.138391556497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.4146424358742, 1560.1809050248619, 1829.5700510380059, 1904.628597423503, 1942.0, 6298.7165577549, 7012.474064445174, 8476.915230847697, 9051.592678329474, 9133.725988220347, 7016.543924644894, 7214.314640109194, 8789.121087891208, 8956.507392093432, 8966.641334346617, 2341.239097293378, 2371.620540713486, 2376.1802178248477, 2377.3105799318264, 2380.642903564462, 2022.8078332558457, 2316.884155792212, 2335.789778919897, 2345.0971376020184, 2389.3429306940557, 2346.026399044403, 2349.0955981946904, 2350.7061617297836, 2365.089440565386, 2381.6427535869584, 2307.746147923727, 2321.3036089173265, 2338.462153704649, 2342.2621874109773, 2355.163916809542, 2306.7693230676796, 2323.802476789475, 2336.38085907233, 2336.836421450499, 2340.33300509354, 8863.379563430562, 8907.153820387053, 8978.50618215998, 8981.506017169053, 9049.638014479413, 5291.708956007418, 5311.2298716686255, 5480.835574932718, 5487.862803429906, 5493.450654934514, 3558.7508874378805, 3588.282343531278, 3632.4732913727626, 3653.6894363979095, 3673.963260367389, 1034.2811745836646, 1076.95692172313, 1082.0910435234362, 1094.950727217277, 1101.1961268274204, 11642.825357619642, 11758.706032349173, 11787.469563869647, 11846.940765296205, 11886.702832429259, 4567.451905771262, 4667.789949452283, 4819.867331177171, 4842.0, 4867.221244600847, 9908.900910990798, 10043.799124017625, 10095.495225238708, 10098.0, 10117.988201179824, 5446.21029950655, 5464.7814087436855, 5474.233607294982, 5482.23248745176, 5485.561155107582, 4171.520275168334, 4476.0, 4643.094596553708, 4770.76146192689, 5023.949760502422, 3484.738644601665, 3813.237352529505, 3951.2887680217837, 4091.7749523775883, 4127.318992366226, 1138.6925530106826, 1312.875276848698, 1328.774108401574, 1335.0787956310114, 1335.3123141582093, 799.2686691677167, 897.5280539914545, 917.2157805076697, 919.6022046489298, 951.9095685909828, 5689.061304884648, 5721.713914304268, 5850.822022510024, 5946.226990491208, 6038.486728628028, 437.2784904906929, 441.99558004420186, 447.29550957242475, 988.8813342398959, 996.1234113979651, 2839.843808590506, 3780.2061567070673, 3915.1778126593736, 3949.111449923744, 3955.0310174006977, 10520.263581549218, 10950.945245273722, 10962.671119866416, 10962.890371096188, 10976.506057227443, 10897.237193396386, 10899.400532970763, 10914.181436392302, 10915.126789856793, 10919.290246133976, 8051.4766540174705, 8068.233517815798, 8191.95904020488, 8264.297534709496, 8306.958465207756, 4967.230079337708, 5696.287964004499, 5744.0, 5817.970910145422, 5948.881022379442, 9500.144986951207, 9811.411315321104, 9855.556499957376, 9964.750881228027, 10088.041636044563, 10024.298299119284, 10074.69775906724, 10166.339187952759, 10207.59169633236, 10337.431441270803, 6392.648404337806, 7141.214466408587, 7322.96338518304, 7489.962550187214, 7655.157932627518, 8268.793280168044, 8504.702335418231, 8535.53054582004, 8536.274416674652, 8575.31397488187, 6968.303169682991, 7301.671424785791, 7486.625668716433, 7497.400207983457, 7567.31894129531, 5594.328680558359, 7569.243075692387, 7621.161672215941, 7673.961630191813, 7778.14440411543, 6816.0, 6956.756513522205, 7037.788866334018, 7039.472039596948, 7042.929570704432, 4206.990322322559, 5063.443021267584, 5130.948690513047, 5188.507091826271, 5242.816501422432, 4386.64906807461, 4420.469543654782, 5177.974110129425, 5291.153415453509, 5336.332958380202], "value": 4531.362682021914, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.5466996765563, 289.77976737679364, 301.6681650184797, 310.16720106514003, 314.38694545636014, 4028.7784171870535, 4702.341672165895, 5214.0614689356, 5347.0909945309295, 5447.046766815806, 4346.956530434694, 5290.365156181264, 5384.461553844623, 5385.919211211825, 5402.837914862551, 3538.9115272118147, 4019.7387169834014, 4129.2567337879245, 4148.008955701265, 4159.459270294858, 3072.4776787946103, 3399.694027537521, 4026.5772093930154, 4180.749155050691, 4189.937150942723, 3504.3867323218333, 3813.3898576227807, 4076.612721791425, 4083.6523947097385, 4085.7957102144924, 3437.845296961655, 3623.963760362389, 3634.4548317752283, 3892.746971446847, 4064.0652649890394, 3159.7092108221586, 3472.770323599052, 3610.6930910872607, 3613.927721445583, 3618.113562177257, 4691.061787642485, 4949.307097006422, 5078.923816142761, 5206.76569554371, 5234.293370395024, 4472.373867658531, 4739.3838800955655, 4751.64362672801, 4752.833650822205, 4764.380630518011, 4958.404991401055, 5695.316562012544, 5705.515031222351, 5751.626144300607, 5758.2514273144225, 3541.9468707969145, 3544.759334232998, 3781.565120011179, 3981.960180398217, 3997.120633460634, 5892.440218179266, 6001.939980600182, 6026.9095963560585, 6042.15409842618, 6107.877842443127, 3929.941050884239, 3934.9803250983564, 3937.2125574884567, 3943.38877473992, 3965.504311961005, 3670.1925576373155, 3894.2990261753157, 3997.5003124609425, 4014.571184433376, 4037.454943582579, 4227.408162857202, 4640.373549570765, 4645.790939407735, 4652.836431059573, 4674.182018146811, 5031.52200540948, 5759.963206622848, 5791.536677065825, 5824.3302020267365, 5838.489449536655, 1153.6366044695894, 1277.201748906933, 1312.5734136405706, 1346.4748747988292, 1352.499575157198, 780.2548566119342, 789.0294937227128, 879.9868001979976, 904.8054668246227, 920.5765347939889, 4307.504636966726, 5413.675179489243, 5441.83674489766, 5449.455054494519, 5456.536194423439, 4788.61691064721, 5020.849374518771, 5481.506664400223, 5851.97590421683, 5903.35063143054, 5062.620303477254, 5150.201718733602, 5383.461653834585, 5393.298871146726, 5396.298481197419, 2579.2520169150735, 2592.4296654735926, 2607.674040744907, 2621.934451638724, 2628.895863737235, 3901.258760835489, 4175.016866988217, 4252.702310838274, 4640.95359046412, 5338.786448542015, 5026.824061157915, 5826.077394459818, 6094.695265236721, 6115.449609535163, 6184.876302474016, 5383.946160538345, 5814.418558144152, 5913.526917846562, 6235.438810507076, 6243.37566243372, 4701.435827700561, 4965.8013679452415, 5686.516646085129, 5960.523158147251, 6137.539684523589, 4904.779284932115, 4939.28380384835, 5421.376541697755, 5621.634593751393, 5694.772209111589, 5291.915157392802, 5907.822765317047, 6237.781677641261, 6247.281562620356, 6281.937180628135, 3741.746514917424, 3849.72866009056, 3928.7446315990514, 3937.9015524612114, 3938.5273767148124, 4956.529129732669, 5437.700926449083, 5623.831285061455, 5939.4951429129005, 5994.885217078642, 4957.851264462072, 5018.548330650259, 5619.611665042423, 5834.7082645866685, 5841.970790146022, 5302.469753024667, 5598.580106492111, 5817.0983497557945, 5829.358770535153, 5904.734286957183, 5011.997600479992, 5039.722815245197, 5181.611379146504, 5329.866753331198, 5694.601377903507, 5007.47421520735, 5781.624194427349, 5808.419158084158, 5845.386234445492, 5869.325027621878, 5310.6813591184655, 5674.971625141848, 5696.686682232351, 5705.572082093942, 5718.912596902018], "value": 4072.8090204980526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.4346881167096, 758.9430792690549, 779.4504874063786, 793.984120317594, 866.0257210638032, 14945.775813362794, 15790.289436975336, 15793.28930198141, 17274.56813579658, 18064.916105033673, 16930.661386772288, 16999.980001199936, 17108.401205957794, 17126.914365428154, 17147.314107435686, 868.8566386546212, 901.3870568013748, 904.900460949295, 907.5371560504158, 907.9046700096461, 695.1067877777058, 716.0798374089296, 870.8737233101197, 889.2619126125301, 902.4314681750488, 917.2891009467683, 933.3000249812641, 944.9338546301761, 946.2288235088415, 947.1996163242084, 902.0573500691793, 909.5043201455156, 929.0987741890356, 936.5598168860658, 942.0814705661993, 689.1076056506836, 700.1493185779302, 702.6135625406006, 703.3037293079865, 705.3651713457929, 14509.129452232793, 14659.0, 14711.0, 14771.187584682839, 14935.701285974328, 14089.71820563583, 14146.858531414657, 14181.929090354586, 14204.431822727078, 14395.280235988159, 11390.25963312382, 11460.770784584345, 11581.305121692641, 11615.0, 11758.412079396081, 3697.2235830475634, 3790.298794722985, 3806.71449641278, 3807.866724664651, 3932.5674175840636, 111744.0, 111828.44085779518, 113246.0, 114055.42972285085, 115226.42386788096, 10816.351018938889, 10862.945685271523, 10949.288296260718, 10981.231313807957, 11077.944610276896, 21544.892275538834, 21865.67201491979, 21875.453113672287, 21886.0, 21890.89054554717, 7748.6125693715085, 7767.0, 7802.375809935192, 7946.205379462008, 8040.195980401913, 4240.406343111967, 4272.273713468718, 4279.7251370593885, 4291.077418355007, 4392.165488557164, 3661.212839239576, 3733.0, 3760.4735337052834, 3781.9432708509394, 3786.0156359346215, 632.2918331468784, 654.656305439648, 659.673461636493, 667.216021175127, 687.2817905288985, 620.6183197333697, 634.9492040636738, 638.6423602782364, 666.4068978609042, 669.7488441834312, 9102.7698213938, 9509.476978766234, 9617.902511668826, 10219.540120694586, 10349.534270957825, 548.4241546376289, 564.3312674480753, 574.3681949855126, 644.2494493914537, 674.3020973292619, 4907.901841963212, 4936.679115857458, 4986.526280003394, 4986.850394488171, 5102.489751024942, 94099.52950235204, 106395.0, 107102.46448767862, 129190.0, 143447.0, 75753.86369204466, 114952.0, 116732.41633791776, 117649.0, 118204.40897795456, 86788.0, 101813.49093254487, 102818.48590756998, 103225.0, 104397.91204175874, 8037.0, 8823.676448532771, 9878.16035636979, 9896.653617123655, 10051.145652619609, 42980.78509607557, 53978.73010634922, 56141.43858561526, 57479.0, 58360.0, 71374.92937606043, 72904.27095728974, 79951.2004879967, 83681.58159209165, 87991.56004219937, 13083.215007099605, 13100.934495327463, 13120.449127277736, 13161.53934612284, 13632.318384080954, 14339.354729037426, 14460.06009609372, 14585.489507867174, 14784.852151478777, 14990.925045374703, 13346.799798002843, 13512.797308040585, 13544.458221671417, 13582.388792504558, 13797.037044384944, 13557.389917453935, 13859.237741923887, 13928.860711392756, 14159.929200354345, 14224.715505690036, 10754.139668826632, 13220.202662112299, 13564.38960246811, 13755.79366309526, 13836.37736301889, 11055.668329950115, 11064.28082174656, 11370.31778093317, 11506.597269095542, 11512.366819824654, 7011.964940175267, 9128.406653567497, 9166.22087122602, 10993.450327483433, 11420.257683250562], "value": 7740.75854030531, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 116.0, 118.0, 115.0, 116.0, 118.0, 117.0, 116.0, 119.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 137.0, 144.0, 181.0, 117.0, 118.0, 148.0, 138.0, 141.0, 118.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 204.0, 219.0, 193.0, 193.0, 195.0, 199.0, 196.0, 195.0], "value": 199.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 61.0, 60.0, 85.0, 61.0, 66.0, 52.0, 70.0, 100.0, 50.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 87.0, 74.0, 71.0, 72.0, 88.0, 70.0, 74.0, 87.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 90.0, 88.0, 94.0, 87.0, 92.0, 88.0, 89.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 97.0, 96.0, 95.0, 96.0, 98.0, 96.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 85.0, 86.0, 89.0, 92.0, 94.0, 150.0, 136.0, 78.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 56.0, 59.0, 58.0, 58.0, 57.0, 56.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 59.0, 100.0, 115.0, 108.0, 101.0, 79.0, 72.0, 72.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 86.0, 89.0, 87.0, 88.0, 94.0, 90.0, 92.0, 94.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 146.0, 170.0, 168.0, 159.0, 147.0, 146.0, 194.0, 153.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 178.0, 175.0, 170.0, 173.0, 170.0, 172.0, 171.0, 173.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 71.0, 70.0, 68.0, 70.0, 70.0, 85.0, 92.0], "value": 73.8, "unit": "score"}]}]} 02:22:08 INFO - Return code: 0 02:22:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:08 ERROR - # TBPL SUCCESS # 02:22:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:08 INFO - 2016-10-18 02:22:08.712 screenresolution[1680:12267] starting screenresolution argv=screenresolution get 02:22:08 INFO - 2016-10-18 02:22:08.715 screenresolution[1680:12267] Display 0: 1600x1200x32@60 02:22:08 INFO - 2016-10-18 02:22:08.721 screenresolution[1681:12270] starting screenresolution argv=screenresolution list 02:22:08 INFO - Available Modes on Display 0 02:22:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:08 INFO - Intel Iris: 02:22:08 INFO - Chipset Model: Intel Iris 02:22:08 INFO - Type: GPU 02:22:08 INFO - Bus: Built-In 02:22:08 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:08 INFO - Vendor: Intel (0x8086) 02:22:08 INFO - Device ID: 0x0a2e 02:22:08 INFO - Revision ID: 0x0009 02:22:08 INFO - Displays: 02:22:08 INFO - Display: 02:22:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:08 INFO - Display Serial Number: 1600x1200 60 02:22:08 INFO - Main Display: Yes 02:22:08 INFO - Mirror: Off 02:22:08 INFO - Online: Yes 02:22:08 INFO - Rotation: Supported 02:22:08 INFO - Return code: 0 02:22:08 INFO - Running post-action listener: _resource_record_post_action 02:22:08 INFO - [mozharness: 2016-10-18 09:22:08.957276Z] Finished run-tests step (success) 02:22:08 INFO - Running post-run listener: _resource_record_post_run 02:22:09 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 33001984; Write bytes: 712407040; Read time: 202; Write time: 2047 02:22:09 INFO - TinderboxPrint: CPU usage
54.4% 02:22:09 INFO - TinderboxPrint: I/O read bytes / time
33,001,984 / 202 02:22:09 INFO - TinderboxPrint: I/O write bytes / time
712,407,040 / 2,047 02:22:09 INFO - TinderboxPrint: CPU idle
2,210.8 (45.6%) 02:22:09 INFO - TinderboxPrint: CPU system
977.3 (20.2%) 02:22:09 INFO - TinderboxPrint: CPU user
1,657.6 (34.2%) 02:22:09 INFO - TinderboxPrint: Swap in / out
435,220,480 / 0 02:22:09 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393349632; Write bytes: 387664896; Read time: 29262; Write time: 830 02:22:09 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31207936; Write bytes: 301321216; Read time: 186; Write time: 1161 02:22:09 INFO - Running post-run listener: _upload_blobber_files 02:22:09 INFO - Blob upload gear active. 02:22:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:09 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 02:22:09 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'] 02:22:09 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 02:22:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:10 INFO - (blobuploader) - INFO - Done attempting. 02:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:22:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:11 INFO - (blobuploader) - INFO - Done attempting. 02:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:13 INFO - (blobuploader) - INFO - Done attempting. 02:22:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:13 INFO - Return code: 0 02:22:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dc940f5de516fdbcafd7b167892ed6c1a25355659be507ab16511085804f16e1f30bd3f0f6e4ed5536da4c7a6c35b68d09f0fcee8998fcf2ec528f588fbd6932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc4d92618fccf018fa9a5f36c2d1912715c8c952d0721b1b1b0c6d7655283431327ed48c8557ed9d18add0353a5551dd9571eaedcbc426b1d52e1b17409d2c70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/acbd6d189d97760afa99c44bed44d6695aba990932ef5d78739988e314649f96de5f2a75f67c217adb35b0d1e0423b202e8716d96a0e914902d572ce5e28b1ad"} 02:22:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:13 INFO - Contents: 02:22:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dc940f5de516fdbcafd7b167892ed6c1a25355659be507ab16511085804f16e1f30bd3f0f6e4ed5536da4c7a6c35b68d09f0fcee8998fcf2ec528f588fbd6932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc4d92618fccf018fa9a5f36c2d1912715c8c952d0721b1b1b0c6d7655283431327ed48c8557ed9d18add0353a5551dd9571eaedcbc426b1d52e1b17409d2c70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/acbd6d189d97760afa99c44bed44d6695aba990932ef5d78739988e314649f96de5f2a75f67c217adb35b0d1e0423b202e8716d96a0e914902d572ce5e28b1ad"} 02:22:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:13 INFO - Copying logs to upload dir... 02:22:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.007911 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-18 02:22:13.732779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 02:22:13.736360) ========= 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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dc940f5de516fdbcafd7b167892ed6c1a25355659be507ab16511085804f16e1f30bd3f0f6e4ed5536da4c7a6c35b68d09f0fcee8998fcf2ec528f588fbd6932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc4d92618fccf018fa9a5f36c2d1912715c8c952d0721b1b1b0c6d7655283431327ed48c8557ed9d18add0353a5551dd9571eaedcbc426b1d52e1b17409d2c70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/acbd6d189d97760afa99c44bed44d6695aba990932ef5d78739988e314649f96de5f2a75f67c217adb35b0d1e0423b202e8716d96a0e914902d572ce5e28b1ad"} build_url:https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/Xotls7A1TEGHHpVtIF3WoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dc940f5de516fdbcafd7b167892ed6c1a25355659be507ab16511085804f16e1f30bd3f0f6e4ed5536da4c7a6c35b68d09f0fcee8998fcf2ec528f588fbd6932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc4d92618fccf018fa9a5f36c2d1912715c8c952d0721b1b1b0c6d7655283431327ed48c8557ed9d18add0353a5551dd9571eaedcbc426b1d52e1b17409d2c70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/acbd6d189d97760afa99c44bed44d6695aba990932ef5d78739988e314649f96de5f2a75f67c217adb35b0d1e0423b202e8716d96a0e914902d572ce5e28b1ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 02:22:13.768935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 02:22:13.769254) ========= 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.P3NQlZ32Zo/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.HVJ7Ahx7oi/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 02:22:13.817707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 02:22:13.818020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 02:22:13.818338) ========= ========= Total master_lag: 0.43 =========