builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1481123942.06 results: success (0) buildid: 20161207062738 builduid: 865d439b197647eeb575deaeee89acc3 revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.059478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.059909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.060215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.076544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.076820) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 07:19:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.4M=0s 2016-12-07 07:19:02 (38.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129397 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.219371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.219664) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.269465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.269831) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2526f6786f074888d71c8e166a02aea3e19e75b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c2526f6786f074888d71c8e166a02aea3e19e75b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 07:19:02,755 truncating revision to first 12 chars 2016-12-07 07:19:02,755 Setting DEBUG logging. 2016-12-07 07:19:02,755 attempt 1/10 2016-12-07 07:19:02,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2526f6786f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 07:19:03,057 unpacking tar archive at: mozilla-central-c2526f6786f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.948269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.948562) ========= script_repo_revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.948948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.949213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:19:02.957669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-12-07 07:19:02.957936) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:19:03 INFO - MultiFileLogger online at 20161207 07:19:03 in /builds/slave/test 07:19:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:19:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:19:03 INFO - {'append_to_log': False, 07:19:03 INFO - 'base_work_dir': '/builds/slave/test', 07:19:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:19:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:19:03 INFO - 'branch': 'Firefox-Non-PGO', 07:19:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:19:03 INFO - 'config_files': ('talos/linux_config.py',), 07:19:03 INFO - 'default_actions': ('clobber', 07:19:03 INFO - 'read-buildbot-config', 07:19:03 INFO - 'download-and-extract', 07:19:03 INFO - 'populate-webroot', 07:19:03 INFO - 'create-virtualenv', 07:19:03 INFO - 'install', 07:19:03 INFO - 'run-tests'), 07:19:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:19:03 INFO - 'download_minidump_stackwalk': True, 07:19:03 INFO - 'download_symbols': 'ondemand', 07:19:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:19:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:19:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:19:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:19:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:19:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:19:03 INFO - 'installer_path': 'installer.exe', 07:19:03 INFO - 'log_level': 'info', 07:19:03 INFO - 'log_name': 'talos', 07:19:03 INFO - 'log_to_console': True, 07:19:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:19:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:19:03 INFO - 'opt_config_files': (), 07:19:03 INFO - 'pip_index': False, 07:19:03 INFO - 'sps_profile': False, 07:19:03 INFO - 'sps_profile_interval': 0, 07:19:03 INFO - 'suite': 'dromaeojs', 07:19:03 INFO - 'system_bits': '32', 07:19:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:19:03 INFO - 'title': 'talos-linux64-ix-038', 07:19:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:19:03 INFO - 'use_talos_json': True, 07:19:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:19:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:19:03 INFO - 'work_dir': 'build'} 07:19:03 INFO - [mozharness: 2016-12-07 15:19:03.541913Z] Running clobber step. 07:19:03 INFO - Running pre-action listener: _resource_record_pre_action 07:19:03 INFO - Running main action method: clobber 07:19:03 INFO - rmtree: /builds/slave/test/build 07:19:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:19:04 INFO - Running post-action listener: _resource_record_post_action 07:19:04 INFO - [mozharness: 2016-12-07 15:19:04.531130Z] Finished clobber step (success) 07:19:04 INFO - [mozharness: 2016-12-07 15:19:04.531228Z] Running read-buildbot-config step. 07:19:04 INFO - Running pre-action listener: _resource_record_pre_action 07:19:04 INFO - Running main action method: read_buildbot_config 07:19:04 INFO - Using buildbot properties: 07:19:04 INFO - { 07:19:04 INFO - "project": "", 07:19:04 INFO - "product": "firefox", 07:19:04 INFO - "script_repo_revision": "production", 07:19:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:19:04 INFO - "repository": "", 07:19:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:19:04 INFO - "buildid": "20161207062738", 07:19:04 INFO - "pgo_build": "False", 07:19:04 INFO - "basedir": "/builds/slave/test", 07:19:04 INFO - "buildnumber": 331, 07:19:04 INFO - "slavename": "talos-linux64-ix-038", 07:19:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:19:04 INFO - "platform": "ubuntu64_hw", 07:19:04 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:19:04 INFO - "branch": "mozilla-central", 07:19:04 INFO - "repo_path": "mozilla-central", 07:19:04 INFO - "revision": "c2526f6786f074888d71c8e166a02aea3e19e75b", 07:19:04 INFO - "stage_platform": "linux64", 07:19:04 INFO - "builduid": "865d439b197647eeb575deaeee89acc3", 07:19:04 INFO - "slavebuilddir": "test" 07:19:04 INFO - } 07:19:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:19:04 INFO - Running post-action listener: _resource_record_post_action 07:19:04 INFO - [mozharness: 2016-12-07 15:19:04.533631Z] Finished read-buildbot-config step (success) 07:19:04 INFO - [mozharness: 2016-12-07 15:19:04.533718Z] Running download-and-extract step. 07:19:04 INFO - Running pre-action listener: _resource_record_pre_action 07:19:04 INFO - Running main action method: download_and_extract 07:19:04 INFO - mkdir: /builds/slave/test/build/tests 07:19:04 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')]} 07:19:04 INFO - trying https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:19:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:19:05 INFO - Downloaded 1361 bytes. 07:19:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:19:05 INFO - Using the following test package requirements: 07:19:05 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:19:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:19:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:19:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'jsshell-linux-x86_64.zip'], 07:19:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:19:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:19:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:19:05 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:19:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:19:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:19:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:19:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:19:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:19:06 INFO - Expected file size: 20219060 07:19:06 INFO - Obtained file size: 20219060 07:19:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:19:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:19:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:19:11 INFO - Expected file size: 20219060 07:19:11 INFO - Obtained file size: 20219060 07:19:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:19:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:19:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:19:16 INFO - Expected file size: 14409734 07:19:16 INFO - Obtained file size: 14409734 07:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:17 INFO - trying https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:19:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:19:20 INFO - Downloaded 55705145 bytes. 07:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:19:20 INFO - mkdir: /builds/slave/test/properties 07:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:19:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:19:20 INFO - Contents: 07:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:19:21 INFO - Running post-action listener: _resource_record_post_action 07:19:21 INFO - Running post-action listener: set_extra_try_arguments 07:19:21 INFO - [mozharness: 2016-12-07 15:19:21.437732Z] Finished download-and-extract step (success) 07:19:21 INFO - [mozharness: 2016-12-07 15:19:21.437959Z] Running populate-webroot step. 07:19:21 INFO - Running pre-action listener: _resource_record_pre_action 07:19:21 INFO - Running main action method: populate_webroot 07:19:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:19:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:19:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:19:21 INFO - '--tppagecycles', 07:19:21 INFO - '7'], 07:19:21 INFO - 'tests': ['tsvgm']}}, 07:19:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:19:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:19:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:19:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:19:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['damp', 'tps']}, 07:19:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'tests': ['damp', 'tps']}, 07:19:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['dromaeo_dom']}, 07:19:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:19:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['basic_compositor_video']}, 07:19:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:19:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['a11yr', 07:19:21 INFO - 'ts_paint', 07:19:21 INFO - 'tpaint', 07:19:21 INFO - 'sessionrestore', 07:19:21 INFO - 'sessionrestore_no_auto_restore', 07:19:21 INFO - 'tabpaint']}, 07:19:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:19:21 INFO - 'ts_paint', 07:19:21 INFO - 'tpaint', 07:19:21 INFO - 'sessionrestore', 07:19:21 INFO - 'sessionrestore_no_auto_restore', 07:19:21 INFO - 'tabpaint']}, 07:19:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:19:21 INFO - 'ts_paint', 07:19:21 INFO - 'tpaint', 07:19:21 INFO - 'sessionrestore', 07:19:21 INFO - 'sessionrestore_no_auto_restore', 07:19:21 INFO - 'tabpaint']}, 07:19:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:19:21 INFO - 'ts_paint', 07:19:21 INFO - 'tpaint', 07:19:21 INFO - 'sessionrestore', 07:19:21 INFO - 'sessionrestore_no_auto_restore', 07:19:21 INFO - 'tabpaint']}, 07:19:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['a11yr', 07:19:21 INFO - 'ts_paint', 07:19:21 INFO - 'tpaint', 07:19:21 INFO - 'sessionrestore', 07:19:21 INFO - 'sessionrestore_no_auto_restore', 07:19:21 INFO - 'tabpaint']}, 07:19:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['a11yr', 07:19:21 INFO - 'ts_paint', 07:19:21 INFO - 'tpaint', 07:19:21 INFO - 'sessionrestore', 07:19:21 INFO - 'sessionrestore_no_auto_restore', 07:19:21 INFO - 'tabpaint']}, 07:19:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['tsvgx', 07:19:21 INFO - 'tsvgr_opacity', 07:19:21 INFO - 'tart', 07:19:21 INFO - 'tscrollx', 07:19:21 INFO - 'cart', 07:19:21 INFO - 'tsvg_static']}, 07:19:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:19:21 INFO - 'tsvgr_opacity', 07:19:21 INFO - 'tart', 07:19:21 INFO - 'tscrollx', 07:19:21 INFO - 'cart', 07:19:21 INFO - 'tsvg_static']}, 07:19:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'talos_options': ['--disable-e10s'], 07:19:21 INFO - 'tests': ['tp5o']}, 07:19:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:19:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'talos_options': ['--disable-e10s', 07:19:21 INFO - '--xperf_path', 07:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:21 INFO - 'tests': ['tp5n']}, 07:19:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:19:21 INFO - 'talos_options': ['--xperf_path', 07:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:21 INFO - 'tests': ['tp5n']}}, 07:19:21 INFO - 'talos.zip': {'path': '', 07:19:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:19:21 INFO - Running post-action listener: _resource_record_post_action 07:19:21 INFO - [mozharness: 2016-12-07 15:19:21.455765Z] Finished populate-webroot step (success) 07:19:21 INFO - [mozharness: 2016-12-07 15:19:21.455852Z] Running create-virtualenv step. 07:19:21 INFO - Running pre-action listener: _resource_record_pre_action 07:19:21 INFO - Running main action method: create_virtualenv 07:19:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:19:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:19:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:19:21 INFO - Using real prefix '/usr' 07:19:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:19:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:19:24 INFO - Installing pip.................done. 07:19:24 INFO - Return code: 0 07:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:19:24 INFO - Reading from file tmpfile_stdout 07:19:24 INFO - Output received: 07:19:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:19:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:19:24 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')]} 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 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')]} 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:24 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 07:19:24 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 07:19:24 INFO - Using env: {'DISPLAY': ':0', 07:19:24 INFO - 'HOME': '/home/cltbld', 07:19:24 INFO - 'LANG': 'en_US.UTF-8', 07:19:24 INFO - 'LANGUAGE': 'en_US:en', 07:19:24 INFO - 'LOGNAME': 'cltbld', 07:19:24 INFO - 'MAIL': '/var/mail/cltbld', 07:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:24 INFO - 'MOZ_NO_REMOTE': '1', 07:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:24 INFO - 'NO_EM_RESTART': '1', 07:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:24 INFO - 'PWD': '/builds/slave/test', 07:19:24 INFO - 'SHELL': '/bin/bash', 07:19:24 INFO - 'SHLVL': '1', 07:19:24 INFO - 'TERM': 'linux', 07:19:24 INFO - 'TMOUT': '86400', 07:19:24 INFO - 'USER': 'cltbld', 07:19:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:24 INFO - '_': '/tools/buildbot/bin/python'} 07:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:24 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 07:19:24 INFO - Cleaning up... 07:19:24 INFO - Return code: 0 07:19:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:19:24 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')]} 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 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')]} 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:24 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 07:19:24 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 07:19:24 INFO - Using env: {'DISPLAY': ':0', 07:19:24 INFO - 'HOME': '/home/cltbld', 07:19:24 INFO - 'LANG': 'en_US.UTF-8', 07:19:24 INFO - 'LANGUAGE': 'en_US:en', 07:19:24 INFO - 'LOGNAME': 'cltbld', 07:19:24 INFO - 'MAIL': '/var/mail/cltbld', 07:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:24 INFO - 'MOZ_NO_REMOTE': '1', 07:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:24 INFO - 'NO_EM_RESTART': '1', 07:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:24 INFO - 'PWD': '/builds/slave/test', 07:19:24 INFO - 'SHELL': '/bin/bash', 07:19:24 INFO - 'SHLVL': '1', 07:19:24 INFO - 'TERM': 'linux', 07:19:24 INFO - 'TMOUT': '86400', 07:19:24 INFO - 'USER': 'cltbld', 07:19:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:24 INFO - '_': '/tools/buildbot/bin/python'} 07:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:24 INFO - Downloading/unpacking psutil>=3.1.1 07:19:24 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 07:19:24 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 07:19:24 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 07:19:24 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 07:19:24 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 07:19:24 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 07:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:26 INFO - Installing collected packages: psutil 07:19:26 INFO - Running setup.py install for psutil 07:19:26 INFO - building 'psutil._psutil_linux' extension 07:19:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:19:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:19:27 INFO - building 'psutil._psutil_posix' extension 07:19:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:19:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:27 INFO - Successfully installed psutil 07:19:27 INFO - Cleaning up... 07:19:27 INFO - Return code: 0 07:19:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:19:27 INFO - Using env: {'DISPLAY': ':0', 07:19:27 INFO - 'HOME': '/home/cltbld', 07:19:27 INFO - 'LANG': 'en_US.UTF-8', 07:19:27 INFO - 'LANGUAGE': 'en_US:en', 07:19:27 INFO - 'LOGNAME': 'cltbld', 07:19:27 INFO - 'MAIL': '/var/mail/cltbld', 07:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:27 INFO - 'MOZ_NO_REMOTE': '1', 07:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:27 INFO - 'NO_EM_RESTART': '1', 07:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:27 INFO - 'PWD': '/builds/slave/test', 07:19:27 INFO - 'SHELL': '/bin/bash', 07:19:27 INFO - 'SHLVL': '1', 07:19:27 INFO - 'TERM': 'linux', 07:19:27 INFO - 'TMOUT': '86400', 07:19:27 INFO - 'USER': 'cltbld', 07:19:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:27 INFO - '_': '/tools/buildbot/bin/python'} 07:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:19:27 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 07:19:27 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 07:19:27 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 07:19:27 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 07:19:27 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 07:19:27 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 07:19:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:19:29 INFO - Installing collected packages: mozsystemmonitor 07:19:29 INFO - Running setup.py install for mozsystemmonitor 07:19:29 INFO - Successfully installed mozsystemmonitor 07:19:29 INFO - Cleaning up... 07:19:29 INFO - Return code: 0 07:19:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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', '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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:19: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 jsonschema==2.5.1 07:19:29 INFO - Using env: {'DISPLAY': ':0', 07:19:29 INFO - 'HOME': '/home/cltbld', 07:19:29 INFO - 'LANG': 'en_US.UTF-8', 07:19:29 INFO - 'LANGUAGE': 'en_US:en', 07:19:29 INFO - 'LOGNAME': 'cltbld', 07:19:29 INFO - 'MAIL': '/var/mail/cltbld', 07:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:29 INFO - 'MOZ_NO_REMOTE': '1', 07:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:29 INFO - 'NO_EM_RESTART': '1', 07:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:29 INFO - 'PWD': '/builds/slave/test', 07:19:29 INFO - 'SHELL': '/bin/bash', 07:19:29 INFO - 'SHLVL': '1', 07:19:29 INFO - 'TERM': 'linux', 07:19:29 INFO - 'TMOUT': '86400', 07:19:29 INFO - 'USER': 'cltbld', 07:19:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:29 INFO - '_': '/tools/buildbot/bin/python'} 07:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:19:31 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 07:19:31 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 07:19:31 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 07:19:31 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 07:19:31 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 07:19:31 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 07:19:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:32 INFO - warning: no files found matching '*.txt' 07:19:32 INFO - no previously-included directories found matching 'build' 07:19:32 INFO - no previously-included directories found matching 'dist' 07:19:32 INFO - no previously-included directories found matching '.git*' 07:19:32 INFO - Installing collected packages: jsonschema, functools32 07:19:32 INFO - Running setup.py install for functools32 07:19:32 INFO - warning: no files found matching '*.txt' 07:19:32 INFO - no previously-included directories found matching 'build' 07:19:32 INFO - no previously-included directories found matching 'dist' 07:19:32 INFO - no previously-included directories found matching '.git*' 07:19:32 INFO - Successfully installed jsonschema functools32 07:19:32 INFO - Cleaning up... 07:19:32 INFO - Return code: 0 07:19:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:19:32 INFO - Using env: {'DISPLAY': ':0', 07:19:32 INFO - 'HOME': '/home/cltbld', 07:19:32 INFO - 'LANG': 'en_US.UTF-8', 07:19:32 INFO - 'LANGUAGE': 'en_US:en', 07:19:32 INFO - 'LOGNAME': 'cltbld', 07:19:32 INFO - 'MAIL': '/var/mail/cltbld', 07:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:32 INFO - 'MOZ_NO_REMOTE': '1', 07:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:32 INFO - 'NO_EM_RESTART': '1', 07:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:32 INFO - 'PWD': '/builds/slave/test', 07:19:32 INFO - 'SHELL': '/bin/bash', 07:19:32 INFO - 'SHLVL': '1', 07:19:32 INFO - 'TERM': 'linux', 07:19:32 INFO - 'TMOUT': '86400', 07:19:32 INFO - 'USER': 'cltbld', 07:19:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:32 INFO - '_': '/tools/buildbot/bin/python'} 07:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:19:32 INFO - Cleaning up... 07:19:32 INFO - Return code: 0 07:19:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:19:32 INFO - Using env: {'DISPLAY': ':0', 07:19:32 INFO - 'HOME': '/home/cltbld', 07:19:32 INFO - 'LANG': 'en_US.UTF-8', 07:19:32 INFO - 'LANGUAGE': 'en_US:en', 07:19:32 INFO - 'LOGNAME': 'cltbld', 07:19:32 INFO - 'MAIL': '/var/mail/cltbld', 07:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:32 INFO - 'MOZ_NO_REMOTE': '1', 07:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:32 INFO - 'NO_EM_RESTART': '1', 07:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:32 INFO - 'PWD': '/builds/slave/test', 07:19:32 INFO - 'SHELL': '/bin/bash', 07:19:32 INFO - 'SHLVL': '1', 07:19:32 INFO - 'TERM': 'linux', 07:19:32 INFO - 'TMOUT': '86400', 07:19:32 INFO - 'USER': 'cltbld', 07:19:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:32 INFO - '_': '/tools/buildbot/bin/python'} 07:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:35 INFO - Downloading docopt-0.6.1.tar.gz 07:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:35 INFO - Running setup.py install for blobuploader 07:19:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:35 INFO - Running setup.py install for requests 07:19:36 INFO - Running setup.py install for docopt 07:19:36 INFO - Successfully installed blobuploader requests docopt 07:19:36 INFO - Cleaning up... 07:19:36 INFO - Return code: 0 07:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:36 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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:36 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 07:19:36 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 07:19:36 INFO - Using env: {'DISPLAY': ':0', 07:19:36 INFO - 'HOME': '/home/cltbld', 07:19:36 INFO - 'LANG': 'en_US.UTF-8', 07:19:36 INFO - 'LANGUAGE': 'en_US:en', 07:19:36 INFO - 'LOGNAME': 'cltbld', 07:19:36 INFO - 'MAIL': '/var/mail/cltbld', 07:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:36 INFO - 'MOZ_NO_REMOTE': '1', 07:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:36 INFO - 'NO_EM_RESTART': '1', 07:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:36 INFO - 'PWD': '/builds/slave/test', 07:19:36 INFO - 'SHELL': '/bin/bash', 07:19:36 INFO - 'SHLVL': '1', 07:19:36 INFO - 'TERM': 'linux', 07:19:36 INFO - 'TMOUT': '86400', 07:19:36 INFO - 'USER': 'cltbld', 07:19:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:36 INFO - '_': '/tools/buildbot/bin/python'} 07:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:36 INFO - Running setup.py (path:/tmp/pip-csCJt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:36 INFO - Running setup.py (path:/tmp/pip-Lsas0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:36 INFO - Running setup.py (path:/tmp/pip-fO4Oo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:36 INFO - Running setup.py (path:/tmp/pip-TwSb2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:36 INFO - Running setup.py (path:/tmp/pip-hMb5Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:36 INFO - Running setup.py (path:/tmp/pip-3F8bTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:36 INFO - Running setup.py (path:/tmp/pip-G1_FFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:36 INFO - Running setup.py (path:/tmp/pip-gjAolt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:37 INFO - Running setup.py (path:/tmp/pip-ripHuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:37 INFO - Running setup.py (path:/tmp/pip-nmtLGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:37 INFO - Running setup.py (path:/tmp/pip-p1PAj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:37 INFO - Running setup.py (path:/tmp/pip-hQvJ6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:37 INFO - Running setup.py (path:/tmp/pip-d66slF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:37 INFO - Running setup.py (path:/tmp/pip-xb7Rcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:37 INFO - Running setup.py (path:/tmp/pip-2yovFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:37 INFO - Running setup.py (path:/tmp/pip-_yTJ3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:37 INFO - Running setup.py (path:/tmp/pip-zEOpSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:37 INFO - Running setup.py install for manifestparser 07:19:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:37 INFO - Running setup.py install for mozcrash 07:19:37 INFO - Running setup.py install for mozdebug 07:19:37 INFO - Running setup.py install for mozdevice 07:19:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Running setup.py install for mozfile 07:19:38 INFO - Running setup.py install for mozhttpd 07:19:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Running setup.py install for mozinfo 07:19:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Running setup.py install for mozInstall 07:19:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Running setup.py install for mozleak 07:19:38 INFO - Running setup.py install for mozlog 07:19:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Running setup.py install for moznetwork 07:19:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:38 INFO - Running setup.py install for mozprocess 07:19:38 INFO - Running setup.py install for mozprofile 07:19:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:39 INFO - Running setup.py install for mozrunner 07:19:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:39 INFO - Running setup.py install for mozscreenshot 07:19:39 INFO - Running setup.py install for moztest 07:19:39 INFO - Running setup.py install for mozversion 07:19:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:39 INFO - Cleaning up... 07:19:39 INFO - Return code: 0 07:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:39 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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:39 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 07:19:39 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 07:19:39 INFO - Using env: {'DISPLAY': ':0', 07:19:39 INFO - 'HOME': '/home/cltbld', 07:19:39 INFO - 'LANG': 'en_US.UTF-8', 07:19:39 INFO - 'LANGUAGE': 'en_US:en', 07:19:39 INFO - 'LOGNAME': 'cltbld', 07:19:39 INFO - 'MAIL': '/var/mail/cltbld', 07:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:39 INFO - 'MOZ_NO_REMOTE': '1', 07:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:39 INFO - 'NO_EM_RESTART': '1', 07:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:39 INFO - 'PWD': '/builds/slave/test', 07:19:39 INFO - 'SHELL': '/bin/bash', 07:19:39 INFO - 'SHLVL': '1', 07:19:39 INFO - 'TERM': 'linux', 07:19:39 INFO - 'TMOUT': '86400', 07:19:39 INFO - 'USER': 'cltbld', 07:19:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:39 INFO - '_': '/tools/buildbot/bin/python'} 07:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:39 INFO - Running setup.py (path:/tmp/pip-jWi5XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:39 INFO - Running setup.py (path:/tmp/pip-SgQSwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:39 INFO - Running setup.py (path:/tmp/pip-y8VAtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:39 INFO - Running setup.py (path:/tmp/pip-Pq8rFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:39 INFO - Running setup.py (path:/tmp/pip-gYTo8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:40 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)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:40 INFO - Running setup.py (path:/tmp/pip-QkpC9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:40 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)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:40 INFO - Running setup.py (path:/tmp/pip-nJc_Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:40 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)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:40 INFO - Running setup.py (path:/tmp/pip-6HCHEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:40 INFO - Running setup.py (path:/tmp/pip-dJg5pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:40 INFO - Running setup.py (path:/tmp/pip-0C9knI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:40 INFO - Running setup.py (path:/tmp/pip-sLlIg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:40 INFO - Running setup.py (path:/tmp/pip-rtxV7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:40 INFO - Running setup.py (path:/tmp/pip-AnZ35q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:40 INFO - Running setup.py (path:/tmp/pip-fHptAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:40 INFO - Running setup.py (path:/tmp/pip-IDZ5N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:40 INFO - Running setup.py (path:/tmp/pip-_ku2LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:40 INFO - Running setup.py (path:/tmp/pip-QXIiT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:40 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)) 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:40 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)) 07:19:40 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:40 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:42 INFO - Downloading blessings-1.6.tar.gz 07:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:42 INFO - Installing collected packages: blessings 07:19:42 INFO - Running setup.py install for blessings 07:19:43 INFO - Successfully installed blessings 07:19:43 INFO - Cleaning up... 07:19:43 INFO - Return code: 0 07:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:43 INFO - Reading from file tmpfile_stdout 07:19:43 INFO - Current package versions: 07:19:43 INFO - argparse == 1.2.1 07:19:43 INFO - blessings == 1.6 07:19:43 INFO - blobuploader == 1.2.4 07:19:43 INFO - docopt == 0.6.1 07:19:43 INFO - functools32 == 3.2.3-2 07:19:43 INFO - jsonschema == 2.5.1 07:19:43 INFO - manifestparser == 1.1 07:19:43 INFO - mozInstall == 1.12 07:19:43 INFO - mozcrash == 1.0 07:19:43 INFO - mozdebug == 0.1 07:19:43 INFO - mozdevice == 0.49 07:19:43 INFO - mozfile == 1.2 07:19:43 INFO - mozhttpd == 0.7 07:19:43 INFO - mozinfo == 0.9 07:19:43 INFO - mozleak == 0.1 07:19:43 INFO - mozlog == 3.4 07:19:43 INFO - moznetwork == 0.27 07:19:43 INFO - mozprocess == 0.23 07:19:43 INFO - mozprofile == 0.28 07:19:43 INFO - mozrunner == 6.13 07:19:43 INFO - mozscreenshot == 0.1 07:19:43 INFO - mozsystemmonitor == 0.3 07:19:43 INFO - moztest == 0.7 07:19:43 INFO - mozversion == 1.4 07:19:43 INFO - psutil == 3.1.1 07:19:43 INFO - requests == 1.2.3 07:19:43 INFO - wsgiref == 0.1.2 07:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:43 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')]} 07:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:43 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')]} 07:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:43 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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:43 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 07:19:43 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 07:19:43 INFO - Using env: {'DISPLAY': ':0', 07:19:43 INFO - 'HOME': '/home/cltbld', 07:19:43 INFO - 'LANG': 'en_US.UTF-8', 07:19:43 INFO - 'LANGUAGE': 'en_US:en', 07:19:43 INFO - 'LOGNAME': 'cltbld', 07:19:43 INFO - 'MAIL': '/var/mail/cltbld', 07:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:43 INFO - 'MOZ_NO_REMOTE': '1', 07:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:43 INFO - 'NO_EM_RESTART': '1', 07:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:43 INFO - 'PWD': '/builds/slave/test', 07:19:43 INFO - 'SHELL': '/bin/bash', 07:19:43 INFO - 'SHLVL': '1', 07:19:43 INFO - 'TERM': 'linux', 07:19:43 INFO - 'TMOUT': '86400', 07:19:43 INFO - 'USER': 'cltbld', 07:19:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:43 INFO - '_': '/tools/buildbot/bin/python'} 07:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 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)) 07:19:43 INFO - Cleaning up... 07:19:43 INFO - Return code: 0 07:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:43 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')]} 07:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:43 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')]} 07:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:43 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 0x7f881783de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cb120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:43 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 07:19:43 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 07:19:43 INFO - Using env: {'DISPLAY': ':0', 07:19:43 INFO - 'HOME': '/home/cltbld', 07:19:43 INFO - 'LANG': 'en_US.UTF-8', 07:19:43 INFO - 'LANGUAGE': 'en_US:en', 07:19:43 INFO - 'LOGNAME': 'cltbld', 07:19:43 INFO - 'MAIL': '/var/mail/cltbld', 07:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:43 INFO - 'MOZ_NO_REMOTE': '1', 07:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:43 INFO - 'NO_EM_RESTART': '1', 07:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:43 INFO - 'PWD': '/builds/slave/test', 07:19:43 INFO - 'SHELL': '/bin/bash', 07:19:43 INFO - 'SHLVL': '1', 07:19:43 INFO - 'TERM': 'linux', 07:19:43 INFO - 'TMOUT': '86400', 07:19:43 INFO - 'USER': 'cltbld', 07:19:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:43 INFO - '_': '/tools/buildbot/bin/python'} 07:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:43 INFO - Cleaning up... 07:19:43 INFO - Return code: 0 07:19:43 INFO - Running post-action listener: _resource_record_post_action 07:19:43 INFO - Running post-action listener: _start_resource_monitoring 07:19:43 INFO - Starting resource monitoring. 07:19:43 INFO - [mozharness: 2016-12-07 15:19:43.913544Z] Finished create-virtualenv step (success) 07:19:43 INFO - [mozharness: 2016-12-07 15:19:43.914069Z] Running install step. 07:19:43 INFO - Running pre-action listener: _resource_record_pre_action 07:19:43 INFO - Running main action method: install 07:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:44 INFO - Reading from file tmpfile_stdout 07:19:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:44 INFO - Reading from file tmpfile_stdout 07:19:44 INFO - Output received: 07:19:44 INFO - Usage: mozinstall [options] installer 07:19:44 INFO - Options: 07:19:44 INFO - -h, --help show this help message and exit 07:19:44 INFO - -d DEST, --destination=DEST 07:19:44 INFO - Directory to install application into. [default: 07:19:44 INFO - "/builds/slave/test"] 07:19:44 INFO - --app=APP Application being installed. [default: firefox] 07:19:44 INFO - mkdir: /builds/slave/test/build/application 07:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:20:02 INFO - Reading from file tmpfile_stdout 07:20:02 INFO - Output received: 07:20:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:20:02 INFO - Running post-action listener: _resource_record_post_action 07:20:02 INFO - [mozharness: 2016-12-07 15:20:02.752167Z] Finished install step (success) 07:20:02 INFO - [mozharness: 2016-12-07 15:20:02.752409Z] Running run-tests step. 07:20:02 INFO - Running pre-action listener: _resource_record_pre_action 07:20:02 INFO - Running main action method: run_tests 07:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:20:02 INFO - Python 2.7.3 07:20:02 INFO - Return code: 0 07:20:02 INFO - grabbing minidump binary from tooltool 07:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:02 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/linux64/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 0x125bf20>, '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 0x11c8c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:20:02 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:20:02 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/linux64/releng.manifest -o -c /builds/tooltool_cache 07:20:02 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:20:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:20:02 INFO - Return code: 0 07:20:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:20:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:20:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:20:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:20:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:20:02 INFO - Using env: {'DISPLAY': ':0', 07:20:02 INFO - 'HOME': '/home/cltbld', 07:20:02 INFO - 'LANG': 'en_US.UTF-8', 07:20:02 INFO - 'LANGUAGE': 'en_US:en', 07:20:02 INFO - 'LOGNAME': 'cltbld', 07:20:02 INFO - 'MAIL': '/var/mail/cltbld', 07:20:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:20:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:02 INFO - 'MOZ_NO_REMOTE': '1', 07:20:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:02 INFO - 'NO_EM_RESTART': '1', 07:20:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:02 INFO - 'PWD': '/builds/slave/test', 07:20:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:20:02 INFO - 'SHELL': '/bin/bash', 07:20:02 INFO - 'SHLVL': '1', 07:20:02 INFO - 'TERM': 'linux', 07:20:02 INFO - 'TMOUT': '86400', 07:20:02 INFO - 'USER': 'cltbld', 07:20:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257', 07:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:02 INFO - '_': '/tools/buildbot/bin/python'} 07:20:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:20:03 INFO - mozversion application_buildid: 20161207062738 07:20:03 INFO - mozversion application_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 07:20:03 INFO - mozversion application_display_name: Nightly 07:20:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:20:03 INFO - mozversion application_name: Firefox 07:20:03 INFO - mozversion application_remotingname: firefox 07:20:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:20:03 INFO - mozversion application_vendor: Mozilla 07:20:03 INFO - mozversion application_version: 53.0a1 07:20:03 INFO - mozversion platform_buildid: 20161207062738 07:20:03 INFO - mozversion platform_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 07:20:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:20:03 INFO - mozversion platform_version: 53.0a1 07:20:03 INFO - using testdate: 1481124003 07:20:03 INFO - actual date: 1481124003 07:20:03 INFO - starting webserver on 'localhost:45066' 07:20:03 INFO - SUITE-START | Running 2 tests 07:20:03 INFO - TEST-START | dromaeo_css 07:20:03 INFO - operating with platform_type : linux_ 07:20:03 INFO - Initialising browser for dromaeo_css test... 07:20:03 INFO - TEST-INFO | started process 20945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxlGP6W/profile http://localhost:45066/getInfo.html) 07:20:08 INFO - PROCESS | 20945 | __metrics Screen width/height:1600/1200 07:20:08 INFO - PROCESS | 20945 | colorDepth:24 07:20:08 INFO - PROCESS | 20945 | Browser inner width/height: 1024/697 07:20:08 INFO - PROCESS | 20945 | __metrics 07:20:09 INFO - PROCESS | 20945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:20:09 INFO - PROCESS | 20945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:20:10 INFO - PROCESS | 20945 | console.error: PushService: 07:20:10 INFO - PROCESS | 20945 | stateChangeProcessEnqueue: Error transitioning state 07:20:10 INFO - PROCESS | 20945 | UnknownError 07:20:11 INFO - TEST-INFO | 20945: exit 0 07:20:11 INFO - Browser initialized. 07:20:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:11 INFO - TEST-INFO | started process 21028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxlGP6W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:23 INFO - PROCESS | 21028 | RSS: Main: 173678592 07:20:23 INFO - PROCESS | 21028 | 07:21:14 INFO - PROCESS | 21028 | 1481124074424 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] 07:23:29 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:45066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45066/tests/dromaeo/cssquery-ext.html) 07:23:30 INFO - PROCESS | 21028 | RSS: Main: 283254784 07:23:30 INFO - PROCESS | 21028 | 07:26:33 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:45066/tests/dromaeo/cssquery-ext.html (next: http://localhost:45066/tests/dromaeo/cssquery-jquery.html) 07:26:33 INFO - PROCESS | 21028 | RSS: Main: 287162368 07:26:33 INFO - PROCESS | 21028 | 07:29:36 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:45066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45066/tests/dromaeo/cssquery-mootools.html) 07:29:36 INFO - PROCESS | 21028 | RSS: Main: 224935936 07:29:36 INFO - PROCESS | 21028 | 07:32:39 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:45066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45066/tests/dromaeo/cssquery-prototype.html) 07:32:39 INFO - PROCESS | 21028 | RSS: Main: 225681408 07:32:39 INFO - PROCESS | 21028 | 07:35:42 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:45066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45066/tests/dromaeo/cssquery-yui.html) 07:35:43 INFO - PROCESS | 21028 | RSS: Main: 228880384 07:35:43 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | Cycle 1(1): loaded http://localhost:45066/tests/dromaeo/cssquery-yui.html (next: http://localhost:45066/tests/dromaeo/cssquery-dojo.html) 07:38:46 INFO - PROCESS | 21028 | RSS: Main: 316497920 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | __start_tp_report 07:38:46 INFO - PROCESS | 21028 | _x_x_mozilla_page_load 07:38:46 INFO - PROCESS | 21028 | _x_x_mozilla_page_load_details 07:38:46 INFO - PROCESS | 21028 | |i|pagename|runs| 07:38:46 INFO - PROCESS | 21028 | |0;dojo.html;2546.981207516993;2557.6163575463665;2578.3682997665574;2582.961255581167;2599.246218596606;4541.137183935059;4567.246404343279;4649.558291962262;4671.50949150339;4715.646326525516;4601.5398460153965;4648.674592778507;4658.25467925132;4669.322948172521;4710.528947105287;4261.509926358462;4280.892977675568;4287.8284868605215;4309.030468144674;4324.675649326297;4356.97821510892;4372.191144638252;4403.889902752441;4424.911501769962;4460.955390446086;4367.71609845359;4405.845795397146;4428.291473364262;4459.331100334944;4468.3744275801255;4209.200251952119;4254.425652536899;4254.468191476066;4284.186004659136;4316.460442444694;4305.117450922553;4318.330658747899;4349.086691794727;4363.083752411997;4383.3863259143745;4691.366665500182;4691.577758001762;4697.342372067913;4730.810767569293;4761.571458568711;4897.7795999180125;4941.604671626261;4943.975280123613;5030.547250747451;5050.7222102784335;5008.424031236382;5028.823991160292;5039.77321020555;5061.5950723942;5114.539691427789;4681.906361872811;4683.320918466803;4707.764611769432;4714.599259062949;4754.049190161982;4939.728314942641;5127.307813445212;5166.948330516647;5169.043726910533;5213.348331458567;4798.47216806151;4855.101806165871;4865.805367785249;4871.610271178297;4874.975625121922;4979.4771548987555;4981.078500477423;4987.077390682735;4990.326305948723;5027.773750181251;4888.193448081027;4927.989762098761;4934.679245849008;4980.352554167935;4982.476839931827;4707.411573553306;4793.32893394925;4805.1590971579835;4867.318575399447;4897.902041959141;4084.897877553085;4086;4087.7547347159266;4090.9795451022555;4092.283850326181;3669.7614655047337;3675.7978311192605;3676.4485327201132;3677.3196958562753;3679.1537946272506;4295.8496452624;4302.483701955785;4311.159323931866;4316.848910288125;4332.848350307724;5040.218766091261;5042.168042273057;5042.924356134661;5075.593952483792;5094.745262736922;4355.8475453359615;4368.694191406571;4370.781460927004;4380.342948557742;4410.625096866802;4383.320585309219;4402.053558484941;4422.027154026109;4482.955170448319;4492.640588752892;4651.465081515669;4658.301254811738;4684.765761711833;4727.314539391838;4733.573978341966;4934.827281045146;4967.428745694291;4974.154393753143;4976.776045078052;5017.774200161075;4590.6327493799745;4613.077384523176;4616.907661846812;4666.370040044686;4716.481187069488;4889.657723959289;4897.4857639947295;4903.901921961469;4915.26271059344;4916.7541622919425;4932.260160975882;4951.158303088411;4969.900601987868;4977.601791856715;5037.345145131109;4853.927191092066;4854.660173787942;4855.101806165871;4867.172580661225;4899.461059283547;4631.722096674211;4854.878628034327;4867.318575399376;4868.975655121843;4910.533499317559;4598.655100867515;4704.623630109514;4730.101280756645;4745.074710431432;4798.688085274446;4838.104950584153;4838.346823178967;4839.201531747222;4850.320955066223;4889.779959901742;4695.694779839299;4734.366643507984;4735.21868891629;4735.360726302043;4747.8575642730775 07:38:46 INFO - PROCESS | 21028 | |1;ext.html;552.9557635389168;580.8605934575703;584.7982446056111;586.4838941731273;590.4685782795486;28095.297617559547;41894.79052604736;42950.57049429505;43045.35431968519;43077.56922430775;38558.4216236756;38871.611283887156;38973.41539876897;38981.22037559247;39013.60986390135;7422.18355980843;7558.773236802877;7569.659365328546;7570.6971721131085;7571.205023472538;7373.225811289818;7559.848803023936;9457.574409151604;9725.51372431379;9735.41587504752;9778.462184579845;9835.213182945346;9836.606535738561;9842.655507057254;9849.950750246238;9695.272854535939;9752.609895604202;9758.12176904075;9763.365381250267;9765;9680.75798105046;9716.31985760997;9739.269554783348;9749;9754.317197796157;37397.813010935046;37785.05537361561;37792.24415511674;37814.24371512554;37832.81083594592;2961.8667159977635;3209.791363561361;3251.4472539668313;3420.880269190566;3485.268093700326;28306.575401368995;28763;28796;29103.85448072746;30142.698573014426;3431.3137372525343;3496.9300613987834;3520.7535472516934;3577.266660334625;3600.6759391654614;236897.81551092135;236904.97022663747;236985.99999999828;237194;239346;52390.47609523856;52745.73627131917;52754.20868686973;52764.47235527595;52983.470165297855;54564.72717636466;54720.45279547154;54755.72622136864;54761.726191369584;54774.45225547773;13072.411741471657;13257.07200495956;13259.73480530384;13265.66835829112;13265.801012984813;8929.10708929102;9152.679656212;10040.548175332127;10087;10098.949505252427;14038.157710537196;14828.555143345717;15529;15581.844181558266;16277;5620.606557540933;5626.43735626434;5663.093904975184;5725.713714314267;5881.5000724938;787.9606019698992;916.619602864817;932.785459344341;951.0006353240148;991.1179050644931;26803.463930721275;27340.726592734216;27343.430208759593;27727.861360693067;27891;926.786839027014;940.7177846645978;945.0360632155164;953.7043516509765;955.2739917662487;14441.638959026108;14740.926295368454;14798.92600537012;14915.70168596622;15051.623709407353;113809;113866.43066784779;114074;114177.4291128539;114183;47658.5234147661;47803.17574594024;47938;47951.76024119857;47979.280310795366;1085.8914108589079;1139.5214010115938;1142.1034487926938;1143.89704926557;1174.5595401724354;25959.61060584055;26566.867165664047;26802;27155.321116972234;27470.17589472319;43187.35218971655;43402.782986084865;43564.34653480137;43617.563824362616;43656.56343436525;313576;313876;314002;314507;314637;35481.82259088688;35766;35836;35871.46192807162;38206;38411.42382864315;38786.6121338783;41414.1717165661;41790.79104604579;42435;34509.309813803084;35585.28829423449;35891.820540897126;35911.28177436489;36077.27845443129;35585.82207088948;36002.8199858999;36012.09969750777;36063.63936360603;36484.81757591195;35035.124121897155;35311.64688353187;36312.09219769527;36346;36357.63642363648;29887.356195408593;31235.843820780752;31592.839396317497;31971.84014080008;32123.196920077185;25284.241472755846;25335.61996570016;25411.618825718;25421.237362879143;25851.22446326613 07:38:46 INFO - PROCESS | 21028 | |2;jquery.html;339.81404896909794;355.1724481957042;361.1999421281861;362.24471975930186;379.89059547602875;12202.755944881097;15410.383584656629;15438.150901700403;16693.415730449437;16774.74837877433;16106;16185.83814161861;16399.918000410013;16559.08925009124;16669.41657042004;4845.27320901864;4848.563629273364;4948.8267910623135;4989.501049895018;5066.898662026757;3591.748577599569;3757.1358587524887;4884.072026315007;4973.825916092937;4981.37732783402;5584.6090773645865;5823.184754134425;5833.562482813784;5908.763649454017;5910.34986151523;5735.799247026334;5793.304803423574;5901.23283973085;5915.053591425372;5923.792667256647;5167.48325167484;5170.715610641413;5172.767225474862;5173.249878767595;5175.767090480937;19266.614667706708;20285.8985705072;20399.694004589943;20494.18023279067;20498.487537811674;1846.1784505894882;1912.177763561668;1930.9806901930942;2056.9280075197444;2334.3813889319345;8606.354523410706;12112.576059837864;12623.368831558477;13109.147905386119;13364.866351336557;1630.8776841736917;1661.551381127101;1708.3679038755615;1712.888662236963;1721.2684609041232;65404.3459565403;66204.3379566203;66567.3343266566;66871.66564167148;66970.66514667396;9987.700368988943;10197.18422526211;10215.438150901771;10276.537555810006;10332.70841144857;13755.38100785467;13895.65260868466;13898.235597042058;13902;13909.234992075331;6799.11611490503;6849.4177994871;6888.41448476875;7054.2945705430075;7072.257412971667;6360.109584658151;6374.426301632875;6513.837154071186;6550.705218265094;6551.770688025991;4282.122164956177;4296.076343586082;4314.935275970863;4346.456692913386;4470.418845550058;1721.1910402110989;1723.5087999919963;1748.8688348373923;1752.3603884582035;1811.5652243461739;799.7680672604996;804.4931693033468;837.9706710265111;860.6600392844791;903.2039868299352;16095.839041609433;16566.585835354213;16838.32646694143;17062.573435664206;17406.564835879206;779.5751315533048;818.2553875972836;830.7258604660448;841.3101256969348;847.1232274595764;9259.583318750672;9264.305177111608;9585.760355991157;9616.23070154386;9785.951070244602;260316;266441;331596;332880;337330;54364.28301774315;57766.111694415114;69110;69127;78391.60804196057;914.9039350868196;935.6210734652477;936.5644975086617;983.6409710455775;986.5412583148727;15079;15171;15681.686366272383;16066.59833504125;16073.35706571724;35109.32157415168;35753;36081;36173.638263617024;36566.63433365632;44874.551254487036;48444.515554844;49069;49640.75179624079;51348;6749.358810912955;6881.4494840413645;6957.965210173917;7296.671649775667;7565.583892885724;10551.577936882439;11616;11911.344876031555;11928.701782455508;12211.633650990485;10110.882915835813;10168.949155254177;10324.43215623148;10808.56765729362;10914.727131821768;9686.660966866126;9763.218942484442;9790.853137202805;9935.453550054817;10090.798184036132;7148.714051438093;9608.615655373986;9617.759556010877;10257.846132307872;10519;7451.701931922662;7466.962665186639;7528.134264559427;7532.397408207221;7896.289333959971;7645.350145237717;9872.308938374244;9981.251406144424;10253.897461025592;10416.21878359111 07:38:46 INFO - PROCESS | 21028 | |3;mootools.html;1302.7134030513287;1315.9407826647803;1364.3246592936498;1613.038896008472;1628.1289510112085;6107.053406721965;6325.1144839722365;6711.832204194898;7158.961950517179;7177.3540381365665;6736;7016.614086225269;7038.225795162528;7053.57678539288;7213.026241457402;2031.7561892572876;2080.6358887194756;2081.927132550361;2082.416923261489;2083.343746719786;1799.7750281214849;1846.3906910719431;2078.2414418737126;2084.4893001214723;2096.811286984171;1987.5130593004735;2055.9074841632164;2058.3207541511265;2062.9484262893397;2067.803558661932;2055.5066783971815;2059.5983783162287;2081.0739221046565;2087.968680469794;2097.842661800356;2100.0759665747023;2100.527381339202;2103.7265155529835;2105.357865850915;2109.683547467877;7049.400800931876;7235.312645298688;7238.963805180993;7251.419886409075;7252.818679533001;4286.228478873802;4369.584889435499;4477.059817438342;4515.7516336601475;4518.096380723869;2750.6561679790025;2887.5379939209624;3001.7598592112577;3002.219422950027;3014.427258820839;906.1572737354257;917.7200953709116;927.3230541704594;969.5152423788106;972.1639390124558;9286.674966376211;9489.810203795954;9495;9496.952515237379;9510.809783804285;3851.171998020439;3968.8015599219925;3992.121733218687;4104.56902025283;4135.193637240709;7502.737404190827;7549.169591344948;7556;7556.1310449297935;7568.508046977039;4342.891427714332;4344.9348259776125;4354.7822608870065;4358.193734159191;4358.716683415568;3938.3107956107565;3995.5205375355144;4020.537638171589;4031.3348297531165;4043.4945631796027;3162.1462205204466;3173.0639461358955;3201.551782750417;3213.196700824794;3239.3521295740948;894.2711689972651;928;968.7142293023575;985.8077674853334;1002.6941782756184;660.4914216053612;752.5710345103239;804.129312686763;821.5358322547861;830.0164305298241;5064.392272927273;5116.897662046738;5131.948680513222;5163.173892177234;5234.816781412632;818.6602559937678;827.6399766101765;840.8570543007703;863.317978796756;892.4243862708646;3760.4735337052834;3808.27642747877;3843.1929294847837;3866.2074274773604;3935.878274691699;8085.514869107872;8398.706045288385;8429.873551896726;8648.1784230498;8662.826743465095;8591.312694984386;8595.140485951355;8610;8610.440321379216;8610.526421046903;6361;6453.645049522322;6467.547271691031;6476.579022363531;6483.7730679425995;4849.248366503198;4973.179425394769;5011.899762004812;5029.64792464524;5076.390833100052;7501.774946751606;7511.887321690288;7654.617269136632;7661.502002369828;7750.728724494616;7734.497257678233;7755.844883102419;7774.144844067035;7807.453478256468;7846.646900889587;5798.971005144947;5962.821115366546;5962.9105563415715;5963.612365196248;6007.939920600738;6843.794686159423;6845.828854278683;6914.792556223321;6918.135233095863;6929.618870962146;6301.653409062362;6305.905411418924;6308.243010838729;6338.58799178052;6345.17512723343;6099.9390006099375;6203.658798766111;6218.098375735583;6228.408301211378;6238.532110091852;5833.154192642128;5875.794347197828;5931.3178984417345;5946.108083787293;5957.49361304294;4267.402563641155;4434.290513517822;4443.866683999485;4489.910201796011;4541.931871021871;4377;4451.488078870972;4500.974561447297;4580.427446569179;4678.157931572349 07:38:46 INFO - PROCESS | 21028 | |4;prototype.html;283.61570072551706;284.75795573762304;288.17581716291403;291.58435794219076;291.9226405002674;4529.297958816381;4651.4650815156265;4677.134730074934;4720.551547602977;4779.761011949406;4559.544045595439;4611.769411529419;4639.605633521155;4668.206404911165;4679.578837904588;3651.233241019389;3669.9266014679692;3672.008557689422;3674.210044840359;3676.5588129424505;3480.8861164427267;3663.688586470153;3684.5025921500524;3693.8707145249923;3694.113412780927;3485.651434856507;3559.288142371523;3665.138692407282;3677.9448308275396;3708.1841994761107;3647.544056992876;3664.4686520454384;3667.486551882752;3687.8340474678434;3705.1478160023344;3272.051105179495;3275.033865009828;3276.1482014676117;3276.3938671345877;3278.606567211926;4471.686981911267;4620.19146649335;4637.5826175644015;4650.883727906796;4651.139539185261;4176.248275310443;4189.91620167598;4197.664186865074;4216.198922204771;4222.429971953778;4910.8281210157475;4939.827106051307;4943.307936888838;4956.677815941952;4962.87592810179;3536.398812201932;3539.752217344787;3541.8406171722336;3544.220271540257;3549.4498352755104;4908.754562271872;5132.486751324875;5133.486651334837;5165.199394093921;5184.040952423776;3481.9303613927577;3498.9475157872653;3504.667056629616;3506.053365591276;3523.418635925044;3543.0965103898343;3544.3442963051916;3553.09396103997;3559.288142371536;3562.091666624994;3962.583928687446;4103.610157035077;4104.199681062164;4108.609682080198;4149.2738770715605;4865.464798872121;4900.803967841318;4907.411110666742;4924.803007879645;4925.2119660854805;1189.2448295332526;1228.791105512065;1254.8870601645895;1257.2393701810456;1257.974840503203;826.904351733955;836.677879016583;862.9223369896739;863.2964134230582;863.447393668053;4263.168682107022;4263.211305908417;4269.338252570857;4281.186574550826;4282.9785851071165;4896.436909755424;4916.582090522345;4916.975415122902;4930.580900623487;4931.654784165074;4126.66986641068;4208.263553878121;4216.9036050627055;4261.275583150872;4285.421468101767;2574.206985420802;2582.2382397192496;2586.6120081987474;2587.2884956637076;2600.206936884231;4561.566651168134;4576.970181709089;4580.763193937618;4583.960137738674;4602.309653551994;4820.373351464287;4935.988122434892;4937.950620493749;4992.375953005874;5001.124803159505;4527;4538.526503055842;4543.477500087466;4546.772661366918;4579.6794224403975;4846.491118432514;4850.1997170466475;4858.5384388483035;4876.512348765095;4881.365422495053;4596.379488768974;4702.882427939329;4743.407074115736;4754.358161648272;4765.166095933268;4514.232580461264;4567.566081222411;4572.611328037021;4575.7483338416705;4577.420789827504;3481.4603736420895;3500.1599616092462;3509.64903509647;3510.1751088494693;3526.682598566141;4749.96002558356;4812.807487700453;4842.5157484251295;4894.975525122351;4910.968696573759;4713.835015774432;4726.740029298421;4728.146560553138;4736.5973892219545;4758.333833263277;4743.264793956942;4757.16749568831;4805.57318554128;4806.543378379049;4825.879353016203;4397.9340309896015;4704.482506924304;4707.17624415719;4713.457952335525;4716.339712440193;4685.5080216578135;4700.882477938079;4720.291956206596;4727.550882666142;4751.382320298339;4631.745254011062;4640.164770341371;4665.020345727436;4681.016986432887;4683.344331793483 07:38:46 INFO - PROCESS | 21028 | |5;yui.html;676.4453148418296;682.6109117802852;686.5091459606381;723.334532230348;741.5550669598242;12493.937530312347;13580.660483487918;13640.863591364083;13657.180569165845;13663.999999999987;12432.502699891993;12436.378181090955;12444;12509.687257818536;12551.497940082385;617.718937883262;636.1253276744476;740.9259074092574;757.829488365119;767.6277005652282;772.7797577690359;774.2296415067016;776.2780614028951;776.5185584937346;776.5651235308245;821.6179476543406;822.6298165825373;823.6334831000207;823.8064054947113;824.0235321144434;650.9153810004716;668.1381018486147;816.6733306677318;817.0930267403148;817.4441379861692;584.298841390329;602.1780269931555;602.6414283501309;602.7890238416563;605.8848818724429;13539.661508462268;13564.186148831102;13602;13612.591622251348;13618.727625447535;12931.418086186144;12931.642177571408;13264.137831040951;13349.46602135923;13492.527761528398;11448.181468512259;11758;11850.31391560042;12183.756324873542;12215.877841221563;4018.8995275118064;4064.7561146331313;4067.5670292020204;4072.8778136655947;4084.326086195774;64513.35486645167;65693.67153164251;66129.33870661329;66166.33833661601;66220;10343;10534.367937923596;10637.840432393365;10687.46562671879;11127.610533631285;19787;19797.30709425163;19828.50428739293;19849.60300793976;19880.304189353305;6515;6597.274299827015;6746.494012949049;6758.256591774901;6838.350356716104;3569.268299998494;3601.549806274216;3649.288388764219;3663.68858647018;3708.0173753955223;2660.7339266073236;2744.8078634495396;2759;2766.1148432501404;2782.123631056211;469.1227404753133;471.6721878294621;476.58060906402835;481.81931775584155;487.11831584831566;478.3160081084014;524.2712629445074;530.2761730238198;536.3456582968772;545.3564793543657;7888.526688398714;8024.117347091816;8024.518528888286;8264.958675206586;8350.540720260322;550.3505863081522;555.2753656478254;555.5722093987607;581.4882903045293;581.6800759582213;3710.3692372296773;3988.361862102108;3988.700847436454;4014.6186112319283;4040.717149799486;67588.6620566894;68425;69150;70727;71556.28443715496;60713.08930366048;61501.69249153726;62535.6873215631;62822.685886570274;63740.36259637437;55086;55876.999999999185;56401.71799140978;56833.14750278749;57109.42890571041;7455.850882982419;8022.398320126131;8242.546659933521;8291.792705182419;8304.87542686848;38999.2200156001;39053;39975.80012099921;40387;40959.1808163841;47531.44434001913;51600.74199628978;51906;52532.212016819016;54719.72640136774;9877.50612469388;9928.156106731009;9928.404295742279;10122.746931326481;10421.322614030063;10463.529141188817;10464;10665.680029599125;11058.115350771757;11681.88318116842;10081.143102836048;10838;11518.769624607628;11807.586734464252;12064.095192860746;12026.699332516408;12059.69850753703;12070.215435996632;12644.936775316064;12684.936575317064;11844.170908036354;11882.643520694393;12217.389130543259;12496.125271230927;12595.937020315207;10072.294939354175;10258.640947567097;10443.738906527398;10493.737656558647;10673.519691613741;10140.340877842917;10447.612102807976;10533.841992369968;10599.62901298451;10656.62701805433 07:38:46 INFO - PROCESS | 21028 | __end_tp_report 07:38:46 INFO - PROCESS | 21028 | __start_cc_report 07:38:46 INFO - PROCESS | 21028 | _x_x_mozilla_cycle_collect,1177 07:38:46 INFO - PROCESS | 21028 | __end_cc_report 07:38:46 INFO - PROCESS | 21028 | __startTimestamp1481125126720__endTimestamp 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | ------- Summary: start ------- 07:38:46 INFO - PROCESS | 21028 | Number of tests: 6 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | [#0] dojo.html Cycles:165 Average:4602.57 Median:4714.60 stddev:481.92 (10.2%) stddev-sans-first:455.63 07:38:46 INFO - PROCESS | 21028 | Values: 2547.0 2557.6 2578.4 2583.0 2599.2 4541.1 4567.2 4649.6 4671.5 4715.6 4601.5 4648.7 4658.3 4669.3 4710.5 4261.5 4280.9 4287.8 4309.0 4324.7 4357.0 4372.2 4403.9 4424.9 4461.0 4367.7 4405.8 4428.3 4459.3 4468.4 4209.2 4254.4 4254.5 4284.2 4316.5 4305.1 4318.3 4349.1 4363.1 4383.4 4691.4 4691.6 4697.3 4730.8 4761.6 4897.8 4941.6 4944.0 5030.5 5050.7 5008.4 5028.8 5039.8 5061.6 5114.5 4681.9 4683.3 4707.8 4714.6 4754.0 4939.7 5127.3 5166.9 5169.0 5213.3 4798.5 4855.1 4865.8 4871.6 4875.0 4979.5 4981.1 4987.1 4990.3 5027.8 4888.2 4928.0 4934.7 4980.4 4982.5 4707.4 4793.3 4805.2 4867.3 4897.9 4084.9 4086.0 4087.8 4091.0 4092.3 3669.8 3675.8 3676.4 3677.3 3679.2 4295.8 4302.5 4311.2 4316.8 4332.8 5040.2 5042.2 5042.9 5075.6 5094.7 4355.8 4368.7 4370.8 4380.3 4410.6 4383.3 4402.1 4422.0 4483.0 4492.6 4651.5 4658.3 4684.8 4727.3 4733.6 4934.8 4967.4 4974.2 4976.8 5017.8 4590.6 4613.1 4616.9 4666.4 4716.5 4889.7 4897.5 4903.9 4915.3 4916.8 4932.3 4951.2 4969.9 4977.6 5037.3 4853.9 4854.7 4855.1 4867.2 4899.5 4631.7 4854.9 4867.3 4869.0 4910.5 4598.7 4704.6 4730.1 4745.1 4798.7 4838.1 4838.3 4839.2 4850.3 4889.8 4695.7 4734.4 4735.2 4735.4 4747.9 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | [#1] ext.html Cycles:180 Average:39438.44 Median:36351.82 stddev:62208.11 (171.1%) stddev-sans-first:62314.10 07:38:46 INFO - PROCESS | 21028 | Values: 553.0 580.9 584.8 586.5 590.5 28095.3 41894.8 42950.6 43045.4 43077.6 38558.4 38871.6 38973.4 38981.2 39013.6 7422.2 7558.8 7569.7 7570.7 7571.2 7373.2 7559.8 9457.6 9725.5 9735.4 9778.5 9835.2 9836.6 9842.7 9850.0 9695.3 9752.6 9758.1 9763.4 9765.0 9680.8 9716.3 9739.3 9749.0 9754.3 37397.8 37785.1 37792.2 37814.2 37832.8 2961.9 3209.8 3251.4 3420.9 3485.3 28306.6 28763.0 28796.0 29103.9 30142.7 3431.3 3496.9 3520.8 3577.3 3600.7 236897.8 236905.0 236986.0 237194.0 239346.0 52390.5 52745.7 52754.2 52764.5 52983.5 54564.7 54720.5 54755.7 54761.7 54774.5 13072.4 13257.1 13259.7 13265.7 13265.8 8929.1 9152.7 10040.5 10087.0 10098.9 14038.2 14828.6 15529.0 15581.8 16277.0 5620.6 5626.4 5663.1 5725.7 5881.5 788.0 916.6 932.8 951.0 991.1 26803.5 27340.7 27343.4 27727.9 27891.0 926.8 940.7 945.0 953.7 955.3 14441.6 14740.9 14798.9 14915.7 15051.6 113809.0 113866.4 114074.0 114177.4 114183.0 47658.5 47803.2 47938.0 47951.8 47979.3 1085.9 1139.5 1142.1 1143.9 1174.6 25959.6 26566.9 26802.0 27155.3 27470.2 43187.4 43402.8 43564.3 43617.6 43656.6 313576.0 313876.0 314002.0 314507.0 314637.0 35481.8 35766.0 35836.0 35871.5 38206.0 38411.4 38786.6 41414.2 41790.8 42435.0 34509.3 35585.3 35891.8 35911.3 36077.3 35585.8 36002.8 36012.1 36063.6 36484.8 35035.1 35311.6 36312.1 36346.0 36357.6 29887.4 31235.8 31592.8 31971.8 32123.2 25284.2 25335.6 25411.6 25421.2 25851.2 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | [#2] jquery.html Cycles:180 Average:21399.66 Median:46659.53 stddev:51109.95 (109.5%) stddev-sans-first:51228.86 07:38:46 INFO - PROCESS | 21028 | Values: 339.8 355.2 361.2 362.2 379.9 12202.8 15410.4 15438.2 16693.4 16774.7 16106.0 16185.8 16399.9 16559.1 16669.4 4845.3 4848.6 4948.8 4989.5 5066.9 3591.7 3757.1 4884.1 4973.8 4981.4 5584.6 5823.2 5833.6 5908.8 5910.3 5735.8 5793.3 5901.2 5915.1 5923.8 5167.5 5170.7 5172.8 5173.2 5175.8 19266.6 20285.9 20399.7 20494.2 20498.5 1846.2 1912.2 1931.0 2056.9 2334.4 8606.4 12112.6 12623.4 13109.1 13364.9 1630.9 1661.6 1708.4 1712.9 1721.3 65404.3 66204.3 66567.3 66871.7 66970.7 9987.7 10197.2 10215.4 10276.5 10332.7 13755.4 13895.7 13898.2 13902.0 13909.2 6799.1 6849.4 6888.4 7054.3 7072.3 6360.1 6374.4 6513.8 6550.7 6551.8 4282.1 4296.1 4314.9 4346.5 4470.4 1721.2 1723.5 1748.9 1752.4 1811.6 799.8 804.5 838.0 860.7 903.2 16095.8 16566.6 16838.3 17062.6 17406.6 779.6 818.3 830.7 841.3 847.1 9259.6 9264.3 9585.8 9616.2 9786.0 260316.0 266441.0 331596.0 332880.0 337330.0 54364.3 57766.1 69110.0 69127.0 78391.6 914.9 935.6 936.6 983.6 986.5 15079.0 15171.0 15681.7 16066.6 16073.4 35109.3 35753.0 36081.0 36173.6 36566.6 44874.6 48444.5 49069.0 49640.8 51348.0 6749.4 6881.4 6958.0 7296.7 7565.6 10551.6 11616.0 11911.3 11928.7 12211.6 10110.9 10168.9 10324.4 10808.6 10914.7 9686.7 9763.2 9790.9 9935.5 10090.8 7148.7 9608.6 9617.8 10257.8 10519.0 7451.7 7467.0 7528.1 7532.4 7896.3 7645.4 9872.3 9981.3 10253.9 10416.2 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | [#3] mootools.html Cycles:180 Average:4699.08 Median:5951.80 stddev:2486.54 (41.8%) stddev-sans-first:2480.42 07:38:46 INFO - PROCESS | 21028 | Values: 1302.7 1315.9 1364.3 1613.0 1628.1 6107.1 6325.1 6711.8 7159.0 7177.4 6736.0 7016.6 7038.2 7053.6 7213.0 2031.8 2080.6 2081.9 2082.4 2083.3 1799.8 1846.4 2078.2 2084.5 2096.8 1987.5 2055.9 2058.3 2062.9 2067.8 2055.5 2059.6 2081.1 2088.0 2097.8 2100.1 2100.5 2103.7 2105.4 2109.7 7049.4 7235.3 7239.0 7251.4 7252.8 4286.2 4369.6 4477.1 4515.8 4518.1 2750.7 2887.5 3001.8 3002.2 3014.4 906.2 917.7 927.3 969.5 972.2 9286.7 9489.8 9495.0 9497.0 9510.8 3851.2 3968.8 3992.1 4104.6 4135.2 7502.7 7549.2 7556.0 7556.1 7568.5 4342.9 4344.9 4354.8 4358.2 4358.7 3938.3 3995.5 4020.5 4031.3 4043.5 3162.1 3173.1 3201.6 3213.2 3239.4 894.3 928.0 968.7 985.8 1002.7 660.5 752.6 804.1 821.5 830.0 5064.4 5116.9 5131.9 5163.2 5234.8 818.7 827.6 840.9 863.3 892.4 3760.5 3808.3 3843.2 3866.2 3935.9 8085.5 8398.7 8429.9 8648.2 8662.8 8591.3 8595.1 8610.0 8610.4 8610.5 6361.0 6453.6 6467.5 6476.6 6483.8 4849.2 4973.2 5011.9 5029.6 5076.4 7501.8 7511.9 7654.6 7661.5 7750.7 7734.5 7755.8 7774.1 7807.5 7846.6 5799.0 5962.8 5962.9 5963.6 6007.9 6843.8 6845.8 6914.8 6918.1 6929.6 6301.7 6305.9 6308.2 6338.6 6345.2 6099.9 6203.7 6218.1 6228.4 6238.5 5833.2 5875.8 5931.3 5946.1 5957.5 4267.4 4434.3 4443.9 4489.9 4541.9 4377.0 4451.5 4501.0 4580.4 4678.2 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | [#4] prototype.html Cycles:180 Average:4002.66 Median:4570.09 stddev:1143.32 (25.0%) stddev-sans-first:1111.93 07:38:46 INFO - PROCESS | 21028 | Values: 283.6 284.8 288.2 291.6 291.9 4529.3 4651.5 4677.1 4720.6 4779.8 4559.5 4611.8 4639.6 4668.2 4679.6 3651.2 3669.9 3672.0 3674.2 3676.6 3480.9 3663.7 3684.5 3693.9 3694.1 3485.7 3559.3 3665.1 3677.9 3708.2 3647.5 3664.5 3667.5 3687.8 3705.1 3272.1 3275.0 3276.1 3276.4 3278.6 4471.7 4620.2 4637.6 4650.9 4651.1 4176.2 4189.9 4197.7 4216.2 4222.4 4910.8 4939.8 4943.3 4956.7 4962.9 3536.4 3539.8 3541.8 3544.2 3549.4 4908.8 5132.5 5133.5 5165.2 5184.0 3481.9 3498.9 3504.7 3506.1 3523.4 3543.1 3544.3 3553.1 3559.3 3562.1 3962.6 4103.6 4104.2 4108.6 4149.3 4865.5 4900.8 4907.4 4924.8 4925.2 1189.2 1228.8 1254.9 1257.2 1258.0 826.9 836.7 862.9 863.3 863.4 4263.2 4263.2 4269.3 4281.2 4283.0 4896.4 4916.6 4917.0 4930.6 4931.7 4126.7 4208.3 4216.9 4261.3 4285.4 2574.2 2582.2 2586.6 2587.3 2600.2 4561.6 4577.0 4580.8 4584.0 4602.3 4820.4 4936.0 4938.0 4992.4 5001.1 4527.0 4538.5 4543.5 4546.8 4579.7 4846.5 4850.2 4858.5 4876.5 4881.4 4596.4 4702.9 4743.4 4754.4 4765.2 4514.2 4567.6 4572.6 4575.7 4577.4 3481.5 3500.2 3509.6 3510.2 3526.7 4750.0 4812.8 4842.5 4895.0 4911.0 4713.8 4726.7 4728.1 4736.6 4758.3 4743.3 4757.2 4805.6 4806.5 4825.9 4397.9 4704.5 4707.2 4713.5 4716.3 4685.5 4700.9 4720.3 4727.6 4751.4 4631.7 4640.2 4665.0 4681.0 4683.3 07:38:46 INFO - PROCESS | 21028 | 07:38:46 INFO - PROCESS | 21028 | [#5] yui.html Cycles:180 Average:15585.34 Median:22521.75 stddev:19886.38 (88.3%) stddev-sans-first:19910.65 07:38:46 INFO - PROCESS | 21028 | Values: 676.4 682.6 686.5 723.3 741.6 12493.9 13580.7 13640.9 13657.2 13664.0 12432.5 12436.4 12444.0 12509.7 12551.5 617.7 636.1 740.9 757.8 767.6 772.8 774.2 776.3 776.5 776.6 821.6 822.6 823.6 823.8 824.0 650.9 668.1 816.7 817.1 817.4 584.3 602.2 602.6 602.8 605.9 13539.7 13564.2 13602.0 13612.6 13618.7 12931.4 12931.6 13264.1 13349.5 13492.5 11448.2 11758.0 11850.3 12183.8 12215.9 4018.9 4064.8 4067.6 4072.9 4084.3 64513.4 65693.7 66129.3 66166.3 66220.0 10343.0 10534.4 10637.8 10687.5 11127.6 19787.0 19797.3 19828.5 19849.6 19880.3 6515.0 6597.3 6746.5 6758.3 6838.4 3569.3 3601.5 3649.3 3663.7 3708.0 2660.7 2744.8 2759.0 2766.1 2782.1 469.1 471.7 476.6 481.8 487.1 478.3 524.3 530.3 536.3 545.4 7888.5 8024.1 8024.5 8265.0 8350.5 550.4 555.3 555.6 581.5 581.7 3710.4 3988.4 3988.7 4014.6 4040.7 67588.7 68425.0 69150.0 70727.0 71556.3 60713.1 61501.7 62535.7 62822.7 63740.4 55086.0 55877.0 56401.7 56833.1 57109.4 7455.9 8022.4 8242.5 8291.8 8304.9 38999.2 39053.0 39975.8 40387.0 40959.2 47531.4 51600.7 51906.0 52532.2 54719.7 9877.5 9928.2 9928.4 10122.7 10421.3 10463.5 10464.0 10665.7 11058.1 11681.9 10081.1 10838.0 11518.8 11807.6 12064.1 12026.7 12059.7 12070.2 12644.9 12684.9 11844.2 11882.6 12217.4 12496.1 12595.9 10072.3 10258.6 10443.7 10493.7 10673.5 10140.3 10447.6 10533.8 10599.6 10656.6 07:38:46 INFO - PROCESS | 21028 | -------- Summary: end -------- 07:38:46 INFO - PROCESS | 21028 | 07:38:47 INFO - TEST-INFO | 21028: exit 0 07:38:47 INFO - TEST-OK | dromaeo_css | took 1124716ms 07:38:47 INFO - TEST-START | kraken 07:38:47 INFO - operating with platform_type : linux_ 07:38:47 INFO - Initialising browser for kraken test... 07:38:47 INFO - TEST-INFO | started process 21372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptLRW_E/profile http://localhost:45066/getInfo.html) 07:38:52 INFO - PROCESS | 21372 | __metrics Screen width/height:1600/1200 07:38:52 INFO - PROCESS | 21372 | colorDepth:24 07:38:52 INFO - PROCESS | 21372 | Browser inner width/height: 1024/697 07:38:52 INFO - PROCESS | 21372 | __metrics 07:38:53 INFO - PROCESS | 21372 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:53 INFO - PROCESS | 21372 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:54 INFO - PROCESS | 21372 | console.error: PushService: 07:38:54 INFO - PROCESS | 21372 | stateChangeProcessEnqueue: Error transitioning state 07:38:54 INFO - PROCESS | 21372 | UnknownError 07:38:55 INFO - TEST-INFO | 21372: exit 0 07:38:55 INFO - Browser initialized. 07:38:55 INFO - Running cycle 1/1 for kraken test... 07:38:55 INFO - TEST-INFO | started process 21457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptLRW_E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:07 INFO - PROCESS | 21457 | RSS: Main: 173465600 07:39:07 INFO - PROCESS | 21457 | 07:39:10 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45066/tests/kraken/driver.html?testName=audio-beat-detection) 07:39:11 INFO - PROCESS | 21457 | RSS: Main: 235565056 07:39:11 INFO - PROCESS | 21457 | 07:39:14 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45066/tests/kraken/driver.html?testName=audio-dft) 07:39:14 INFO - PROCESS | 21457 | RSS: Main: 218050560 07:39:14 INFO - PROCESS | 21457 | 07:39:17 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45066/tests/kraken/driver.html?testName=audio-fft) 07:39:18 INFO - PROCESS | 21457 | RSS: Main: 299790336 07:39:18 INFO - PROCESS | 21457 | 07:39:20 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45066/tests/kraken/driver.html?testName=audio-oscillator) 07:39:21 INFO - PROCESS | 21457 | RSS: Main: 211738624 07:39:21 INFO - PROCESS | 21457 | 07:39:23 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:24 INFO - PROCESS | 21457 | RSS: Main: 214044672 07:39:24 INFO - PROCESS | 21457 | 07:39:27 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45066/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:27 INFO - PROCESS | 21457 | RSS: Main: 253714432 07:39:27 INFO - PROCESS | 21457 | 07:39:31 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45066/tests/kraken/driver.html?testName=imaging-desaturate) 07:39:32 INFO - PROCESS | 21457 | RSS: Main: 253587456 07:39:32 INFO - PROCESS | 21457 | 07:39:34 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45066/tests/kraken/driver.html?testName=json-parse-financial) 07:39:35 INFO - PROCESS | 21457 | RSS: Main: 251637760 07:39:35 INFO - PROCESS | 21457 | 07:39:37 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:39:37 INFO - PROCESS | 21457 | RSS: Main: 214102016 07:39:37 INFO - PROCESS | 21457 | 07:39:39 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:39:40 INFO - PROCESS | 21457 | RSS: Main: 222056448 07:39:40 INFO - PROCESS | 21457 | 07:39:42 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:43 INFO - PROCESS | 21457 | RSS: Main: 230166528 07:39:43 INFO - PROCESS | 21457 | 07:39:46 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:46 INFO - PROCESS | 21457 | RSS: Main: 239595520 07:39:46 INFO - PROCESS | 21457 | 07:39:49 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:50 INFO - PROCESS | 21457 | RSS: Main: 235741184 07:39:50 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | Cycle 1(1): loaded http://localhost:45066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45066/tests/kraken/driver.html?testName=ai-astar) 07:39:52 INFO - PROCESS | 21457 | RSS: Main: 286351360 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | __start_tp_report 07:39:52 INFO - PROCESS | 21457 | _x_x_mozilla_page_load 07:39:52 INFO - PROCESS | 21457 | _x_x_mozilla_page_load_details 07:39:52 INFO - PROCESS | 21457 | |i|pagename|runs| 07:39:52 INFO - PROCESS | 21457 | |0;ai-astar;114;119;117;119;118;116;116;118;117;117 07:39:52 INFO - PROCESS | 21457 | |1;audio-beat-detection;156;135;130;180;130;137;138;129;161;142 07:39:52 INFO - PROCESS | 21457 | |2;audio-dft;162;163;161;162;161;161;161;162;162;165 07:39:52 INFO - PROCESS | 21457 | |3;audio-fft;77;86;76;111;77;78;77;78;92;77 07:39:52 INFO - PROCESS | 21457 | |4;audio-oscillator;84;85;107;85;85;84;105;84;84;114 07:39:52 INFO - PROCESS | 21457 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;116;117;117 07:39:52 INFO - PROCESS | 21457 | |6;imaging-darkroom;146;146;147;147;147;147;146;147;147;146 07:39:52 INFO - PROCESS | 21457 | |7;imaging-desaturate;96;95;96;95;95;95;96;96;95;95 07:39:52 INFO - PROCESS | 21457 | |8;json-parse-financial;66;66;65;65;67;65;68;66;66;66 07:39:52 INFO - PROCESS | 21457 | |9;json-stringify-tinderbox;65;66;65;66;66;67;66;68;66;67 07:39:52 INFO - PROCESS | 21457 | |10;stanford-crypto-aes;96;88;91;85;86;84;95;85;86;96 07:39:52 INFO - PROCESS | 21457 | |11;stanford-crypto-ccm;138;140;147;143;141;139;141;143;184;164 07:39:52 INFO - PROCESS | 21457 | |12;stanford-crypto-pbkdf2;180;179;180;184;179;182;181;179;178;185 07:39:52 INFO - PROCESS | 21457 | |13;stanford-crypto-sha256-iterative;70;69;70;68;70;68;74;70;72;68 07:39:52 INFO - PROCESS | 21457 | __end_tp_report 07:39:52 INFO - PROCESS | 21457 | __start_cc_report 07:39:52 INFO - PROCESS | 21457 | _x_x_mozilla_cycle_collect,1989 07:39:52 INFO - PROCESS | 21457 | __end_cc_report 07:39:52 INFO - PROCESS | 21457 | __startTimestamp1481125192533__endTimestamp 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | ------- Summary: start ------- 07:39:52 INFO - PROCESS | 21457 | Number of tests: 14 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.50 stddev:1.52 (1.3%) stddev-sans-first:1.13 07:39:52 INFO - PROCESS | 21457 | Values: 114.0 119.0 117.0 119.0 118.0 116.0 116.0 118.0 117.0 117.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:140.00 stddev:16.72 (11.9%) stddev-sans-first:17.14 07:39:52 INFO - PROCESS | 21457 | Values: 156.0 135.0 130.0 180.0 130.0 137.0 138.0 129.0 161.0 142.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 07:39:52 INFO - PROCESS | 21457 | Values: 162.0 163.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 165.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.50 stddev:11.14 (14.4%) stddev-sans-first:11.61 07:39:52 INFO - PROCESS | 21457 | Values: 77.0 86.0 76.0 111.0 77.0 78.0 77.0 78.0 92.0 77.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:11.93 (14.2%) stddev-sans-first:12.32 07:39:52 INFO - PROCESS | 21457 | Values: 84.0 85.0 107.0 85.0 85.0 84.0 105.0 84.0 84.0 114.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:39:52 INFO - PROCESS | 21457 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:39:52 INFO - PROCESS | 21457 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:39:52 INFO - PROCESS | 21457 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 07:39:52 INFO - PROCESS | 21457 | Values: 66.0 66.0 65.0 65.0 67.0 65.0 68.0 66.0 66.0 66.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 07:39:52 INFO - PROCESS | 21457 | Values: 65.0 66.0 65.0 66.0 66.0 67.0 66.0 68.0 66.0 67.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:89.50 stddev:4.87 (5.4%) stddev-sans-first:4.50 07:39:52 INFO - PROCESS | 21457 | Values: 96.0 88.0 91.0 85.0 86.0 84.0 95.0 85.0 86.0 96.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:143.00 stddev:14.70 (10.3%) stddev-sans-first:15.14 07:39:52 INFO - PROCESS | 21457 | Values: 138.0 140.0 147.0 143.0 141.0 139.0 141.0 143.0 184.0 164.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:180.50 stddev:2.31 (1.3%) stddev-sans-first:2.44 07:39:52 INFO - PROCESS | 21457 | Values: 180.0 179.0 180.0 184.0 179.0 182.0 181.0 179.0 178.0 185.0 07:39:52 INFO - PROCESS | 21457 | 07:39:52 INFO - PROCESS | 21457 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.91 (2.7%) stddev-sans-first:2.03 07:39:52 INFO - PROCESS | 21457 | Values: 70.0 69.0 70.0 68.0 70.0 68.0 74.0 70.0 72.0 68.0 07:39:52 INFO - PROCESS | 21457 | -------- Summary: end -------- 07:39:52 INFO - PROCESS | 21457 | 07:39:53 INFO - TEST-INFO | 21457: exit 0 07:39:53 INFO - TEST-OK | kraken | took 66134ms 07:39:53 INFO - SUITE-END | took 1190s 07:39:54 INFO - Completed test suite (00:19:51) 07:39:54 INFO - javascript benchmark 07:39:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2546.981207516993, 2557.6163575463665, 2578.3682997665574, 2582.961255581167, 2599.246218596606, 4541.137183935059, 4567.246404343279, 4649.558291962262, 4671.50949150339, 4715.646326525516, 4601.5398460153965, 4648.674592778507, 4658.25467925132, 4669.322948172521, 4710.528947105287, 4261.509926358462, 4280.892977675568, 4287.8284868605215, 4309.030468144674, 4324.675649326297, 4356.97821510892, 4372.191144638252, 4403.889902752441, 4424.911501769962, 4460.955390446086, 4367.71609845359, 4405.845795397146, 4428.291473364262, 4459.331100334944, 4468.3744275801255, 4209.200251952119, 4254.425652536899, 4254.468191476066, 4284.186004659136, 4316.460442444694, 4305.117450922553, 4318.330658747899, 4349.086691794727, 4363.083752411997, 4383.3863259143745, 4691.366665500182, 4691.577758001762, 4697.342372067913, 4730.810767569293, 4761.571458568711, 4897.7795999180125, 4941.604671626261, 4943.975280123613, 5030.547250747451, 5050.7222102784335, 5008.424031236382, 5028.823991160292, 5039.77321020555, 5061.5950723942, 5114.539691427789, 4681.906361872811, 4683.320918466803, 4707.764611769432, 4714.599259062949, 4754.049190161982, 4939.728314942641, 5127.307813445212, 5166.948330516647, 5169.043726910533, 5213.348331458567, 4798.47216806151, 4855.101806165871, 4865.805367785249, 4871.610271178297, 4874.975625121922, 4979.4771548987555, 4981.078500477423, 4987.077390682735, 4990.326305948723, 5027.773750181251, 4888.193448081027, 4927.989762098761, 4934.679245849008, 4980.352554167935, 4982.476839931827, 4707.411573553306, 4793.32893394925, 4805.1590971579835, 4867.318575399447, 4897.902041959141, 4084.897877553085, 4086.0, 4087.7547347159266, 4090.9795451022555, 4092.283850326181, 3669.7614655047337, 3675.7978311192605, 3676.4485327201132, 3677.3196958562753, 3679.1537946272506, 4295.8496452624, 4302.483701955785, 4311.159323931866, 4316.848910288125, 4332.848350307724, 5040.218766091261, 5042.168042273057, 5042.924356134661, 5075.593952483792, 5094.745262736922, 4355.8475453359615, 4368.694191406571, 4370.781460927004, 4380.342948557742, 4410.625096866802, 4383.320585309219, 4402.053558484941, 4422.027154026109, 4482.955170448319, 4492.640588752892, 4651.465081515669, 4658.301254811738, 4684.765761711833, 4727.314539391838, 4733.573978341966, 4934.827281045146, 4967.428745694291, 4974.154393753143, 4976.776045078052, 5017.774200161075, 4590.6327493799745, 4613.077384523176, 4616.907661846812, 4666.370040044686, 4716.481187069488, 4889.657723959289, 4897.4857639947295, 4903.901921961469, 4915.26271059344, 4916.7541622919425, 4932.260160975882, 4951.158303088411, 4969.900601987868, 4977.601791856715, 5037.345145131109, 4853.927191092066, 4854.660173787942, 4855.101806165871, 4867.172580661225, 4899.461059283547, 4631.722096674211, 4854.878628034327, 4867.318575399376, 4868.975655121843, 4910.533499317559, 4598.655100867515, 4704.623630109514, 4730.101280756645, 4745.074710431432, 4798.688085274446, 4838.104950584153, 4838.346823178967, 4839.201531747222, 4850.320955066223, 4889.779959901742, 4695.694779839299, 4734.366643507984, 4735.21868891629, 4735.360726302043, 4747.8575642730775], "value": 4571.466838405514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9557635389168, 580.8605934575703, 584.7982446056111, 586.4838941731273, 590.4685782795486, 28095.297617559547, 41894.79052604736, 42950.57049429505, 43045.35431968519, 43077.56922430775, 38558.4216236756, 38871.611283887156, 38973.41539876897, 38981.22037559247, 39013.60986390135, 7422.18355980843, 7558.773236802877, 7569.659365328546, 7570.6971721131085, 7571.205023472538, 7373.225811289818, 7559.848803023936, 9457.574409151604, 9725.51372431379, 9735.41587504752, 9778.462184579845, 9835.213182945346, 9836.606535738561, 9842.655507057254, 9849.950750246238, 9695.272854535939, 9752.609895604202, 9758.12176904075, 9763.365381250267, 9765.0, 9680.75798105046, 9716.31985760997, 9739.269554783348, 9749.0, 9754.317197796157, 37397.813010935046, 37785.05537361561, 37792.24415511674, 37814.24371512554, 37832.81083594592, 2961.8667159977635, 3209.791363561361, 3251.4472539668313, 3420.880269190566, 3485.268093700326, 28306.575401368995, 28763.0, 28796.0, 29103.85448072746, 30142.698573014426, 3431.3137372525343, 3496.9300613987834, 3520.7535472516934, 3577.266660334625, 3600.6759391654614, 236897.81551092135, 236904.97022663747, 236985.99999999828, 237194.0, 239346.0, 52390.47609523856, 52745.73627131917, 52754.20868686973, 52764.47235527595, 52983.470165297855, 54564.72717636466, 54720.45279547154, 54755.72622136864, 54761.726191369584, 54774.45225547773, 13072.411741471657, 13257.07200495956, 13259.73480530384, 13265.66835829112, 13265.801012984813, 8929.10708929102, 9152.679656212, 10040.548175332127, 10087.0, 10098.949505252427, 14038.157710537196, 14828.555143345717, 15529.0, 15581.844181558266, 16277.0, 5620.606557540933, 5626.43735626434, 5663.093904975184, 5725.713714314267, 5881.5000724938, 787.9606019698992, 916.619602864817, 932.785459344341, 951.0006353240148, 991.1179050644931, 26803.463930721275, 27340.726592734216, 27343.430208759593, 27727.861360693067, 27891.0, 926.786839027014, 940.7177846645978, 945.0360632155164, 953.7043516509765, 955.2739917662487, 14441.638959026108, 14740.926295368454, 14798.92600537012, 14915.70168596622, 15051.623709407353, 113809.0, 113866.43066784779, 114074.0, 114177.4291128539, 114183.0, 47658.5234147661, 47803.17574594024, 47938.0, 47951.76024119857, 47979.280310795366, 1085.8914108589079, 1139.5214010115938, 1142.1034487926938, 1143.89704926557, 1174.5595401724354, 25959.61060584055, 26566.867165664047, 26802.0, 27155.321116972234, 27470.17589472319, 43187.35218971655, 43402.782986084865, 43564.34653480137, 43617.563824362616, 43656.56343436525, 313576.0, 313876.0, 314002.0, 314507.0, 314637.0, 35481.82259088688, 35766.0, 35836.0, 35871.46192807162, 38206.0, 38411.42382864315, 38786.6121338783, 41414.1717165661, 41790.79104604579, 42435.0, 34509.309813803084, 35585.28829423449, 35891.820540897126, 35911.28177436489, 36077.27845443129, 35585.82207088948, 36002.8199858999, 36012.09969750777, 36063.63936360603, 36484.81757591195, 35035.124121897155, 35311.64688353187, 36312.09219769527, 36346.0, 36357.63642363648, 29887.356195408593, 31235.843820780752, 31592.839396317497, 31971.84014080008, 32123.196920077185, 25284.241472755846, 25335.61996570016, 25411.618825718, 25421.237362879143, 25851.22446326613], "value": 17069.632876279808, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.81404896909794, 355.1724481957042, 361.1999421281861, 362.24471975930186, 379.89059547602875, 12202.755944881097, 15410.383584656629, 15438.150901700403, 16693.415730449437, 16774.74837877433, 16106.0, 16185.83814161861, 16399.918000410013, 16559.08925009124, 16669.41657042004, 4845.27320901864, 4848.563629273364, 4948.8267910623135, 4989.501049895018, 5066.898662026757, 3591.748577599569, 3757.1358587524887, 4884.072026315007, 4973.825916092937, 4981.37732783402, 5584.6090773645865, 5823.184754134425, 5833.562482813784, 5908.763649454017, 5910.34986151523, 5735.799247026334, 5793.304803423574, 5901.23283973085, 5915.053591425372, 5923.792667256647, 5167.48325167484, 5170.715610641413, 5172.767225474862, 5173.249878767595, 5175.767090480937, 19266.614667706708, 20285.8985705072, 20399.694004589943, 20494.18023279067, 20498.487537811674, 1846.1784505894882, 1912.177763561668, 1930.9806901930942, 2056.9280075197444, 2334.3813889319345, 8606.354523410706, 12112.576059837864, 12623.368831558477, 13109.147905386119, 13364.866351336557, 1630.8776841736917, 1661.551381127101, 1708.3679038755615, 1712.888662236963, 1721.2684609041232, 65404.3459565403, 66204.3379566203, 66567.3343266566, 66871.66564167148, 66970.66514667396, 9987.700368988943, 10197.18422526211, 10215.438150901771, 10276.537555810006, 10332.70841144857, 13755.38100785467, 13895.65260868466, 13898.235597042058, 13902.0, 13909.234992075331, 6799.11611490503, 6849.4177994871, 6888.41448476875, 7054.2945705430075, 7072.257412971667, 6360.109584658151, 6374.426301632875, 6513.837154071186, 6550.705218265094, 6551.770688025991, 4282.122164956177, 4296.076343586082, 4314.935275970863, 4346.456692913386, 4470.418845550058, 1721.1910402110989, 1723.5087999919963, 1748.8688348373923, 1752.3603884582035, 1811.5652243461739, 799.7680672604996, 804.4931693033468, 837.9706710265111, 860.6600392844791, 903.2039868299352, 16095.839041609433, 16566.585835354213, 16838.32646694143, 17062.573435664206, 17406.564835879206, 779.5751315533048, 818.2553875972836, 830.7258604660448, 841.3101256969348, 847.1232274595764, 9259.583318750672, 9264.305177111608, 9585.760355991157, 9616.23070154386, 9785.951070244602, 260316.0, 266441.0, 331596.0, 332880.0, 337330.0, 54364.28301774315, 57766.111694415114, 69110.0, 69127.0, 78391.60804196057, 914.9039350868196, 935.6210734652477, 936.5644975086617, 983.6409710455775, 986.5412583148727, 15079.0, 15171.0, 15681.686366272383, 16066.59833504125, 16073.35706571724, 35109.32157415168, 35753.0, 36081.0, 36173.638263617024, 36566.63433365632, 44874.551254487036, 48444.515554844, 49069.0, 49640.75179624079, 51348.0, 6749.358810912955, 6881.4494840413645, 6957.965210173917, 7296.671649775667, 7565.583892885724, 10551.577936882439, 11616.0, 11911.344876031555, 11928.701782455508, 12211.633650990485, 10110.882915835813, 10168.949155254177, 10324.43215623148, 10808.56765729362, 10914.727131821768, 9686.660966866126, 9763.218942484442, 9790.853137202805, 9935.453550054817, 10090.798184036132, 7148.714051438093, 9608.615655373986, 9617.759556010877, 10257.846132307872, 10519.0, 7451.701931922662, 7466.962665186639, 7528.134264559427, 7532.397408207221, 7896.289333959971, 7645.350145237717, 9872.308938374244, 9981.251406144424, 10253.897461025592, 10416.21878359111], "value": 7991.191961971762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.7134030513287, 1315.9407826647803, 1364.3246592936498, 1613.038896008472, 1628.1289510112085, 6107.053406721965, 6325.1144839722365, 6711.832204194898, 7158.961950517179, 7177.3540381365665, 6736.0, 7016.614086225269, 7038.225795162528, 7053.57678539288, 7213.026241457402, 2031.7561892572876, 2080.6358887194756, 2081.927132550361, 2082.416923261489, 2083.343746719786, 1799.7750281214849, 1846.3906910719431, 2078.2414418737126, 2084.4893001214723, 2096.811286984171, 1987.5130593004735, 2055.9074841632164, 2058.3207541511265, 2062.9484262893397, 2067.803558661932, 2055.5066783971815, 2059.5983783162287, 2081.0739221046565, 2087.968680469794, 2097.842661800356, 2100.0759665747023, 2100.527381339202, 2103.7265155529835, 2105.357865850915, 2109.683547467877, 7049.400800931876, 7235.312645298688, 7238.963805180993, 7251.419886409075, 7252.818679533001, 4286.228478873802, 4369.584889435499, 4477.059817438342, 4515.7516336601475, 4518.096380723869, 2750.6561679790025, 2887.5379939209624, 3001.7598592112577, 3002.219422950027, 3014.427258820839, 906.1572737354257, 917.7200953709116, 927.3230541704594, 969.5152423788106, 972.1639390124558, 9286.674966376211, 9489.810203795954, 9495.0, 9496.952515237379, 9510.809783804285, 3851.171998020439, 3968.8015599219925, 3992.121733218687, 4104.56902025283, 4135.193637240709, 7502.737404190827, 7549.169591344948, 7556.0, 7556.1310449297935, 7568.508046977039, 4342.891427714332, 4344.9348259776125, 4354.7822608870065, 4358.193734159191, 4358.716683415568, 3938.3107956107565, 3995.5205375355144, 4020.537638171589, 4031.3348297531165, 4043.4945631796027, 3162.1462205204466, 3173.0639461358955, 3201.551782750417, 3213.196700824794, 3239.3521295740948, 894.2711689972651, 928.0, 968.7142293023575, 985.8077674853334, 1002.6941782756184, 660.4914216053612, 752.5710345103239, 804.129312686763, 821.5358322547861, 830.0164305298241, 5064.392272927273, 5116.897662046738, 5131.948680513222, 5163.173892177234, 5234.816781412632, 818.6602559937678, 827.6399766101765, 840.8570543007703, 863.317978796756, 892.4243862708646, 3760.4735337052834, 3808.27642747877, 3843.1929294847837, 3866.2074274773604, 3935.878274691699, 8085.514869107872, 8398.706045288385, 8429.873551896726, 8648.1784230498, 8662.826743465095, 8591.312694984386, 8595.140485951355, 8610.0, 8610.440321379216, 8610.526421046903, 6361.0, 6453.645049522322, 6467.547271691031, 6476.579022363531, 6483.7730679425995, 4849.248366503198, 4973.179425394769, 5011.899762004812, 5029.64792464524, 5076.390833100052, 7501.774946751606, 7511.887321690288, 7654.617269136632, 7661.502002369828, 7750.728724494616, 7734.497257678233, 7755.844883102419, 7774.144844067035, 7807.453478256468, 7846.646900889587, 5798.971005144947, 5962.821115366546, 5962.9105563415715, 5963.612365196248, 6007.939920600738, 6843.794686159423, 6845.828854278683, 6914.792556223321, 6918.135233095863, 6929.618870962146, 6301.653409062362, 6305.905411418924, 6308.243010838729, 6338.58799178052, 6345.17512723343, 6099.9390006099375, 6203.658798766111, 6218.098375735583, 6228.408301211378, 6238.532110091852, 5833.154192642128, 5875.794347197828, 5931.3178984417345, 5946.108083787293, 5957.49361304294, 4267.402563641155, 4434.290513517822, 4443.866683999485, 4489.910201796011, 4541.931871021871, 4377.0, 4451.488078870972, 4500.974561447297, 4580.427446569179, 4678.157931572349], "value": 3845.3356313247027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.61570072551706, 284.75795573762304, 288.17581716291403, 291.58435794219076, 291.9226405002674, 4529.297958816381, 4651.4650815156265, 4677.134730074934, 4720.551547602977, 4779.761011949406, 4559.544045595439, 4611.769411529419, 4639.605633521155, 4668.206404911165, 4679.578837904588, 3651.233241019389, 3669.9266014679692, 3672.008557689422, 3674.210044840359, 3676.5588129424505, 3480.8861164427267, 3663.688586470153, 3684.5025921500524, 3693.8707145249923, 3694.113412780927, 3485.651434856507, 3559.288142371523, 3665.138692407282, 3677.9448308275396, 3708.1841994761107, 3647.544056992876, 3664.4686520454384, 3667.486551882752, 3687.8340474678434, 3705.1478160023344, 3272.051105179495, 3275.033865009828, 3276.1482014676117, 3276.3938671345877, 3278.606567211926, 4471.686981911267, 4620.19146649335, 4637.5826175644015, 4650.883727906796, 4651.139539185261, 4176.248275310443, 4189.91620167598, 4197.664186865074, 4216.198922204771, 4222.429971953778, 4910.8281210157475, 4939.827106051307, 4943.307936888838, 4956.677815941952, 4962.87592810179, 3536.398812201932, 3539.752217344787, 3541.8406171722336, 3544.220271540257, 3549.4498352755104, 4908.754562271872, 5132.486751324875, 5133.486651334837, 5165.199394093921, 5184.040952423776, 3481.9303613927577, 3498.9475157872653, 3504.667056629616, 3506.053365591276, 3523.418635925044, 3543.0965103898343, 3544.3442963051916, 3553.09396103997, 3559.288142371536, 3562.091666624994, 3962.583928687446, 4103.610157035077, 4104.199681062164, 4108.609682080198, 4149.2738770715605, 4865.464798872121, 4900.803967841318, 4907.411110666742, 4924.803007879645, 4925.2119660854805, 1189.2448295332526, 1228.791105512065, 1254.8870601645895, 1257.2393701810456, 1257.974840503203, 826.904351733955, 836.677879016583, 862.9223369896739, 863.2964134230582, 863.447393668053, 4263.168682107022, 4263.211305908417, 4269.338252570857, 4281.186574550826, 4282.9785851071165, 4896.436909755424, 4916.582090522345, 4916.975415122902, 4930.580900623487, 4931.654784165074, 4126.66986641068, 4208.263553878121, 4216.9036050627055, 4261.275583150872, 4285.421468101767, 2574.206985420802, 2582.2382397192496, 2586.6120081987474, 2587.2884956637076, 2600.206936884231, 4561.566651168134, 4576.970181709089, 4580.763193937618, 4583.960137738674, 4602.309653551994, 4820.373351464287, 4935.988122434892, 4937.950620493749, 4992.375953005874, 5001.124803159505, 4527.0, 4538.526503055842, 4543.477500087466, 4546.772661366918, 4579.6794224403975, 4846.491118432514, 4850.1997170466475, 4858.5384388483035, 4876.512348765095, 4881.365422495053, 4596.379488768974, 4702.882427939329, 4743.407074115736, 4754.358161648272, 4765.166095933268, 4514.232580461264, 4567.566081222411, 4572.611328037021, 4575.7483338416705, 4577.420789827504, 3481.4603736420895, 3500.1599616092462, 3509.64903509647, 3510.1751088494693, 3526.682598566141, 4749.96002558356, 4812.807487700453, 4842.5157484251295, 4894.975525122351, 4910.968696573759, 4713.835015774432, 4726.740029298421, 4728.146560553138, 4736.5973892219545, 4758.333833263277, 4743.264793956942, 4757.16749568831, 4805.57318554128, 4806.543378379049, 4825.879353016203, 4397.9340309896015, 4704.482506924304, 4707.17624415719, 4713.457952335525, 4716.339712440193, 4685.5080216578135, 4700.882477938079, 4720.291956206596, 4727.550882666142, 4751.382320298339, 4631.745254011062, 4640.164770341371, 4665.020345727436, 4681.016986432887, 4683.344331793483], "value": 3641.1392438140124, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.4453148418296, 682.6109117802852, 686.5091459606381, 723.334532230348, 741.5550669598242, 12493.937530312347, 13580.660483487918, 13640.863591364083, 13657.180569165845, 13663.999999999987, 12432.502699891993, 12436.378181090955, 12444.0, 12509.687257818536, 12551.497940082385, 617.718937883262, 636.1253276744476, 740.9259074092574, 757.829488365119, 767.6277005652282, 772.7797577690359, 774.2296415067016, 776.2780614028951, 776.5185584937346, 776.5651235308245, 821.6179476543406, 822.6298165825373, 823.6334831000207, 823.8064054947113, 824.0235321144434, 650.9153810004716, 668.1381018486147, 816.6733306677318, 817.0930267403148, 817.4441379861692, 584.298841390329, 602.1780269931555, 602.6414283501309, 602.7890238416563, 605.8848818724429, 13539.661508462268, 13564.186148831102, 13602.0, 13612.591622251348, 13618.727625447535, 12931.418086186144, 12931.642177571408, 13264.137831040951, 13349.46602135923, 13492.527761528398, 11448.181468512259, 11758.0, 11850.31391560042, 12183.756324873542, 12215.877841221563, 4018.8995275118064, 4064.7561146331313, 4067.5670292020204, 4072.8778136655947, 4084.326086195774, 64513.35486645167, 65693.67153164251, 66129.33870661329, 66166.33833661601, 66220.0, 10343.0, 10534.367937923596, 10637.840432393365, 10687.46562671879, 11127.610533631285, 19787.0, 19797.30709425163, 19828.50428739293, 19849.60300793976, 19880.304189353305, 6515.0, 6597.274299827015, 6746.494012949049, 6758.256591774901, 6838.350356716104, 3569.268299998494, 3601.549806274216, 3649.288388764219, 3663.68858647018, 3708.0173753955223, 2660.7339266073236, 2744.8078634495396, 2759.0, 2766.1148432501404, 2782.123631056211, 469.1227404753133, 471.6721878294621, 476.58060906402835, 481.81931775584155, 487.11831584831566, 478.3160081084014, 524.2712629445074, 530.2761730238198, 536.3456582968772, 545.3564793543657, 7888.526688398714, 8024.117347091816, 8024.518528888286, 8264.958675206586, 8350.540720260322, 550.3505863081522, 555.2753656478254, 555.5722093987607, 581.4882903045293, 581.6800759582213, 3710.3692372296773, 3988.361862102108, 3988.700847436454, 4014.6186112319283, 4040.717149799486, 67588.6620566894, 68425.0, 69150.0, 70727.0, 71556.28443715496, 60713.08930366048, 61501.69249153726, 62535.6873215631, 62822.685886570274, 63740.36259637437, 55086.0, 55876.999999999185, 56401.71799140978, 56833.14750278749, 57109.42890571041, 7455.850882982419, 8022.398320126131, 8242.546659933521, 8291.792705182419, 8304.87542686848, 38999.2200156001, 39053.0, 39975.80012099921, 40387.0, 40959.1808163841, 47531.44434001913, 51600.74199628978, 51906.0, 52532.212016819016, 54719.72640136774, 9877.50612469388, 9928.156106731009, 9928.404295742279, 10122.746931326481, 10421.322614030063, 10463.529141188817, 10464.0, 10665.680029599125, 11058.115350771757, 11681.88318116842, 10081.143102836048, 10838.0, 11518.769624607628, 11807.586734464252, 12064.095192860746, 12026.699332516408, 12059.69850753703, 12070.215435996632, 12644.936775316064, 12684.936575317064, 11844.170908036354, 11882.643520694393, 12217.389130543259, 12496.125271230927, 12595.937020315207, 10072.294939354175, 10258.640947567097, 10443.738906527398, 10493.737656558647, 10673.519691613741, 10140.340877842917, 10447.612102807976, 10533.841992369968, 10599.62901298451, 10656.62701805433], "value": 6330.66711532718, "unit": "score"}], "name": "dromaeo_css", "value": 6172.024232540592, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 117.0, 119.0, 118.0, 116.0, 116.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 130.0, 180.0, 130.0, 137.0, 138.0, 129.0, 161.0, 142.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 165.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 76.0, 111.0, 77.0, 78.0, 77.0, 78.0, 92.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 85.0, 85.0, 84.0, 105.0, 84.0, 84.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 67.0, 65.0, 68.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 68.0, 66.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 88.0, 91.0, 85.0, 86.0, 84.0, 95.0, 85.0, 86.0, 96.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 147.0, 143.0, 141.0, 139.0, 141.0, 143.0, 184.0, 164.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 180.0, 184.0, 179.0, 182.0, 181.0, 179.0, 178.0, 185.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 68.0, 70.0, 68.0, 74.0, 70.0, 72.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1576.5000000000002, "alertThreshold": 2.0}]} 07:39:54 INFO - Return code: 0 07:39:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:54 INFO - # TBPL SUCCESS # 07:39:54 INFO - Running post-action listener: _resource_record_post_action 07:39:54 INFO - [mozharness: 2016-12-07 15:39:54.335798Z] Finished run-tests step (success) 07:39:54 INFO - Running post-run listener: _resource_record_post_run 07:39:54 INFO - Total resource usage - Wall time: 1210s; CPU: 13.0%; Read bytes: 2142208; Write bytes: 389910528; Read time: 1284; Write time: 1010792 07:39:54 INFO - TinderboxPrint: CPU usage
13.2% 07:39:54 INFO - TinderboxPrint: I/O read bytes / time
2,142,208 / 1,284 07:39:54 INFO - TinderboxPrint: I/O write bytes / time
389,910,528 / 1,010,792 07:39:54 INFO - TinderboxPrint: CPU idle
8,377.9 (86.8%) 07:39:54 INFO - TinderboxPrint: CPU user
1,211.0 (12.5%) 07:39:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:54 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 99778560; Read time: 0; Write time: 283528 07:39:54 INFO - run-tests - Wall time: 1192s; CPU: 13.0%; Read bytes: 2142208; Write bytes: 289951744; Read time: 1284; Write time: 727224 07:39:54 INFO - Running post-run listener: _upload_blobber_files 07:39:54 INFO - Blob upload gear active. 07:39:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:56 INFO - (blobuploader) - INFO - Done attempting. 07:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:59 INFO - (blobuploader) - INFO - Done attempting. 07:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:00 INFO - (blobuploader) - INFO - Done attempting. 07:40:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:40:00 INFO - Return code: 0 07:40:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:40:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:40:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca388cbfbcda57754e66f6e49653d6f13fbd52fe264f06f417fec6a3d31985b7616de142d1cb47971ed36ad738e40a1abafb685b35f903f3205ca6f604e57ac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2578ebce46c3ed9517b41c5f614884916b598115468c57a2029d784e61537a19fd5661d0de9da4f4d8e912e0a4e589390b9594a1075b6fc9b8ee7a99265417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b83d3ed5590df0e40e74de61014625ffe32860ce3cba8836f1d8964b4f0aaaf921c391d960cb71b069613240c83ecfad22a4e8b8d62cb6d1215e970db89ae7a"} 07:40:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:40:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:40:00 INFO - Contents: 07:40:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca388cbfbcda57754e66f6e49653d6f13fbd52fe264f06f417fec6a3d31985b7616de142d1cb47971ed36ad738e40a1abafb685b35f903f3205ca6f604e57ac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2578ebce46c3ed9517b41c5f614884916b598115468c57a2029d784e61537a19fd5661d0de9da4f4d8e912e0a4e589390b9594a1075b6fc9b8ee7a99265417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b83d3ed5590df0e40e74de61014625ffe32860ce3cba8836f1d8964b4f0aaaf921c391d960cb71b069613240c83ecfad22a4e8b8d62cb6d1215e970db89ae7a"} 07:40:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:40:00 INFO - Copying logs to upload dir... 07:40:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:40:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.012078 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-12-07 07:39:59.986591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 07:39:59.989959) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca388cbfbcda57754e66f6e49653d6f13fbd52fe264f06f417fec6a3d31985b7616de142d1cb47971ed36ad738e40a1abafb685b35f903f3205ca6f604e57ac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2578ebce46c3ed9517b41c5f614884916b598115468c57a2029d784e61537a19fd5661d0de9da4f4d8e912e0a4e589390b9594a1075b6fc9b8ee7a99265417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b83d3ed5590df0e40e74de61014625ffe32860ce3cba8836f1d8964b4f0aaaf921c391d960cb71b069613240c83ecfad22a4e8b8d62cb6d1215e970db89ae7a"} build_url:https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011827 build_url: 'https://queue.taskcluster.net/v1/task/ICuj-yDhRlGRDWQexXiGsw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca388cbfbcda57754e66f6e49653d6f13fbd52fe264f06f417fec6a3d31985b7616de142d1cb47971ed36ad738e40a1abafb685b35f903f3205ca6f604e57ac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2578ebce46c3ed9517b41c5f614884916b598115468c57a2029d784e61537a19fd5661d0de9da4f4d8e912e0a4e589390b9594a1075b6fc9b8ee7a99265417", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b83d3ed5590df0e40e74de61014625ffe32860ce3cba8836f1d8964b4f0aaaf921c391d960cb71b069613240c83ecfad22a4e8b8d62cb6d1215e970db89ae7a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 07:40:00.015947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:40:00.016282) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1481119079.549062-146511257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:40:00.099426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 07:40:00.099752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 07:40:00.100035) ========= ========= Total master_lag: 0.16 =========