builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1484767929.04 results: success (0) buildid: 20170118113039 builduid: d19c40545ab5463ca4cbea88a5d7f625 revision: 7715d62057e50fdafddeca167ecf2d1dbd79b35b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.039952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.040407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.040704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.054740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.055127) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-18 11:32:09-- 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% 218M=0s 2017-01-18 11:32:09 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.181206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.181550) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014188 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:09.231723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 11:32:09.232087) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7715d62057e50fdafddeca167ecf2d1dbd79b35b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7715d62057e50fdafddeca167ecf2d1dbd79b35b --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=a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-18 11:32:09,492 truncating revision to first 12 chars 2017-01-18 11:32:09,492 Setting DEBUG logging. 2017-01-18 11:32:09,492 attempt 1/10 2017-01-18 11:32:09,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7715d62057e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 11:32:10,515 unpacking tar archive at: mozilla-inbound-7715d62057e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 11:32:10.597316) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:10.597663) ========= script_repo_revision: 7715d62057e50fdafddeca167ecf2d1dbd79b35b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:10.598066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:10.598349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 11:32:10.607119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 11:32:10.607394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:32:10 INFO - MultiFileLogger online at 20170118 11:32:10 in /builds/slave/test 11:32:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:32:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:32:10 INFO - {'append_to_log': False, 11:32:10 INFO - 'base_work_dir': '/builds/slave/test', 11:32:10 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:32:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:32:10 INFO - 'branch': 'Mozilla-Inbound', 11:32:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:10 INFO - 'config_files': ('talos/linux_config.py',), 11:32:10 INFO - 'default_actions': ('clobber', 11:32:10 INFO - 'read-buildbot-config', 11:32:10 INFO - 'download-and-extract', 11:32:10 INFO - 'populate-webroot', 11:32:10 INFO - 'create-virtualenv', 11:32:10 INFO - 'install', 11:32:10 INFO - 'run-tests'), 11:32:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:10 INFO - 'download_minidump_stackwalk': True, 11:32:10 INFO - 'download_symbols': 'ondemand', 11:32:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:10 INFO - 'installer_path': 'installer.exe', 11:32:10 INFO - 'log_level': 'info', 11:32:10 INFO - 'log_name': 'talos', 11:32:10 INFO - 'log_to_console': True, 11:32:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:32:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:32:10 INFO - 'opt_config_files': (), 11:32:10 INFO - 'pip_index': False, 11:32:10 INFO - 'sps_profile': False, 11:32:10 INFO - 'sps_profile_interval': 0, 11:32:10 INFO - 'suite': 'dromaeojs', 11:32:10 INFO - 'system_bits': '32', 11:32:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:10 INFO - 'title': 'talos-linux64-ix-062', 11:32:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:10 INFO - 'use_talos_json': True, 11:32:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:32:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:10 INFO - 'work_dir': 'build'} 11:32:10 INFO - [mozharness: 2017-01-18 19:32:10.964512Z] Running clobber step. 11:32:10 INFO - Running pre-action listener: _resource_record_pre_action 11:32:10 INFO - Running main action method: clobber 11:32:10 INFO - rmtree: /builds/slave/test/build 11:32:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:32:11 INFO - Running post-action listener: _resource_record_post_action 11:32:11 INFO - [mozharness: 2017-01-18 19:32:11.426283Z] Finished clobber step (success) 11:32:11 INFO - [mozharness: 2017-01-18 19:32:11.426384Z] Running read-buildbot-config step. 11:32:11 INFO - Running pre-action listener: _resource_record_pre_action 11:32:11 INFO - Running main action method: read_buildbot_config 11:32:11 INFO - Using buildbot properties: 11:32:11 INFO - { 11:32:11 INFO - "project": "", 11:32:11 INFO - "product": "firefox", 11:32:11 INFO - "script_repo_revision": "production", 11:32:11 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 11:32:11 INFO - "repository": "", 11:32:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 11:32:11 INFO - "buildid": "20170118113039", 11:32:11 INFO - "stage_platform": "linux64-pgo", 11:32:11 INFO - "basedir": "/builds/slave/test", 11:32:11 INFO - "buildnumber": 3255, 11:32:11 INFO - "platform": "ubuntu64_hw", 11:32:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:32:11 INFO - "slavebuilddir": "test", 11:32:11 INFO - "branch": "mozilla-inbound", 11:32:11 INFO - "revision": "7715d62057e50fdafddeca167ecf2d1dbd79b35b", 11:32:11 INFO - "slavename": "talos-linux64-ix-062", 11:32:11 INFO - "builduid": "d19c40545ab5463ca4cbea88a5d7f625", 11:32:11 INFO - "repo_path": "integration/mozilla-inbound" 11:32:11 INFO - } 11:32:11 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:32:11 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:32:11 INFO - Running post-action listener: _resource_record_post_action 11:32:11 INFO - [mozharness: 2017-01-18 19:32:11.428767Z] Finished read-buildbot-config step (success) 11:32:11 INFO - [mozharness: 2017-01-18 19:32:11.428857Z] Running download-and-extract step. 11:32:11 INFO - Running pre-action listener: _resource_record_pre_action 11:32:11 INFO - Running main action method: download_and_extract 11:32:11 INFO - mkdir: /builds/slave/test/build/tests 11:32:11 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')]} 11:32:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:32:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/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 11:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/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 11:32:11 INFO - Downloaded 1361 bytes. 11:32:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:32:11 INFO - Using the following test package requirements: 11:32:11 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:32:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:32:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'jsshell-linux-x86_64.zip'], 11:32:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:32:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:32:11 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:32:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:32:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:32:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:32:11 INFO - Expected file size: 21875589 11:32:11 INFO - Obtained file size: 21875589 11:32:15 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 11:32:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:32:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:32:16 INFO - Expected file size: 21875589 11:32:16 INFO - Obtained file size: 21875589 11:32:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:32:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:32:20 INFO - Expected file size: 14403463 11:32:20 INFO - Obtained file size: 14403463 11:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:20 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:32:20 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/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 11:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/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 11:32:21 INFO - Downloaded 61622504 bytes. 11:32:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:32:21 INFO - mkdir: /builds/slave/test/properties 11:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:21 INFO - Contents: 11:32:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:32:21 INFO - Running post-action listener: _resource_record_post_action 11:32:21 INFO - Running post-action listener: set_extra_try_arguments 11:32:21 INFO - [mozharness: 2017-01-18 19:32:21.695086Z] Finished download-and-extract step (success) 11:32:21 INFO - [mozharness: 2017-01-18 19:32:21.695313Z] Running populate-webroot step. 11:32:21 INFO - Running pre-action listener: _resource_record_pre_action 11:32:21 INFO - Running main action method: populate_webroot 11:32:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:32:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:32:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:32:21 INFO - '--tppagecycles', 11:32:21 INFO - '7'], 11:32:21 INFO - 'tests': ['tsvgm']}}, 11:32:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:32:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:32:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['damp', 'tps']}, 11:32:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'tests': ['damp', 'tps']}, 11:32:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['dromaeo_dom']}, 11:32:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['basic_compositor_video']}, 11:32:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:32:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['a11yr', 11:32:21 INFO - 'ts_paint', 11:32:21 INFO - 'tpaint', 11:32:21 INFO - 'sessionrestore', 11:32:21 INFO - 'sessionrestore_no_auto_restore', 11:32:21 INFO - 'tabpaint']}, 11:32:21 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:21 INFO - 'ts_paint', 11:32:21 INFO - 'tpaint', 11:32:21 INFO - 'sessionrestore', 11:32:21 INFO - 'sessionrestore_no_auto_restore', 11:32:21 INFO - 'tabpaint']}, 11:32:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:32:21 INFO - 'ts_paint', 11:32:21 INFO - 'tpaint', 11:32:21 INFO - 'sessionrestore', 11:32:21 INFO - 'sessionrestore_no_auto_restore', 11:32:21 INFO - 'tabpaint']}, 11:32:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:32:21 INFO - 'ts_paint', 11:32:21 INFO - 'tpaint', 11:32:21 INFO - 'sessionrestore', 11:32:21 INFO - 'sessionrestore_no_auto_restore', 11:32:21 INFO - 'tabpaint']}, 11:32:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['a11yr', 11:32:21 INFO - 'ts_paint', 11:32:21 INFO - 'tpaint', 11:32:21 INFO - 'sessionrestore', 11:32:21 INFO - 'sessionrestore_no_auto_restore', 11:32:21 INFO - 'tabpaint']}, 11:32:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['a11yr', 11:32:21 INFO - 'ts_paint', 11:32:21 INFO - 'tpaint', 11:32:21 INFO - 'sessionrestore', 11:32:21 INFO - 'sessionrestore_no_auto_restore', 11:32:21 INFO - 'tabpaint']}, 11:32:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['tsvgx', 11:32:21 INFO - 'tsvgr_opacity', 11:32:21 INFO - 'tart', 11:32:21 INFO - 'tscrollx', 11:32:21 INFO - 'cart', 11:32:21 INFO - 'tsvg_static']}, 11:32:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:21 INFO - 'tsvgr_opacity', 11:32:21 INFO - 'tart', 11:32:21 INFO - 'tscrollx', 11:32:21 INFO - 'cart', 11:32:21 INFO - 'tsvg_static']}, 11:32:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'talos_options': ['--disable-e10s'], 11:32:21 INFO - 'tests': ['tp5o']}, 11:32:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:32:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'talos_options': ['--disable-e10s', 11:32:21 INFO - '--xperf_path', 11:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:21 INFO - 'tests': ['tp5n']}, 11:32:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:32:21 INFO - 'talos_options': ['--xperf_path', 11:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:21 INFO - 'tests': ['tp5n']}}, 11:32:21 INFO - 'talos.zip': {'path': '', 11:32:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:32:21 INFO - Running post-action listener: _resource_record_post_action 11:32:21 INFO - [mozharness: 2017-01-18 19:32:21.714020Z] Finished populate-webroot step (success) 11:32:21 INFO - [mozharness: 2017-01-18 19:32:21.714109Z] Running create-virtualenv step. 11:32:21 INFO - Running pre-action listener: _resource_record_pre_action 11:32:21 INFO - Running main action method: create_virtualenv 11:32:21 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32: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 11:32:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:32:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:21 INFO - Using real prefix '/usr' 11:32:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:22 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:24 INFO - Installing pip.................done. 11:32:24 INFO - Return code: 0 11:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:32:24 INFO - Reading from file tmpfile_stdout 11:32:24 INFO - Output received: 11:32: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) 11:32:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:24 INFO - Using env: {'DISPLAY': ':0', 11:32:24 INFO - 'HOME': '/home/cltbld', 11:32:24 INFO - 'LANG': 'en_US.UTF-8', 11:32:24 INFO - 'LANGUAGE': 'en_US:en', 11:32:24 INFO - 'LOGNAME': 'cltbld', 11:32:24 INFO - 'MAIL': '/var/mail/cltbld', 11:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:24 INFO - 'MOZ_NO_REMOTE': '1', 11:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:24 INFO - 'NO_EM_RESTART': '1', 11:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:24 INFO - 'PWD': '/builds/slave/test', 11:32:24 INFO - 'SHELL': '/bin/bash', 11:32:24 INFO - 'SHLVL': '1', 11:32:24 INFO - 'TERM': 'linux', 11:32:24 INFO - 'TMOUT': '86400', 11:32:24 INFO - 'USER': 'cltbld', 11:32:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:24 INFO - '_': '/tools/buildbot/bin/python'} 11:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32: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 11:32:24 INFO - Cleaning up... 11:32:24 INFO - Return code: 0 11:32:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:24 INFO - Using env: {'DISPLAY': ':0', 11:32:24 INFO - 'HOME': '/home/cltbld', 11:32:24 INFO - 'LANG': 'en_US.UTF-8', 11:32:24 INFO - 'LANGUAGE': 'en_US:en', 11:32:24 INFO - 'LOGNAME': 'cltbld', 11:32:24 INFO - 'MAIL': '/var/mail/cltbld', 11:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:24 INFO - 'MOZ_NO_REMOTE': '1', 11:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:24 INFO - 'NO_EM_RESTART': '1', 11:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:24 INFO - 'PWD': '/builds/slave/test', 11:32:24 INFO - 'SHELL': '/bin/bash', 11:32:24 INFO - 'SHLVL': '1', 11:32:24 INFO - 'TERM': 'linux', 11:32:24 INFO - 'TMOUT': '86400', 11:32:24 INFO - 'USER': 'cltbld', 11:32:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:24 INFO - '_': '/tools/buildbot/bin/python'} 11:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:24 INFO - Downloading/unpacking psutil>=3.1.1 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:27 INFO - Installing collected packages: psutil 11:32:27 INFO - Running setup.py install for psutil 11:32:27 INFO - building 'psutil._psutil_linux' extension 11:32:27 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 11:32: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:32:27 INFO - building 'psutil._psutil_posix' extension 11:32: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 11:32: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 11:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:27 INFO - Successfully installed psutil 11:32:27 INFO - Cleaning up... 11:32:27 INFO - Return code: 0 11:32:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:27 INFO - Using env: {'DISPLAY': ':0', 11:32:27 INFO - 'HOME': '/home/cltbld', 11:32:27 INFO - 'LANG': 'en_US.UTF-8', 11:32:27 INFO - 'LANGUAGE': 'en_US:en', 11:32:27 INFO - 'LOGNAME': 'cltbld', 11:32:27 INFO - 'MAIL': '/var/mail/cltbld', 11:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:27 INFO - 'MOZ_NO_REMOTE': '1', 11:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:27 INFO - 'NO_EM_RESTART': '1', 11:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:27 INFO - 'PWD': '/builds/slave/test', 11:32:27 INFO - 'SHELL': '/bin/bash', 11:32:27 INFO - 'SHLVL': '1', 11:32:27 INFO - 'TERM': 'linux', 11:32:27 INFO - 'TMOUT': '86400', 11:32:27 INFO - 'USER': 'cltbld', 11:32:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:27 INFO - '_': '/tools/buildbot/bin/python'} 11:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:29 INFO - Installing collected packages: mozsystemmonitor 11:32:29 INFO - Running setup.py install for mozsystemmonitor 11:32:29 INFO - Successfully installed mozsystemmonitor 11:32:29 INFO - Cleaning up... 11:32:30 INFO - Return code: 0 11:32:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:32:30 INFO - Using env: {'DISPLAY': ':0', 11:32:30 INFO - 'HOME': '/home/cltbld', 11:32:30 INFO - 'LANG': 'en_US.UTF-8', 11:32:30 INFO - 'LANGUAGE': 'en_US:en', 11:32:30 INFO - 'LOGNAME': 'cltbld', 11:32:30 INFO - 'MAIL': '/var/mail/cltbld', 11:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:30 INFO - 'MOZ_NO_REMOTE': '1', 11:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:30 INFO - 'NO_EM_RESTART': '1', 11:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:30 INFO - 'PWD': '/builds/slave/test', 11:32:30 INFO - 'SHELL': '/bin/bash', 11:32:30 INFO - 'SHLVL': '1', 11:32:30 INFO - 'TERM': 'linux', 11:32:30 INFO - 'TMOUT': '86400', 11:32:30 INFO - 'USER': 'cltbld', 11:32:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:30 INFO - '_': '/tools/buildbot/bin/python'} 11:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:30 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:32 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:32 INFO - warning: no files found matching '*.txt' 11:32:32 INFO - no previously-included directories found matching 'build' 11:32:32 INFO - no previously-included directories found matching 'dist' 11:32:32 INFO - no previously-included directories found matching '.git*' 11:32:32 INFO - Installing collected packages: jsonschema, functools32 11:32:32 INFO - Running setup.py install for functools32 11:32:32 INFO - warning: no files found matching '*.txt' 11:32:32 INFO - no previously-included directories found matching 'build' 11:32:32 INFO - no previously-included directories found matching 'dist' 11:32:32 INFO - no previously-included directories found matching '.git*' 11:32:32 INFO - Successfully installed jsonschema functools32 11:32:32 INFO - Cleaning up... 11:32:32 INFO - Return code: 0 11:32:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:32 INFO - Using env: {'DISPLAY': ':0', 11:32:32 INFO - 'HOME': '/home/cltbld', 11:32:32 INFO - 'LANG': 'en_US.UTF-8', 11:32:32 INFO - 'LANGUAGE': 'en_US:en', 11:32:32 INFO - 'LOGNAME': 'cltbld', 11:32:32 INFO - 'MAIL': '/var/mail/cltbld', 11:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:32 INFO - 'MOZ_NO_REMOTE': '1', 11:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:32 INFO - 'NO_EM_RESTART': '1', 11:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:32 INFO - 'PWD': '/builds/slave/test', 11:32:32 INFO - 'SHELL': '/bin/bash', 11:32:32 INFO - 'SHLVL': '1', 11:32:32 INFO - 'TERM': 'linux', 11:32:32 INFO - 'TMOUT': '86400', 11:32:32 INFO - 'USER': 'cltbld', 11:32:32 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:32 INFO - '_': '/tools/buildbot/bin/python'} 11:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:32 INFO - Cleaning up... 11:32:32 INFO - Return code: 0 11:32:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:32:33 INFO - Using env: {'DISPLAY': ':0', 11:32:33 INFO - 'HOME': '/home/cltbld', 11:32:33 INFO - 'LANG': 'en_US.UTF-8', 11:32:33 INFO - 'LANGUAGE': 'en_US:en', 11:32:33 INFO - 'LOGNAME': 'cltbld', 11:32:33 INFO - 'MAIL': '/var/mail/cltbld', 11:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:33 INFO - 'MOZ_NO_REMOTE': '1', 11:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:33 INFO - 'NO_EM_RESTART': '1', 11:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:33 INFO - 'PWD': '/builds/slave/test', 11:32:33 INFO - 'SHELL': '/bin/bash', 11:32:33 INFO - 'SHLVL': '1', 11:32:33 INFO - 'TERM': 'linux', 11:32:33 INFO - 'TMOUT': '86400', 11:32:33 INFO - 'USER': 'cltbld', 11:32:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:33 INFO - '_': '/tools/buildbot/bin/python'} 11:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:33 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:35 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:35 INFO - Downloading docopt-0.6.1.tar.gz 11:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:36 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:36 INFO - Running setup.py install for blobuploader 11:32:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:36 INFO - Running setup.py install for requests 11:32:36 INFO - Running setup.py install for docopt 11:32:36 INFO - Successfully installed blobuploader requests docopt 11:32:36 INFO - Cleaning up... 11:32:36 INFO - Return code: 0 11:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:36 INFO - Using env: {'DISPLAY': ':0', 11:32:36 INFO - 'HOME': '/home/cltbld', 11:32:36 INFO - 'LANG': 'en_US.UTF-8', 11:32:36 INFO - 'LANGUAGE': 'en_US:en', 11:32:36 INFO - 'LOGNAME': 'cltbld', 11:32:36 INFO - 'MAIL': '/var/mail/cltbld', 11:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:36 INFO - 'MOZ_NO_REMOTE': '1', 11:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:36 INFO - 'NO_EM_RESTART': '1', 11:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:36 INFO - 'PWD': '/builds/slave/test', 11:32:36 INFO - 'SHELL': '/bin/bash', 11:32:36 INFO - 'SHLVL': '1', 11:32:36 INFO - 'TERM': 'linux', 11:32:36 INFO - 'TMOUT': '86400', 11:32:36 INFO - 'USER': 'cltbld', 11:32:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:36 INFO - '_': '/tools/buildbot/bin/python'} 11:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:36 INFO - Running setup.py (path:/tmp/pip-RmLCZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:36 INFO - Running setup.py (path:/tmp/pip-bIojYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:36 INFO - Running setup.py (path:/tmp/pip-tIT3rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:37 INFO - Running setup.py (path:/tmp/pip-dGV5bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:37 INFO - Running setup.py (path:/tmp/pip-eLEJkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:37 INFO - Running setup.py (path:/tmp/pip-MkQKuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:37 INFO - Running setup.py (path:/tmp/pip-cmGUPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:37 INFO - Running setup.py (path:/tmp/pip-nUE2x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:37 INFO - Running setup.py (path:/tmp/pip-QGiLv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:37 INFO - Running setup.py (path:/tmp/pip-XWiTrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:37 INFO - Running setup.py (path:/tmp/pip-iaDSC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:37 INFO - Running setup.py (path:/tmp/pip-i1BxUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:37 INFO - Running setup.py (path:/tmp/pip-0j9jjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:37 INFO - Running setup.py (path:/tmp/pip-62DVyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:37 INFO - Running setup.py (path:/tmp/pip-2BpZDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:37 INFO - Running setup.py (path:/tmp/pip-nckQXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:38 INFO - Running setup.py (path:/tmp/pip-cYBDdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:38 INFO - Running setup.py install for manifestparser 11:32:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozcrash 11:32:38 INFO - Running setup.py install for mozdebug 11:32:38 INFO - Running setup.py install for mozdevice 11:32:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozfile 11:32:38 INFO - Running setup.py install for mozhttpd 11:32:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozinfo 11:32:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozInstall 11:32:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:38 INFO - Running setup.py install for mozleak 11:32:38 INFO - Running setup.py install for mozlog 11:32:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Running setup.py install for moznetwork 11:32:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Running setup.py install for mozprocess 11:32:39 INFO - Running setup.py install for mozprofile 11:32:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Running setup.py install for mozrunner 11:32:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Running setup.py install for mozscreenshot 11:32:39 INFO - Running setup.py install for moztest 11:32:39 INFO - Running setup.py install for mozversion 11:32:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:39 INFO - Cleaning up... 11:32:39 INFO - Return code: 0 11:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:39 INFO - Using env: {'DISPLAY': ':0', 11:32:39 INFO - 'HOME': '/home/cltbld', 11:32:39 INFO - 'LANG': 'en_US.UTF-8', 11:32:39 INFO - 'LANGUAGE': 'en_US:en', 11:32:39 INFO - 'LOGNAME': 'cltbld', 11:32:39 INFO - 'MAIL': '/var/mail/cltbld', 11:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:39 INFO - 'MOZ_NO_REMOTE': '1', 11:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:39 INFO - 'NO_EM_RESTART': '1', 11:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:39 INFO - 'PWD': '/builds/slave/test', 11:32:39 INFO - 'SHELL': '/bin/bash', 11:32:39 INFO - 'SHLVL': '1', 11:32:39 INFO - 'TERM': 'linux', 11:32:39 INFO - 'TMOUT': '86400', 11:32:39 INFO - 'USER': 'cltbld', 11:32:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:39 INFO - '_': '/tools/buildbot/bin/python'} 11:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:40 INFO - Running setup.py (path:/tmp/pip-1mpXOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:40 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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:40 INFO - Running setup.py (path:/tmp/pip-3qMoj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:40 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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:40 INFO - Running setup.py (path:/tmp/pip-WuU_fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:40 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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:40 INFO - Running setup.py (path:/tmp/pip-BEZ3ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:40 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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:40 INFO - Running setup.py (path:/tmp/pip-0A2inD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:40 INFO - Running setup.py (path:/tmp/pip-85BtjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:40 INFO - Running setup.py (path:/tmp/pip-AI2Yx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:40 INFO - Running setup.py (path:/tmp/pip-a4yBsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:40 INFO - Running setup.py (path:/tmp/pip-dmM3yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:40 INFO - Running setup.py (path:/tmp/pip-7UbqMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:40 INFO - Running setup.py (path:/tmp/pip-9v9CdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32: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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:40 INFO - Running setup.py (path:/tmp/pip-7EtQUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:41 INFO - Running setup.py (path:/tmp/pip-Nz7jVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:41 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)) 11:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:41 INFO - Running setup.py (path:/tmp/pip-NQZGBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:41 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)) 11:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:41 INFO - Running setup.py (path:/tmp/pip-L5gyrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:41 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)) 11:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:41 INFO - Running setup.py (path:/tmp/pip-tz3DFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:41 INFO - Running setup.py (path:/tmp/pip-RAUMDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:43 INFO - Downloading blessings-1.6.tar.gz 11:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:43 INFO - Installing collected packages: blessings 11:32:43 INFO - Running setup.py install for blessings 11:32:43 INFO - Successfully installed blessings 11:32:43 INFO - Cleaning up... 11:32:43 INFO - Return code: 0 11:32:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:43 INFO - Reading from file tmpfile_stdout 11:32:43 INFO - Current package versions: 11:32:43 INFO - argparse == 1.2.1 11:32:43 INFO - blessings == 1.6 11:32:43 INFO - blobuploader == 1.2.4 11:32:43 INFO - docopt == 0.6.1 11:32:43 INFO - functools32 == 3.2.3-2 11:32:43 INFO - jsonschema == 2.5.1 11:32:43 INFO - manifestparser == 1.1 11:32:43 INFO - mozInstall == 1.12 11:32:43 INFO - mozcrash == 1.0 11:32:43 INFO - mozdebug == 0.1 11:32:43 INFO - mozdevice == 0.49 11:32:43 INFO - mozfile == 1.2 11:32:43 INFO - mozhttpd == 0.7 11:32:43 INFO - mozinfo == 0.9 11:32:43 INFO - mozleak == 0.1 11:32:43 INFO - mozlog == 3.4 11:32:43 INFO - moznetwork == 0.27 11:32:43 INFO - mozprocess == 0.24 11:32:43 INFO - mozprofile == 0.28 11:32:43 INFO - mozrunner == 6.13 11:32:43 INFO - mozscreenshot == 0.1 11:32:43 INFO - mozsystemmonitor == 0.3 11:32:43 INFO - moztest == 0.8 11:32:43 INFO - mozversion == 1.4 11:32:43 INFO - psutil == 3.1.1 11:32:43 INFO - requests == 1.2.3 11:32:43 INFO - wsgiref == 0.1.2 11:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32: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 11:32: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 11:32:43 INFO - Using env: {'DISPLAY': ':0', 11:32:43 INFO - 'HOME': '/home/cltbld', 11:32:43 INFO - 'LANG': 'en_US.UTF-8', 11:32:43 INFO - 'LANGUAGE': 'en_US:en', 11:32:43 INFO - 'LOGNAME': 'cltbld', 11:32:43 INFO - 'MAIL': '/var/mail/cltbld', 11:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:43 INFO - 'MOZ_NO_REMOTE': '1', 11:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:43 INFO - 'NO_EM_RESTART': '1', 11:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:43 INFO - 'PWD': '/builds/slave/test', 11:32:43 INFO - 'SHELL': '/bin/bash', 11:32:43 INFO - 'SHLVL': '1', 11:32:43 INFO - 'TERM': 'linux', 11:32:43 INFO - 'TMOUT': '86400', 11:32:43 INFO - 'USER': 'cltbld', 11:32:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:43 INFO - '_': '/tools/buildbot/bin/python'} 11:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:32:44 INFO - Cleaning up... 11:32:44 INFO - Return code: 0 11:32:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:44 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 0x15761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1686a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', '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 11:32:44 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 11:32:44 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 11:32:44 INFO - Using env: {'DISPLAY': ':0', 11:32:44 INFO - 'HOME': '/home/cltbld', 11:32:44 INFO - 'LANG': 'en_US.UTF-8', 11:32:44 INFO - 'LANGUAGE': 'en_US:en', 11:32:44 INFO - 'LOGNAME': 'cltbld', 11:32:44 INFO - 'MAIL': '/var/mail/cltbld', 11:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:44 INFO - 'MOZ_NO_REMOTE': '1', 11:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:44 INFO - 'NO_EM_RESTART': '1', 11:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:44 INFO - 'PWD': '/builds/slave/test', 11:32:44 INFO - 'SHELL': '/bin/bash', 11:32:44 INFO - 'SHLVL': '1', 11:32:44 INFO - 'TERM': 'linux', 11:32:44 INFO - 'TMOUT': '86400', 11:32:44 INFO - 'USER': 'cltbld', 11:32:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:44 INFO - '_': '/tools/buildbot/bin/python'} 11:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:44 INFO - Cleaning up... 11:32:44 INFO - Return code: 0 11:32:44 INFO - Running post-action listener: _resource_record_post_action 11:32:44 INFO - Running post-action listener: _start_resource_monitoring 11:32:44 INFO - Starting resource monitoring. 11:32:44 INFO - [mozharness: 2017-01-18 19:32:44.354688Z] Finished create-virtualenv step (success) 11:32:44 INFO - [mozharness: 2017-01-18 19:32:44.355272Z] Running install step. 11:32:44 INFO - Running pre-action listener: _resource_record_pre_action 11:32:44 INFO - Running main action method: install 11:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:44 INFO - Reading from file tmpfile_stdout 11:32:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:44 INFO - Reading from file tmpfile_stdout 11:32:44 INFO - Output received: 11:32:44 INFO - Usage: mozinstall [options] installer 11:32:44 INFO - Options: 11:32:44 INFO - -h, --help show this help message and exit 11:32:44 INFO - -d DEST, --destination=DEST 11:32:44 INFO - Directory to install application into. [default: 11:32:44 INFO - "/builds/slave/test"] 11:32:44 INFO - --app=APP Application being installed. [default: firefox] 11:32:44 INFO - mkdir: /builds/slave/test/build/application 11:32: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'] 11:32: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 11:33:02 INFO - Reading from file tmpfile_stdout 11:33:02 INFO - Output received: 11:33:02 INFO - /builds/slave/test/build/application/firefox/firefox 11:33:02 INFO - Running post-action listener: _resource_record_post_action 11:33:02 INFO - [mozharness: 2017-01-18 19:33:02.122631Z] Finished install step (success) 11:33:02 INFO - [mozharness: 2017-01-18 19:33:02.122778Z] Running run-tests step. 11:33:02 INFO - Running pre-action listener: _resource_record_pre_action 11:33:02 INFO - Running main action method: run_tests 11:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:33:02 INFO - Python 2.7.3 11:33:02 INFO - Return code: 0 11:33:02 INFO - grabbing minidump binary from tooltool 11:33: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')]} 11:33: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 0x1971850>, '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 0x18e66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:33: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 11:33: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 11:33: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 11:33:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:02 INFO - Return code: 0 11:33:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:33:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:33:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:33:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:33:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 11:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 11:33:02 INFO - Using env: {'DISPLAY': ':0', 11:33:02 INFO - 'HOME': '/home/cltbld', 11:33:02 INFO - 'LANG': 'en_US.UTF-8', 11:33:02 INFO - 'LANGUAGE': 'en_US:en', 11:33:02 INFO - 'LOGNAME': 'cltbld', 11:33:02 INFO - 'MAIL': '/var/mail/cltbld', 11:33:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:02 INFO - 'MOZ_NO_REMOTE': '1', 11:33:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:02 INFO - 'NO_EM_RESTART': '1', 11:33:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:02 INFO - 'PWD': '/builds/slave/test', 11:33:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:02 INFO - 'SHELL': '/bin/bash', 11:33:02 INFO - 'SHLVL': '1', 11:33:02 INFO - 'TERM': 'linux', 11:33:02 INFO - 'TMOUT': '86400', 11:33:02 INFO - 'USER': 'cltbld', 11:33:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138', 11:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:02 INFO - '_': '/tools/buildbot/bin/python'} 11:33:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 11:33:02 INFO - mozversion application_buildid: 20170118094250 11:33:02 INFO - mozversion application_changeset: 7715d62057e50fdafddeca167ecf2d1dbd79b35b 11:33:02 INFO - mozversion application_display_name: Nightly 11:33:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:02 INFO - mozversion application_name: Firefox 11:33:02 INFO - mozversion application_remotingname: firefox 11:33:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:33:02 INFO - mozversion application_vendor: Mozilla 11:33:02 INFO - mozversion application_version: 53.0a1 11:33:02 INFO - mozversion platform_buildid: 20170118094250 11:33:02 INFO - mozversion platform_changeset: 7715d62057e50fdafddeca167ecf2d1dbd79b35b 11:33:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:33:02 INFO - mozversion platform_version: 53.0a1 11:33:02 INFO - using testdate: 1484767982 11:33:02 INFO - actual date: 1484767982 11:33:02 INFO - starting webserver on 'localhost:41605' 11:33:02 INFO - SUITE-START | Running 2 tests 11:33:02 INFO - TEST-START | dromaeo_css 11:33:02 INFO - operating with platform_type : linux_ 11:33:02 INFO - Initialising browser for dromaeo_css test... 11:33:02 INFO - TEST-INFO | started process 9557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdjuy3s/profile http://localhost:41605/getInfo.html) 11:33:05 INFO - PROCESS | 9557 | __metrics Screen width/height:1600/1200 11:33:05 INFO - PROCESS | 9557 | colorDepth:24 11:33:05 INFO - PROCESS | 9557 | Browser inner width/height: 1024/697 11:33:05 INFO - PROCESS | 9557 | __metrics 11:33:06 INFO - PROCESS | 9557 | 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" 11:33:06 INFO - PROCESS | 9557 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:06 INFO - PROCESS | 9557 | console.error: PushService: 11:33:06 INFO - PROCESS | 9557 | stateChangeProcessEnqueue: Error transitioning state 11:33:06 INFO - PROCESS | 9557 | UnknownError 11:33:07 INFO - TEST-INFO | 9557: exit 0 11:33:07 INFO - Browser initialized. 11:33:07 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:07 INFO - TEST-INFO | started process 9643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdjuy3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:19 INFO - PROCESS | 9643 | RSS: Main: 148185088 11:33:19 INFO - PROCESS | 9643 | 11:36:20 INFO - PROCESS | 9643 | Cycle 1(1): loaded http://localhost:41605/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41605/tests/dromaeo/cssquery-ext.html) 11:36:21 INFO - PROCESS | 9643 | RSS: Main: 234139648 11:36:21 INFO - PROCESS | 9643 | 11:38:09 INFO - PROCESS | 9643 | ************************* 11:38:09 INFO - PROCESS | 9643 | A coding exception was thrown and uncaught in a Task. 11:38:09 INFO - PROCESS | 9643 | 11:38:09 ERROR - PROCESS | 9643 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:38:09 INFO - PROCESS | 9643 | Full stack: 11:38:09 INFO - PROCESS | 9643 | ************************* 11:39:24 INFO - PROCESS | 9643 | Cycle 1(1): loaded http://localhost:41605/tests/dromaeo/cssquery-ext.html (next: http://localhost:41605/tests/dromaeo/cssquery-jquery.html) 11:39:24 INFO - PROCESS | 9643 | RSS: Main: 237539328 11:39:24 INFO - PROCESS | 9643 | 11:42:26 INFO - PROCESS | 9643 | Cycle 1(1): loaded http://localhost:41605/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41605/tests/dromaeo/cssquery-mootools.html) 11:42:27 INFO - PROCESS | 9643 | RSS: Main: 220499968 11:42:27 INFO - PROCESS | 9643 | 11:45:29 INFO - PROCESS | 9643 | Cycle 1(1): loaded http://localhost:41605/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41605/tests/dromaeo/cssquery-prototype.html) 11:45:29 INFO - PROCESS | 9643 | RSS: Main: 224096256 11:45:29 INFO - PROCESS | 9643 | 11:48:32 INFO - PROCESS | 9643 | Cycle 1(1): loaded http://localhost:41605/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41605/tests/dromaeo/cssquery-yui.html) 11:48:33 INFO - PROCESS | 9643 | RSS: Main: 183201792 11:48:33 INFO - PROCESS | 9643 | 11:51:35 INFO - PROCESS | 9643 | Cycle 1(1): loaded http://localhost:41605/tests/dromaeo/cssquery-yui.html (next: http://localhost:41605/tests/dromaeo/cssquery-dojo.html) 11:51:36 INFO - PROCESS | 9643 | RSS: Main: 271273984 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | __start_tp_report 11:51:36 INFO - PROCESS | 9643 | _x_x_mozilla_page_load 11:51:36 INFO - PROCESS | 9643 | _x_x_mozilla_page_load_details 11:51:36 INFO - PROCESS | 9643 | |i|pagename|runs| 11:51:36 INFO - PROCESS | 9643 | |0;dojo.html;3170.3500782339615;3191.4095892259934;3198.4082944655242;3222.1139186723635;3224.580804495415;5267.657602255851;5355.384130824957;5363.115086010808;5439.483249091335;5466.3167104112035;5366.570674346052;5408.323959505062;5415.214793854889;5444.237806707054;5482.91775623365;4873.0741159179815;4885.951140488585;4906.067847109056;4909.680870743408;4971.801127954877;4971.651984361096;5001.649884508086;5025.824096156635;5026.095302845486;5031.924521132186;4778.068276686065;4803.975980120112;4813.133635945528;4858.927116093226;4929.21132618781;4869.975650121763;4892.363992680965;4893.6329775266995;4935.70385776851;4945.604351651859;4831.275308703723;4843.29772183035;4862.756862156878;4888.022395520875;4914.827981020683;5242.266082748418;5279.155335146396;5323.068463018956;5391.433899440581;5474.534664553517;5733.684647344395;5747.712614369307;5749.1663708762;5796.478316951495;5797.246357973437;5786.826395208151;5787.739551720183;5792.073268277056;5800.419958004208;5808.535317174616;5312.601554883399;5352.6253162279045;5371.435999220103;5377.650452720561;5399.78400863965;5892;5938.524918006549;5952.613080149777;5986.970065149646;6033.18551995475;5670.950874088225;5712.057510510719;5714.342850572154;5725.940700970334;5727.885442291131;5626.831195064155;5669.376368599451;5764.106563482667;5817.621854579439;5825.563082768809;5683.857903552362;5740.253767010262;5743.195952566561;5807.303123625192;5829.650220986754;5778.855528611734;5785.450382213683;5798.072308430716;5837.182794408786;5837.387074357216;4494.07871386365;4495.707778994421;4500.212462818994;4510.300903359985;4538.795754191069;3950.229705207457;3966.829785213369;3974.5429275633674;4009.4587230723478;4075.857344992911;5398;5438.564914806806;5441.619086663895;5472.151816468454;5489.58828087887;5711.400302968212;5718.885622287531;5734.340550836707;5738.483536481736;5773.971130144322;5270;5325.707086110301;5374.355077390738;5440.319960004999;5490.917636235459;4942.20924652054;4947.950520494749;4955.653104282737;4972.428170760337;4982.60139188864;6076.939230607814;6094.078451592408;6096.587161059637;6126.08108783686;6129.448349648553;5822.417758224144;5824.388439213822;5825.621334613236;5829.59192856496;5840.795572154954;5725.5992080555625;5839.7372118255635;6008.158857760004;6046.365131661289;6057.636541807329;5642.379338272869;5751.4536119068625;5754.769809207585;5760.510356619567;5796.101604251347;5869.383714709894;5872.119182122716;5875.41245875409;5877.500412464989;5883.794067207627;5566.582506312124;5672.376038635664;5724.885502290014;5735.11105778605;5740.052891272893;5583.106702927512;5597.916031259453;5605.523530499953;5621.269234999424;5735.827925162252;5394.78420863161;5617.691026993554;5622.550195984393;5637.633553818989;5672.262605861211;5479.753411096431;5521.585881059017;5545.500904918576;5589.916151257816;5668.319801623831;5443.836684899459;5468.097763868917;5515.558755299647;5522.3649280333275;5524.06090964545 11:51:36 INFO - PROCESS | 9643 | |1;ext.html;533.2667582074645;557.0530098831986;581.9185314056033;590.0588561244816;610.8992016317308;34827.82586087069;38554;38561.614383856155;38603.99999999996;38854;47297;48563.51436485634;48790.26814597775;52575;53173;8866.733997980054;9040.141186587263;9043.95478022609;9047.457152570834;9053.230475409599;8554.05905350411;8773.824523509526;9109.817803643924;9171.128742769426;9186.173244408003;10881.510332035037;11123.833142502868;11129.666110016671;11468.655940321803;11477.483513241925;11132.387718675469;11204.495797689124;11213.327200368005;11236.66290011301;11244.26912250701;10903.509342079546;10934.617288394868;10965.342079475176;10985.176111791568;10986;45440;45643.543564564265;45715;45974.310385344244;46125.76937115326;4261.659067274611;4281.250781113293;4363.105563359503;4465.888352791174;4480.19356515827;33830.66169338324;33845.49231761526;33931.491027634605;34147.6585234147;35718;4284.100338928829;4293.699441039129;4329.631981281595;4357.150355680644;4426.579474949875;311028;313370;314689;315212;316033;63246;63374;63593;63599.36400636027;63683.363166367744;66497.33502665008;66928.33071669318;66992;67040;67069.66465167643;16137.112458814878;16452.83547164513;16492.25784839685;16502.917485412738;16515.504534863972;12539.059570532247;12552.937235313764;12556.686082847818;12558.74882502345;12561.560345387868;16334.428295009619;16758.162091895356;17757.378491752985;17763.26971336008;18456.26174953014;6635.834104147435;6675.46596272297;6741.1236539249585;6962.2341542430295;6970.817509494263;930.7135470527335;953.804470083645;975.4196253229317;990.9207263418909;1007.6070332570304;32086;33951.83024084913;34169.487457688156;34262.25255427873;34355.48466773;1070.3577853287966;1131.8415421840948;1132.1791701016862;1173.501261963662;1179.6637958181877;16746.56439757113;17573.28804764908;17792.288308467774;17876.731849022275;17914.46256612304;448966;465398;472461;473021;738023;51443.7427812866;52426.21360679593;56012;58168.709156453944;58951.41048589545;1467.4203689542571;1473.2118316700514;1488.732028234928;1506.314626844783;1522.543237028887;29621.851890740407;31530.054098377084;31882.84058579785;31959.206119081395;32254.35491290114;49971.500284996684;50475;50501;50521;50550.747246263534;396972;399895;400278;401853;402211;26220.08229711951;26549.734502655498;26764.59853102166;26920.596191057542;27027.324316892234;39505.604943950195;40882;42549.5745042558;43489.34765978576;46068;37242.62757372392;37268.254634907695;37543.2491350166;37688;39531.2093758129;37472.625273748;37942.62057379391;38062.42906356351;38212.23575528529;38294.61705383022;37142;37331.6266837339;37453.62546374501;38104.61895381011;38202.426963596125;31302.217444564067;32843;33999;34306.828465857514;34357;25234;25451;25565.616515752652;25690.871545642152;25863.870680646476 11:51:36 INFO - PROCESS | 9643 | |2;jquery.html;400.18162856957537;413.95032596088475;424.7812376626037;426.0839195729182;435.90845922356306;19058.618827623457;19926.003699815006;20878.791212087875;21027.894860525696;21198.89400552995;21438;21471.892640536815;21810.781892181072;21868.562628747455;22186.88906555465;5715.628484148538;6000.519958403339;6003.339632640406;6004.819855404345;6008.969955150218;5555.250041244441;5788.768449262025;5821.214136091637;5885.117232415129;5999.85000374992;5850.73671684773;5852.76588936442;5856.326522449909;5856.619319744224;5863.58954873159;5648.350439699426;5771.076627739562;5782.537397008229;5806.44838740319;5843.678597677126;5621.269234999424;5640.943590564124;5646.745896434671;5673.00722373583;5694.373618901917;25388;25441.109561165456;25564.48871022569;25608.23175304744;25800.354991125183;2650.734926507353;2698.3523954251036;2723.2919440945498;2740.1642499037785;2754.1462146734575;9899.356541824758;10090.192784577217;10349.689509314732;10482.213833962407;10495.580176792919;1799.199356286453;1825.3246298869503;1854.3973208707089;1866.4027511196423;1894.6589613869498;86309.70535442037;87179;88236.55881720614;90199.54900225523;95887.52056239675;11892.718621296326;11901;11948.701282468008;12242.143049986415;12412.317322547166;16839.41062062822;16874.662506750043;16876.15619219034;16891.23989420479;16907.746383804253;8100.756977290691;8363.749087527383;8387.203215694499;8546.78633034179;8640.481571105754;7874.212578742195;7924.366050715929;8105.878411823827;8161.877571836427;8167.918320816716;5029.856339787632;5146.588272938156;5159.406668233126;5165.54404272357;5233.842984710464;2073.5438203595186;2113.1019316790303;2127.319257837477;2155.913763449476;2158.568286342738;999.2570394267636;1003.2425518733455;1003.6838395905266;1014.2190513304862;1027.6300531808542;20267.594648106955;20795.792042079687;21165.470863228235;21251.218475842812;21452;971.5288085278635;993.6124911284605;1032.1226957086417;1044.7805960748176;1064.377339256528;10521.158307335394;10905.879609646783;10994.560217591366;11040.927489880534;11235.382053987109;623366;627151;641315;658007;661629;101635;108395;108486.45756771324;110927;111098.44450777856;1108.0969010256777;1137.351709525579;1160.4197901049474;1161.2916121166081;1167.0371943146938;16552.255148518103;17131;17485.388011419538;17563.209655565784;17980;41571.37642935419;42916.78541607272;43578.78210608927;43985.34021989737;44709.55290447184;63849.680751595944;64967.67516162389;65165.34834651782;65631.67184164049;66925.3307466919;8657.480551166951;8914.55427228623;9004.729858104005;9055.637774488947;9506.239500839778;12051;13270.1374410663;13438.328083595585;14059.929700351433;14085.647858803612;11757.823632645346;11967.880321196677;12128.818067729168;12221.083418743452;12233.632991010283;11821.0543156549;11865.11011674145;12003.039756819608;12250.326232057323;12298.323592202514;11745.530178792753;11830.526778928746;12152.696182595506;12227.510899563918;12345.629631111082;8833;8952.910470895207;8980.101989800967;9321.394109382869;9366.578503967474;10728;11606.76786464249;11898.22661526998;12056.698582535506;12183.086268529718 11:51:36 INFO - PROCESS | 9643 | |3;mootools.html;1319.8548159702425;1442.4302400551783;1468.2585294426317;1473.683158121004;1478.1131321207276;7307.634618269085;7985.9201407985975;8283.33733301336;8308.875366869503;8540;8346.791330216747;8383.16168383163;8435.40952133351;8447.662093516268;8453.957730211356;2041.7345745053121;2107.051826677993;2268.308166009362;2327.895244713992;2334.673145759595;2284.257616274709;2355.305184970438;2357.1749887539395;2373.786359227669;2379.654950032253;2221.1004543160047;2245.236619549353;2248.8875556222206;2252.2454977582447;2256.7066281383395;2250.493638931244;2264.501809601885;2272.5909336319455;2273.783990520898;2283.2008796921027;2223.399682085828;2268.4895898422888;2296.666983287431;2306.5848147333472;2306.988465057681;8409.032961209477;8424.915750842474;8471.195236452528;8474.915250847474;8476.830463390697;5183.714895680736;5328.760205790749;5329.360476742777;5335.3864305604575;5338.092524270884;3248.171716212351;3457.3258214648154;3458.4639380896;3462.4460086386057;3506.0358401439807;1353.1137105196015;1441.149721664223;2092.884891330976;2118.925837595692;2122.554263604645;11051.281666691639;11103.333799971946;11190.888091119066;11191.440427978569;11202.38386888729;4302.7633480158265;4467.508574056851;4509.684322097487;4543.931841022388;4544.204764166324;9220.492872892055;9224.40041397307;9262.72211833646;9263.95368023169;9264.583093760797;5217.843464696065;5241.947580524146;5249.238860365225;5251.684898906078;5254.448282930313;4758.16732071893;4772.76136193189;4877;4883.389576302962;4940.505949405031;3722.5532936047307;3732.1602639405914;3763.6800871925643;3811.142492939122;3819.1597848473293;1159.1885680024018;1170.7014711248578;1172.0623501199007;1174.9177557570888;1185.1052455396293;1006.104566935428;1009.5457044329934;1016.9288149829441;1022.9386236825815;1032.7831155457288;5711.257536520309;5801.622894511843;5873.941260587425;5909.940900590939;6154.553679885224;990.3315262197988;1023.1712313026472;1037.9464843184173;1039.2257767962917;1053.378506681062;3758.4550240215563;3885.4948856648457;3899.8495443843567;3958.3072962231495;3959.821808018646;10041.799164016826;10409.635662751918;10487.37075775456;10511.211659125443;10525.421101839473;10144.340617859963;10209.54057067419;10211.540480678388;10332.586696532206;10339.0694837465;7229.710811567584;7478.962605187048;7497.10034795828;7879.960600196962;8018;5770.278715160605;5851.093080572518;5909.527237820878;5923.49650279731;5989.7304621293015;8724.912750872663;8913.643454261757;8918.420302680564;9012.053734357798;9094.727158185266;8343.45767525109;8982.371234013557;9096.590653420744;9160.404573702954;9163.541822908695;6786.778379891667;7047.541909775849;7184.712611495482;7276.4178865689555;7380.409567234501;7772.417068719982;7825.060992680915;7845.450818442882;7901.209879012053;7911.406644501571;7114.181869084914;7132.393746531396;7142.857142857218;7147.8570428592175;7217.386522145676;7005;7032.542884712478;7119.466040046914;7214.531055481377;7242.311980361857;6477.967610161919;6525.64108974011;6590.90113648286;6592.868142637216;6599.5050371223315;4663.580277775017;4796.784144713426;4802.73584952831;4817.084753896748;4906.288588154626;5064.924026139684;5085.262636917552;5180.507851754077;5211.342215470062;5215.869603259949 11:51:36 INFO - PROCESS | 9643 | |4;prototype.html;383.69879644479073;387.3685891996046;396.11270753512133;396.2787726338064;397.128303374094;5058.4435712071645;5185.429602743695;5269.394019687732;5338.412774594796;5381.654586353407;5093.439721630618;5174.870628234296;5188.04021256067;5217.399999000116;5249.26510288559;4127.484064491939;4165.27107756143;4169.4162817205615;4172.7287726297845;4200.894977625569;3936.8779897729155;3995.3008223560905;4177;4187.455630768011;4237.957620423803;4169.56219596941;4176.060386413048;4208.957910420887;4209.936850947238;4211.4946206455115;4181;4181.874543763692;4195.769232692201;4196.202721482939;4210.97894510527;3821.99345343694;3838.213166300902;3846.8653597123966;3850.3454412749898;3859.186182494251;5001.574866136347;5073.746312684351;5076.680063183562;5097.694138351673;5147.510986456281;4829.855104346875;4839.128956787777;4841.973766396002;4859.979404325096;4879.536444037811;5324.201369794523;5465.059903734157;5515.889682206333;5527.170924361378;5557.777688892439;4150.481189851269;4150.8547200848125;4173.561776013506;4196.538380778112;4222.324428091521;5686.658800471985;5692.77228910843;5693.231413759131;5703.486686198262;5719.599628025998;4319;4350.195213885441;4353.9129217415475;4356.172327257811;4364.62900653448;4259.829606815754;4338.934915976263;4368.716033457815;4387.319965405367;4391.890202744893;4823.311840855672;4832.44426890905;4838.056578967067;4854.732989685601;4875.658703890694;5546.947629377156;5574.58190635704;5594.412586678422;5608.513743857881;5637.43625637433;1325.8740419660116;1330.5077121464926;1360.768669326217;1361.3669643615767;1394.0520446096752;941.152962333905;961.7451375385529;974.6637410093506;975.2100798353357;979.5200351827554;4994.602590756457;5023.924641130386;5025.874353141201;5032.597392208614;5049.318342023853;5442.374126975448;5444.91832622511;5446.346438427414;5460.262864513319;5470.990954974748;4889.437714662859;5022.970291090318;5038.64729468941;5049.166887463601;5063.696178229318;2871.4113606710994;2893.2477555835635;2897.638110088255;2907.912762617125;2910.185148158519;5672.858178545569;5686.772529098873;5691.743871525791;5712.057510510802;5741.85645358861;5412.783488660488;5544.944550554524;5579.74891129892;5596.809818403471;5618.85952851182;5602.6918519481005;5618.803341883015;5637.844241930313;5659.490645841894;5671.347795003545;5246.737663116905;5396.83809485716;5426.593005524523;5430.972845135749;5462.453754624665;5316.494932981361;5333.466653334635;5344.198370244494;5388.191771234347;5414.35027796667;5643.984082864959;5662.886742265049;5665.960254308528;5672.716364181857;5696.316442026983;3936.7834769087976;3979.960200398075;4000.219957108336;4030.6372426481757;4034.3545032794614;5361.731913404392;5407.188921661782;5427.24018637399;5461.754221060141;5486.670799752028;5310.707911064928;5384.5423139032055;5480.451590010664;5487.972560137174;5503.174523821459;5478.80824171168;5479.945200548103;5486.61593688438;5515.641483303572;5521.365043020104;5233.816816411408;5374.050073196276;5427.430119837518;5432.429594892479;5450.727463626724;5455.9454405455435;5459.208414779914;5462.180672899097;5468.726563671721;5525.171224316224;5331.1470164775;5332.120200166929;5346.358436987586;5349.7860085597695;5362.597805164706 11:51:36 INFO - PROCESS | 9643 | |5;yui.html;780.2275747010461;795.8686816675249;818.5620692929281;892.3842548641437;909.8043920557079;16131.193440327981;16841.242144103515;16851;16989.660206795856;17026.31894724211;13987.720245595108;14023.298835058258;14031.438742450315;14098.71802563948;14141.787873181911;643.4691379611816;657.7829316325601;734.320753303195;748.2367984655648;762.0284137724418;754.9849003019937;756.7994481462417;759.3469616130124;760.0727112922253;761.4251240313555;796.9561674107922;801.6072124658933;802.0535767794;802.0535767794;802.9397795165386;684.0491716514025;688.3667026335758;777.9922200777976;791.7664289034749;804.7183485779989;579.6666916522973;580.5181699189662;580.7560824453698;582.2663444060514;583.107844997155;15990.840091599051;16277.91861040699;16319.18404079803;16333.509994700178;17013;14521.78217326741;14878.925605372013;15144;15240.466583669519;15446.227688615525;13703.520376786764;13729.725405491934;13776.10455320401;13790.517331893336;13800.309984500735;4456.930336719196;4459.509453960094;4492.124035813018;4492.348609451644;4541.795619197144;75249.62375188143;76175.61912190459;76689;77874;78154.3568796653;11897.107716921093;11982.221155624857;11984.28094314344;12064.457099430547;12232.81650775239;23265.767342326697;23426.88286558556;23575.646365304536;23593.528129437316;23609.88195059048;8205.79485512867;8263;8344.958275208584;8392.580370981426;8469.280111190494;4506.481754598198;4527.977360113178;4605.171069207508;4642.489326174118;4674.906501869944;3370.9494357584654;3417.5898892133105;3429.091290807938;3466.8093254871224;3469.3061387722555;577.532198918877;580.4340767751409;581.877805660816;594.1770647653032;596.2725474920677;736.1828370508731;756.3835474088601;757.4243574883128;760.4904713841739;765.2577000309691;10081.294309398272;10510.737231569272;10672.466376681135;11118.722031949104;11200.943995280135;702.4275215699291;727.0875051809944;735.1949615171379;747.7196051480695;773.8607050730923;4793.664443488922;4936.160852655057;5032.521910418504;5128.6666366686795;5129.3075434816565;78179.60910195412;78415;80155;81221.18778812254;82486.58756706178;70728.64635676789;70992.64503677552;71649.28350716426;72564.27435725575;72734.27265727276;61081.389186108456;61144.38855611476;61145;61593.38406615966;61645.999999999105;9745.902540974499;9994.900050999688;10032.548535316075;10051.748706282402;10096.596136154472;41726.48923193854;42068.36897446602;42386.5761342395;44105;44338.11323773442;45472.54527454815;46979.765101175646;47404.762976184895;51672;51873.740631296605;13927.860721392657;14026.368813403216;14109;14179.716405671623;14317.713645726819;14740.11559306445;15559.922200388926;15640.061596304258;15862.619095985166;16178.527190634322;10658.946705266424;13032.934835325763;14330;14434.783478247624;14477.420903164177;14620.707585848437;14649.414023439369;14943.850561494246;15468.92265538665;15724;14423.78364324515;14579.271036448346;14830;15340.539783806504;15643.452479163174;12190.71997440256;12341.197822141532;12370.195937264049;12796.424160912968;12963.416646250753;9315.72052838416;9423.623055077995;9432.62269509212;9450.243980481682;9509.144177024102 11:51:36 INFO - PROCESS | 9643 | __end_tp_report 11:51:36 INFO - PROCESS | 9643 | __start_cc_report 11:51:36 INFO - PROCESS | 9643 | _x_x_mozilla_cycle_collect,834 11:51:36 INFO - PROCESS | 9643 | __end_cc_report 11:51:36 INFO - PROCESS | 9643 | __startTimestamp1484769096132__endTimestamp 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | ------- Summary: start ------- 11:51:36 INFO - PROCESS | 9643 | Number of tests: 6 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | [#0] dojo.html Cycles:165 Average:5371.35 Median:5524.06 stddev:600.78 (10.9%) stddev-sans-first:577.28 11:51:36 INFO - PROCESS | 9643 | Values: 3170.4 3191.4 3198.4 3222.1 3224.6 5267.7 5355.4 5363.1 5439.5 5466.3 5366.6 5408.3 5415.2 5444.2 5482.9 4873.1 4886.0 4906.1 4909.7 4971.8 4971.7 5001.6 5025.8 5026.1 5031.9 4778.1 4804.0 4813.1 4858.9 4929.2 4870.0 4892.4 4893.6 4935.7 4945.6 4831.3 4843.3 4862.8 4888.0 4914.8 5242.3 5279.2 5323.1 5391.4 5474.5 5733.7 5747.7 5749.2 5796.5 5797.2 5786.8 5787.7 5792.1 5800.4 5808.5 5312.6 5352.6 5371.4 5377.7 5399.8 5892.0 5938.5 5952.6 5987.0 6033.2 5671.0 5712.1 5714.3 5725.9 5727.9 5626.8 5669.4 5764.1 5817.6 5825.6 5683.9 5740.3 5743.2 5807.3 5829.7 5778.9 5785.5 5798.1 5837.2 5837.4 4494.1 4495.7 4500.2 4510.3 4538.8 3950.2 3966.8 3974.5 4009.5 4075.9 5398.0 5438.6 5441.6 5472.2 5489.6 5711.4 5718.9 5734.3 5738.5 5774.0 5270.0 5325.7 5374.4 5440.3 5490.9 4942.2 4948.0 4955.7 4972.4 4982.6 6076.9 6094.1 6096.6 6126.1 6129.4 5822.4 5824.4 5825.6 5829.6 5840.8 5725.6 5839.7 6008.2 6046.4 6057.6 5642.4 5751.5 5754.8 5760.5 5796.1 5869.4 5872.1 5875.4 5877.5 5883.8 5566.6 5672.4 5724.9 5735.1 5740.1 5583.1 5597.9 5605.5 5621.3 5735.8 5394.8 5617.7 5622.6 5637.6 5672.3 5479.8 5521.6 5545.5 5589.9 5668.3 5443.8 5468.1 5515.6 5522.4 5524.1 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | [#1] ext.html Cycles:180 Average:57776.47 Median:38002.52 stddev:112656.87 (296.4%) stddev-sans-first:112890.92 11:51:36 INFO - PROCESS | 9643 | Values: 533.3 557.1 581.9 590.1 610.9 34827.8 38554.0 38561.6 38604.0 38854.0 47297.0 48563.5 48790.3 52575.0 53173.0 8866.7 9040.1 9044.0 9047.5 9053.2 8554.1 8773.8 9109.8 9171.1 9186.2 10881.5 11123.8 11129.7 11468.7 11477.5 11132.4 11204.5 11213.3 11236.7 11244.3 10903.5 10934.6 10965.3 10985.2 10986.0 45440.0 45643.5 45715.0 45974.3 46125.8 4261.7 4281.3 4363.1 4465.9 4480.2 33830.7 33845.5 33931.5 34147.7 35718.0 4284.1 4293.7 4329.6 4357.2 4426.6 311028.0 313370.0 314689.0 315212.0 316033.0 63246.0 63374.0 63593.0 63599.4 63683.4 66497.3 66928.3 66992.0 67040.0 67069.7 16137.1 16452.8 16492.3 16502.9 16515.5 12539.1 12552.9 12556.7 12558.7 12561.6 16334.4 16758.2 17757.4 17763.3 18456.3 6635.8 6675.5 6741.1 6962.2 6970.8 930.7 953.8 975.4 990.9 1007.6 32086.0 33951.8 34169.5 34262.3 34355.5 1070.4 1131.8 1132.2 1173.5 1179.7 16746.6 17573.3 17792.3 17876.7 17914.5 448966.0 465398.0 472461.0 473021.0 738023.0 51443.7 52426.2 56012.0 58168.7 58951.4 1467.4 1473.2 1488.7 1506.3 1522.5 29621.9 31530.1 31882.8 31959.2 32254.4 49971.5 50475.0 50501.0 50521.0 50550.7 396972.0 399895.0 400278.0 401853.0 402211.0 26220.1 26549.7 26764.6 26920.6 27027.3 39505.6 40882.0 42549.6 43489.3 46068.0 37242.6 37268.3 37543.2 37688.0 39531.2 37472.6 37942.6 38062.4 38212.2 38294.6 37142.0 37331.6 37453.6 38104.6 38202.4 31302.2 32843.0 33999.0 34306.8 34357.0 25234.0 25451.0 25565.6 25690.9 25863.9 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | [#2] jquery.html Cycles:180 Average:34587.12 Median:23787.44 stddev:105677.48 (444.3%) stddev-sans-first:105942.76 11:51:36 INFO - PROCESS | 9643 | Values: 400.2 414.0 424.8 426.1 435.9 19058.6 19926.0 20878.8 21027.9 21198.9 21438.0 21471.9 21810.8 21868.6 22186.9 5715.6 6000.5 6003.3 6004.8 6009.0 5555.3 5788.8 5821.2 5885.1 5999.9 5850.7 5852.8 5856.3 5856.6 5863.6 5648.4 5771.1 5782.5 5806.4 5843.7 5621.3 5640.9 5646.7 5673.0 5694.4 25388.0 25441.1 25564.5 25608.2 25800.4 2650.7 2698.4 2723.3 2740.2 2754.1 9899.4 10090.2 10349.7 10482.2 10495.6 1799.2 1825.3 1854.4 1866.4 1894.7 86309.7 87179.0 88236.6 90199.5 95887.5 11892.7 11901.0 11948.7 12242.1 12412.3 16839.4 16874.7 16876.2 16891.2 16907.7 8100.8 8363.7 8387.2 8546.8 8640.5 7874.2 7924.4 8105.9 8161.9 8167.9 5029.9 5146.6 5159.4 5165.5 5233.8 2073.5 2113.1 2127.3 2155.9 2158.6 999.3 1003.2 1003.7 1014.2 1027.6 20267.6 20795.8 21165.5 21251.2 21452.0 971.5 993.6 1032.1 1044.8 1064.4 10521.2 10905.9 10994.6 11040.9 11235.4 623366.0 627151.0 641315.0 658007.0 661629.0 101635.0 108395.0 108486.5 110927.0 111098.4 1108.1 1137.4 1160.4 1161.3 1167.0 16552.3 17131.0 17485.4 17563.2 17980.0 41571.4 42916.8 43578.8 43985.3 44709.6 63849.7 64967.7 65165.3 65631.7 66925.3 8657.5 8914.6 9004.7 9055.6 9506.2 12051.0 13270.1 13438.3 14059.9 14085.6 11757.8 11967.9 12128.8 12221.1 12233.6 11821.1 11865.1 12003.0 12250.3 12298.3 11745.5 11830.5 12152.7 12227.5 12345.6 8833.0 8952.9 8980.1 9321.4 9366.6 10728.0 11606.8 11898.2 12056.7 12183.1 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | [#3] mootools.html Cycles:180 Average:5495.32 Median:4880.19 stddev:2957.73 (60.6%) stddev-sans-first:2949.38 11:51:36 INFO - PROCESS | 9643 | Values: 1319.9 1442.4 1468.3 1473.7 1478.1 7307.6 7985.9 8283.3 8308.9 8540.0 8346.8 8383.2 8435.4 8447.7 8454.0 2041.7 2107.1 2268.3 2327.9 2334.7 2284.3 2355.3 2357.2 2373.8 2379.7 2221.1 2245.2 2248.9 2252.2 2256.7 2250.5 2264.5 2272.6 2273.8 2283.2 2223.4 2268.5 2296.7 2306.6 2307.0 8409.0 8424.9 8471.2 8474.9 8476.8 5183.7 5328.8 5329.4 5335.4 5338.1 3248.2 3457.3 3458.5 3462.4 3506.0 1353.1 1441.1 2092.9 2118.9 2122.6 11051.3 11103.3 11190.9 11191.4 11202.4 4302.8 4467.5 4509.7 4543.9 4544.2 9220.5 9224.4 9262.7 9264.0 9264.6 5217.8 5241.9 5249.2 5251.7 5254.4 4758.2 4772.8 4877.0 4883.4 4940.5 3722.6 3732.2 3763.7 3811.1 3819.2 1159.2 1170.7 1172.1 1174.9 1185.1 1006.1 1009.5 1016.9 1022.9 1032.8 5711.3 5801.6 5873.9 5909.9 6154.6 990.3 1023.2 1037.9 1039.2 1053.4 3758.5 3885.5 3899.8 3958.3 3959.8 10041.8 10409.6 10487.4 10511.2 10525.4 10144.3 10209.5 10211.5 10332.6 10339.1 7229.7 7479.0 7497.1 7880.0 8018.0 5770.3 5851.1 5909.5 5923.5 5989.7 8724.9 8913.6 8918.4 9012.1 9094.7 8343.5 8982.4 9096.6 9160.4 9163.5 6786.8 7047.5 7184.7 7276.4 7380.4 7772.4 7825.1 7845.5 7901.2 7911.4 7114.2 7132.4 7142.9 7147.9 7217.4 7005.0 7032.5 7119.5 7214.5 7242.3 6478.0 6525.6 6590.9 6592.9 6599.5 4663.6 4796.8 4802.7 4817.1 4906.3 5064.9 5085.3 5180.5 5211.3 5215.9 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | [#4] prototype.html Cycles:180 Average:4620.16 Median:5225.61 stddev:1307.74 (25.0%) stddev-sans-first:1272.16 11:51:36 INFO - PROCESS | 9643 | Values: 383.7 387.4 396.1 396.3 397.1 5058.4 5185.4 5269.4 5338.4 5381.7 5093.4 5174.9 5188.0 5217.4 5249.3 4127.5 4165.3 4169.4 4172.7 4200.9 3936.9 3995.3 4177.0 4187.5 4238.0 4169.6 4176.1 4209.0 4209.9 4211.5 4181.0 4181.9 4195.8 4196.2 4211.0 3822.0 3838.2 3846.9 3850.3 3859.2 5001.6 5073.7 5076.7 5097.7 5147.5 4829.9 4839.1 4842.0 4860.0 4879.5 5324.2 5465.1 5515.9 5527.2 5557.8 4150.5 4150.9 4173.6 4196.5 4222.3 5686.7 5692.8 5693.2 5703.5 5719.6 4319.0 4350.2 4353.9 4356.2 4364.6 4259.8 4338.9 4368.7 4387.3 4391.9 4823.3 4832.4 4838.1 4854.7 4875.7 5546.9 5574.6 5594.4 5608.5 5637.4 1325.9 1330.5 1360.8 1361.4 1394.1 941.2 961.7 974.7 975.2 979.5 4994.6 5023.9 5025.9 5032.6 5049.3 5442.4 5444.9 5446.3 5460.3 5471.0 4889.4 5023.0 5038.6 5049.2 5063.7 2871.4 2893.2 2897.6 2907.9 2910.2 5672.9 5686.8 5691.7 5712.1 5741.9 5412.8 5544.9 5579.7 5596.8 5618.9 5602.7 5618.8 5637.8 5659.5 5671.3 5246.7 5396.8 5426.6 5431.0 5462.5 5316.5 5333.5 5344.2 5388.2 5414.4 5644.0 5662.9 5666.0 5672.7 5696.3 3936.8 3980.0 4000.2 4030.6 4034.4 5361.7 5407.2 5427.2 5461.8 5486.7 5310.7 5384.5 5480.5 5488.0 5503.2 5478.8 5479.9 5486.6 5515.6 5521.4 5233.8 5374.1 5427.4 5432.4 5450.7 5455.9 5459.2 5462.2 5468.7 5525.2 5331.1 5332.1 5346.4 5349.8 5362.6 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - PROCESS | 9643 | [#5] yui.html Cycles:180 Average:17813.68 Median:25038.86 stddev:22155.77 (88.5%) stddev-sans-first:22181.00 11:51:36 INFO - PROCESS | 9643 | Values: 780.2 795.9 818.6 892.4 909.8 16131.2 16841.2 16851.0 16989.7 17026.3 13987.7 14023.3 14031.4 14098.7 14141.8 643.5 657.8 734.3 748.2 762.0 755.0 756.8 759.3 760.1 761.4 797.0 801.6 802.1 802.1 802.9 684.0 688.4 778.0 791.8 804.7 579.7 580.5 580.8 582.3 583.1 15990.8 16277.9 16319.2 16333.5 17013.0 14521.8 14878.9 15144.0 15240.5 15446.2 13703.5 13729.7 13776.1 13790.5 13800.3 4456.9 4459.5 4492.1 4492.3 4541.8 75249.6 76175.6 76689.0 77874.0 78154.4 11897.1 11982.2 11984.3 12064.5 12232.8 23265.8 23426.9 23575.6 23593.5 23609.9 8205.8 8263.0 8345.0 8392.6 8469.3 4506.5 4528.0 4605.2 4642.5 4674.9 3370.9 3417.6 3429.1 3466.8 3469.3 577.5 580.4 581.9 594.2 596.3 736.2 756.4 757.4 760.5 765.3 10081.3 10510.7 10672.5 11118.7 11200.9 702.4 727.1 735.2 747.7 773.9 4793.7 4936.2 5032.5 5128.7 5129.3 78179.6 78415.0 80155.0 81221.2 82486.6 70728.6 70992.6 71649.3 72564.3 72734.3 61081.4 61144.4 61145.0 61593.4 61646.0 9745.9 9994.9 10032.5 10051.7 10096.6 41726.5 42068.4 42386.6 44105.0 44338.1 45472.5 46979.8 47404.8 51672.0 51873.7 13927.9 14026.4 14109.0 14179.7 14317.7 14740.1 15559.9 15640.1 15862.6 16178.5 10658.9 13032.9 14330.0 14434.8 14477.4 14620.7 14649.4 14943.9 15468.9 15724.0 14423.8 14579.3 14830.0 15340.5 15643.5 12190.7 12341.2 12370.2 12796.4 12963.4 9315.7 9423.6 9432.6 9450.2 9509.1 11:51:36 INFO - PROCESS | 9643 | -------- Summary: end -------- 11:51:36 INFO - PROCESS | 9643 | 11:51:36 INFO - TEST-INFO | 9643: exit 0 11:51:36 INFO - TEST-OK | dromaeo_css | took 1114491ms 11:51:36 INFO - TEST-START | kraken 11:51:36 INFO - operating with platform_type : linux_ 11:51:36 INFO - Initialising browser for kraken test... 11:51:36 INFO - TEST-INFO | started process 9945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9JTHUb/profile http://localhost:41605/getInfo.html) 11:51:40 INFO - PROCESS | 9945 | __metrics Screen width/height:1600/1200 11:51:40 INFO - PROCESS | 9945 | colorDepth:24 11:51:40 INFO - PROCESS | 9945 | Browser inner width/height: 1024/697 11:51:40 INFO - PROCESS | 9945 | __metrics 11:51:40 INFO - PROCESS | 9945 | 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" 11:51:40 INFO - PROCESS | 9945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:41 INFO - PROCESS | 9945 | console.error: PushService: 11:51:41 INFO - PROCESS | 9945 | stateChangeProcessEnqueue: Error transitioning state 11:51:41 INFO - PROCESS | 9945 | UnknownError 11:51:41 INFO - TEST-INFO | 9945: exit 0 11:51:41 INFO - Browser initialized. 11:51:41 INFO - Running cycle 1/1 for kraken test... 11:51:41 INFO - TEST-INFO | started process 10028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9JTHUb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:53 INFO - PROCESS | 10028 | RSS: Main: 147615744 11:51:53 INFO - PROCESS | 10028 | 11:51:56 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41605/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:57 INFO - PROCESS | 10028 | RSS: Main: 203354112 11:51:57 INFO - PROCESS | 10028 | 11:51:59 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41605/tests/kraken/driver.html?testName=audio-dft) 11:52:00 INFO - PROCESS | 10028 | RSS: Main: 181895168 11:52:00 INFO - PROCESS | 10028 | 11:52:03 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41605/tests/kraken/driver.html?testName=audio-fft) 11:52:03 INFO - PROCESS | 10028 | RSS: Main: 263897088 11:52:03 INFO - PROCESS | 10028 | 11:52:06 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41605/tests/kraken/driver.html?testName=audio-oscillator) 11:52:06 INFO - PROCESS | 10028 | RSS: Main: 175370240 11:52:06 INFO - PROCESS | 10028 | 11:52:08 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41605/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:09 INFO - PROCESS | 10028 | RSS: Main: 178581504 11:52:09 INFO - PROCESS | 10028 | 11:52:12 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41605/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:12 INFO - PROCESS | 10028 | RSS: Main: 218390528 11:52:12 INFO - PROCESS | 10028 | 11:52:16 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41605/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:16 INFO - PROCESS | 10028 | RSS: Main: 218570752 11:52:16 INFO - PROCESS | 10028 | 11:52:19 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41605/tests/kraken/driver.html?testName=json-parse-financial) 11:52:20 INFO - PROCESS | 10028 | RSS: Main: 216780800 11:52:20 INFO - PROCESS | 10028 | 11:52:21 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41605/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:22 INFO - PROCESS | 10028 | RSS: Main: 179093504 11:52:22 INFO - PROCESS | 10028 | 11:52:24 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:24 INFO - PROCESS | 10028 | RSS: Main: 186179584 11:52:24 INFO - PROCESS | 10028 | 11:52:26 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:27 INFO - PROCESS | 10028 | RSS: Main: 195502080 11:52:27 INFO - PROCESS | 10028 | 11:52:30 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:30 INFO - PROCESS | 10028 | RSS: Main: 203563008 11:52:30 INFO - PROCESS | 10028 | 11:52:33 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:34 INFO - PROCESS | 10028 | RSS: Main: 200507392 11:52:34 INFO - PROCESS | 10028 | 11:52:35 INFO - PROCESS | 10028 | Cycle 1(1): loaded http://localhost:41605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41605/tests/kraken/driver.html?testName=ai-astar) 11:52:36 INFO - PROCESS | 10028 | RSS: Main: 252461056 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | __start_tp_report 11:52:36 INFO - PROCESS | 10028 | _x_x_mozilla_page_load 11:52:36 INFO - PROCESS | 10028 | _x_x_mozilla_page_load_details 11:52:36 INFO - PROCESS | 10028 | |i|pagename|runs| 11:52:36 INFO - PROCESS | 10028 | |0;ai-astar;111;113;113;111;110;112;110;111;114;110 11:52:36 INFO - PROCESS | 10028 | |1;audio-beat-detection;149;119;121;159;121;120;119;120;148;119 11:52:36 INFO - PROCESS | 10028 | |2;audio-dft;163;161;163;163;163;163;165;165;162;162 11:52:36 INFO - PROCESS | 10028 | |3;audio-fft;74;74;77;111;75;76;76;85;91;77 11:52:36 INFO - PROCESS | 10028 | |4;audio-oscillator;83;83;113;82;83;83;93;84;83;106 11:52:36 INFO - PROCESS | 10028 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;117;119;118 11:52:36 INFO - PROCESS | 10028 | |6;imaging-darkroom;149;147;147;147;147;147;147;146;148;146 11:52:36 INFO - PROCESS | 10028 | |7;imaging-desaturate;96;96;96;97;96;96;96;95;97;95 11:52:36 INFO - PROCESS | 10028 | |8;json-parse-financial;51;51;50;51;52;52;52;53;52;50 11:52:36 INFO - PROCESS | 10028 | |9;json-stringify-tinderbox;67;68;68;68;68;68;69;69;69;69 11:52:36 INFO - PROCESS | 10028 | |10;stanford-crypto-aes;84;82;82;81;82;89;88;83;83;83 11:52:36 INFO - PROCESS | 10028 | |11;stanford-crypto-ccm;128;127;125;128;135;126;126;126;161;132 11:52:36 INFO - PROCESS | 10028 | |12;stanford-crypto-pbkdf2;171;169;167;166;166;167;172;171;167;169 11:52:36 INFO - PROCESS | 10028 | |13;stanford-crypto-sha256-iterative;64;63;64;63;63;64;68;63;63;62 11:52:36 INFO - PROCESS | 10028 | __end_tp_report 11:52:36 INFO - PROCESS | 10028 | __start_cc_report 11:52:36 INFO - PROCESS | 10028 | _x_x_mozilla_cycle_collect,1549 11:52:36 INFO - PROCESS | 10028 | __end_cc_report 11:52:36 INFO - PROCESS | 10028 | __startTimestamp1484769156110__endTimestamp 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | ------- Summary: start ------- 11:52:36 INFO - PROCESS | 10028 | Number of tests: 14 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:1.43 (1.3%) stddev-sans-first:1.51 11:52:36 INFO - PROCESS | 10028 | Values: 111.0 113.0 113.0 111.0 110.0 112.0 110.0 111.0 114.0 110.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:121.00 stddev:15.81 (13.1%) stddev-sans-first:15.11 11:52:36 INFO - PROCESS | 10028 | Values: 149.0 119.0 121.0 159.0 121.0 120.0 119.0 120.0 148.0 119.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 11:52:36 INFO - PROCESS | 10028 | Values: 163.0 161.0 163.0 163.0 163.0 163.0 165.0 165.0 162.0 162.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.50 stddev:11.68 (15.3%) stddev-sans-first:12.06 11:52:36 INFO - PROCESS | 10028 | Values: 74.0 74.0 77.0 111.0 75.0 76.0 76.0 85.0 91.0 77.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:11.23 (13.5%) stddev-sans-first:11.67 11:52:36 INFO - PROCESS | 10028 | Values: 83.0 83.0 113.0 82.0 83.0 83.0 93.0 84.0 83.0 106.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 11:52:36 INFO - PROCESS | 10028 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 119.0 118.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 11:52:36 INFO - PROCESS | 10028 | Values: 149.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 148.0 146.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:52:36 INFO - PROCESS | 10028 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 97.0 95.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 11:52:36 INFO - PROCESS | 10028 | Values: 51.0 51.0 50.0 51.0 52.0 52.0 52.0 53.0 52.0 50.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 11:52:36 INFO - PROCESS | 10028 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.67 (3.2%) stddev-sans-first:2.83 11:52:36 INFO - PROCESS | 10028 | Values: 84.0 82.0 82.0 81.0 82.0 89.0 88.0 83.0 83.0 83.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:128.00 stddev:10.85 (8.5%) stddev-sans-first:11.44 11:52:36 INFO - PROCESS | 10028 | Values: 128.0 127.0 125.0 128.0 135.0 126.0 126.0 126.0 161.0 132.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.00 stddev:2.22 (1.3%) stddev-sans-first:2.17 11:52:36 INFO - PROCESS | 10028 | Values: 171.0 169.0 167.0 166.0 166.0 167.0 172.0 171.0 167.0 169.0 11:52:36 INFO - PROCESS | 10028 | 11:52:36 INFO - PROCESS | 10028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.64 (2.6%) stddev-sans-first:1.73 11:52:36 INFO - PROCESS | 10028 | Values: 64.0 63.0 64.0 63.0 63.0 64.0 68.0 63.0 63.0 62.0 11:52:36 INFO - PROCESS | 10028 | -------- Summary: end -------- 11:52:36 INFO - PROCESS | 10028 | 11:52:37 INFO - TEST-INFO | 10028: exit 0 11:52:37 INFO - TEST-OK | kraken | took 60308ms 11:52:37 INFO - SUITE-END | took 1174s 11:52:37 INFO - Completed test suite (00:19:34) 11:52:37 INFO - javascript benchmark 11:52:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3170.3500782339615, 3191.4095892259934, 3198.4082944655242, 3222.1139186723635, 3224.580804495415, 5267.657602255851, 5355.384130824957, 5363.115086010808, 5439.483249091335, 5466.3167104112035, 5366.570674346052, 5408.323959505062, 5415.214793854889, 5444.237806707054, 5482.91775623365, 4873.0741159179815, 4885.951140488585, 4906.067847109056, 4909.680870743408, 4971.801127954877, 4971.651984361096, 5001.649884508086, 5025.824096156635, 5026.095302845486, 5031.924521132186, 4778.068276686065, 4803.975980120112, 4813.133635945528, 4858.927116093226, 4929.21132618781, 4869.975650121763, 4892.363992680965, 4893.6329775266995, 4935.70385776851, 4945.604351651859, 4831.275308703723, 4843.29772183035, 4862.756862156878, 4888.022395520875, 4914.827981020683, 5242.266082748418, 5279.155335146396, 5323.068463018956, 5391.433899440581, 5474.534664553517, 5733.684647344395, 5747.712614369307, 5749.1663708762, 5796.478316951495, 5797.246357973437, 5786.826395208151, 5787.739551720183, 5792.073268277056, 5800.419958004208, 5808.535317174616, 5312.601554883399, 5352.6253162279045, 5371.435999220103, 5377.650452720561, 5399.78400863965, 5892.0, 5938.524918006549, 5952.613080149777, 5986.970065149646, 6033.18551995475, 5670.950874088225, 5712.057510510719, 5714.342850572154, 5725.940700970334, 5727.885442291131, 5626.831195064155, 5669.376368599451, 5764.106563482667, 5817.621854579439, 5825.563082768809, 5683.857903552362, 5740.253767010262, 5743.195952566561, 5807.303123625192, 5829.650220986754, 5778.855528611734, 5785.450382213683, 5798.072308430716, 5837.182794408786, 5837.387074357216, 4494.07871386365, 4495.707778994421, 4500.212462818994, 4510.300903359985, 4538.795754191069, 3950.229705207457, 3966.829785213369, 3974.5429275633674, 4009.4587230723478, 4075.857344992911, 5398.0, 5438.564914806806, 5441.619086663895, 5472.151816468454, 5489.58828087887, 5711.400302968212, 5718.885622287531, 5734.340550836707, 5738.483536481736, 5773.971130144322, 5270.0, 5325.707086110301, 5374.355077390738, 5440.319960004999, 5490.917636235459, 4942.20924652054, 4947.950520494749, 4955.653104282737, 4972.428170760337, 4982.60139188864, 6076.939230607814, 6094.078451592408, 6096.587161059637, 6126.08108783686, 6129.448349648553, 5822.417758224144, 5824.388439213822, 5825.621334613236, 5829.59192856496, 5840.795572154954, 5725.5992080555625, 5839.7372118255635, 6008.158857760004, 6046.365131661289, 6057.636541807329, 5642.379338272869, 5751.4536119068625, 5754.769809207585, 5760.510356619567, 5796.101604251347, 5869.383714709894, 5872.119182122716, 5875.41245875409, 5877.500412464989, 5883.794067207627, 5566.582506312124, 5672.376038635664, 5724.885502290014, 5735.11105778605, 5740.052891272893, 5583.106702927512, 5597.916031259453, 5605.523530499953, 5621.269234999424, 5735.827925162252, 5394.78420863161, 5617.691026993554, 5622.550195984393, 5637.633553818989, 5672.262605861211, 5479.753411096431, 5521.585881059017, 5545.500904918576, 5589.916151257816, 5668.319801623831, 5443.836684899459, 5468.097763868917, 5515.558755299647, 5522.3649280333275, 5524.06090964545], "value": 5332.048571850693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.2667582074645, 557.0530098831986, 581.9185314056033, 590.0588561244816, 610.8992016317308, 34827.82586087069, 38554.0, 38561.614383856155, 38603.99999999996, 38854.0, 47297.0, 48563.51436485634, 48790.26814597775, 52575.0, 53173.0, 8866.733997980054, 9040.141186587263, 9043.95478022609, 9047.457152570834, 9053.230475409599, 8554.05905350411, 8773.824523509526, 9109.817803643924, 9171.128742769426, 9186.173244408003, 10881.510332035037, 11123.833142502868, 11129.666110016671, 11468.655940321803, 11477.483513241925, 11132.387718675469, 11204.495797689124, 11213.327200368005, 11236.66290011301, 11244.26912250701, 10903.509342079546, 10934.617288394868, 10965.342079475176, 10985.176111791568, 10986.0, 45440.0, 45643.543564564265, 45715.0, 45974.310385344244, 46125.76937115326, 4261.659067274611, 4281.250781113293, 4363.105563359503, 4465.888352791174, 4480.19356515827, 33830.66169338324, 33845.49231761526, 33931.491027634605, 34147.6585234147, 35718.0, 4284.100338928829, 4293.699441039129, 4329.631981281595, 4357.150355680644, 4426.579474949875, 311028.0, 313370.0, 314689.0, 315212.0, 316033.0, 63246.0, 63374.0, 63593.0, 63599.36400636027, 63683.363166367744, 66497.33502665008, 66928.33071669318, 66992.0, 67040.0, 67069.66465167643, 16137.112458814878, 16452.83547164513, 16492.25784839685, 16502.917485412738, 16515.504534863972, 12539.059570532247, 12552.937235313764, 12556.686082847818, 12558.74882502345, 12561.560345387868, 16334.428295009619, 16758.162091895356, 17757.378491752985, 17763.26971336008, 18456.26174953014, 6635.834104147435, 6675.46596272297, 6741.1236539249585, 6962.2341542430295, 6970.817509494263, 930.7135470527335, 953.804470083645, 975.4196253229317, 990.9207263418909, 1007.6070332570304, 32086.0, 33951.83024084913, 34169.487457688156, 34262.25255427873, 34355.48466773, 1070.3577853287966, 1131.8415421840948, 1132.1791701016862, 1173.501261963662, 1179.6637958181877, 16746.56439757113, 17573.28804764908, 17792.288308467774, 17876.731849022275, 17914.46256612304, 448966.0, 465398.0, 472461.0, 473021.0, 738023.0, 51443.7427812866, 52426.21360679593, 56012.0, 58168.709156453944, 58951.41048589545, 1467.4203689542571, 1473.2118316700514, 1488.732028234928, 1506.314626844783, 1522.543237028887, 29621.851890740407, 31530.054098377084, 31882.84058579785, 31959.206119081395, 32254.35491290114, 49971.500284996684, 50475.0, 50501.0, 50521.0, 50550.747246263534, 396972.0, 399895.0, 400278.0, 401853.0, 402211.0, 26220.08229711951, 26549.734502655498, 26764.59853102166, 26920.596191057542, 27027.324316892234, 39505.604943950195, 40882.0, 42549.5745042558, 43489.34765978576, 46068.0, 37242.62757372392, 37268.254634907695, 37543.2491350166, 37688.0, 39531.2093758129, 37472.625273748, 37942.62057379391, 38062.42906356351, 38212.23575528529, 38294.61705383022, 37142.0, 37331.6266837339, 37453.62546374501, 38104.61895381011, 38202.426963596125, 31302.217444564067, 32843.0, 33999.0, 34306.828465857514, 34357.0, 25234.0, 25451.0, 25565.616515752652, 25690.871545642152, 25863.870680646476], "value": 20265.28130953142, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.18162856957537, 413.95032596088475, 424.7812376626037, 426.0839195729182, 435.90845922356306, 19058.618827623457, 19926.003699815006, 20878.791212087875, 21027.894860525696, 21198.89400552995, 21438.0, 21471.892640536815, 21810.781892181072, 21868.562628747455, 22186.88906555465, 5715.628484148538, 6000.519958403339, 6003.339632640406, 6004.819855404345, 6008.969955150218, 5555.250041244441, 5788.768449262025, 5821.214136091637, 5885.117232415129, 5999.85000374992, 5850.73671684773, 5852.76588936442, 5856.326522449909, 5856.619319744224, 5863.58954873159, 5648.350439699426, 5771.076627739562, 5782.537397008229, 5806.44838740319, 5843.678597677126, 5621.269234999424, 5640.943590564124, 5646.745896434671, 5673.00722373583, 5694.373618901917, 25388.0, 25441.109561165456, 25564.48871022569, 25608.23175304744, 25800.354991125183, 2650.734926507353, 2698.3523954251036, 2723.2919440945498, 2740.1642499037785, 2754.1462146734575, 9899.356541824758, 10090.192784577217, 10349.689509314732, 10482.213833962407, 10495.580176792919, 1799.199356286453, 1825.3246298869503, 1854.3973208707089, 1866.4027511196423, 1894.6589613869498, 86309.70535442037, 87179.0, 88236.55881720614, 90199.54900225523, 95887.52056239675, 11892.718621296326, 11901.0, 11948.701282468008, 12242.143049986415, 12412.317322547166, 16839.41062062822, 16874.662506750043, 16876.15619219034, 16891.23989420479, 16907.746383804253, 8100.756977290691, 8363.749087527383, 8387.203215694499, 8546.78633034179, 8640.481571105754, 7874.212578742195, 7924.366050715929, 8105.878411823827, 8161.877571836427, 8167.918320816716, 5029.856339787632, 5146.588272938156, 5159.406668233126, 5165.54404272357, 5233.842984710464, 2073.5438203595186, 2113.1019316790303, 2127.319257837477, 2155.913763449476, 2158.568286342738, 999.2570394267636, 1003.2425518733455, 1003.6838395905266, 1014.2190513304862, 1027.6300531808542, 20267.594648106955, 20795.792042079687, 21165.470863228235, 21251.218475842812, 21452.0, 971.5288085278635, 993.6124911284605, 1032.1226957086417, 1044.7805960748176, 1064.377339256528, 10521.158307335394, 10905.879609646783, 10994.560217591366, 11040.927489880534, 11235.382053987109, 623366.0, 627151.0, 641315.0, 658007.0, 661629.0, 101635.0, 108395.0, 108486.45756771324, 110927.0, 111098.44450777856, 1108.0969010256777, 1137.351709525579, 1160.4197901049474, 1161.2916121166081, 1167.0371943146938, 16552.255148518103, 17131.0, 17485.388011419538, 17563.209655565784, 17980.0, 41571.37642935419, 42916.78541607272, 43578.78210608927, 43985.34021989737, 44709.55290447184, 63849.680751595944, 64967.67516162389, 65165.34834651782, 65631.67184164049, 66925.3307466919, 8657.480551166951, 8914.55427228623, 9004.729858104005, 9055.637774488947, 9506.239500839778, 12051.0, 13270.1374410663, 13438.328083595585, 14059.929700351433, 14085.647858803612, 11757.823632645346, 11967.880321196677, 12128.818067729168, 12221.083418743452, 12233.632991010283, 11821.0543156549, 11865.11011674145, 12003.039756819608, 12250.326232057323, 12298.323592202514, 11745.530178792753, 11830.526778928746, 12152.696182595506, 12227.510899563918, 12345.629631111082, 8833.0, 8952.910470895207, 8980.101989800967, 9321.394109382869, 9366.578503967474, 10728.0, 11606.76786464249, 11898.22661526998, 12056.698582535506, 12183.086268529718], "value": 9785.99113758253, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.8548159702425, 1442.4302400551783, 1468.2585294426317, 1473.683158121004, 1478.1131321207276, 7307.634618269085, 7985.9201407985975, 8283.33733301336, 8308.875366869503, 8540.0, 8346.791330216747, 8383.16168383163, 8435.40952133351, 8447.662093516268, 8453.957730211356, 2041.7345745053121, 2107.051826677993, 2268.308166009362, 2327.895244713992, 2334.673145759595, 2284.257616274709, 2355.305184970438, 2357.1749887539395, 2373.786359227669, 2379.654950032253, 2221.1004543160047, 2245.236619549353, 2248.8875556222206, 2252.2454977582447, 2256.7066281383395, 2250.493638931244, 2264.501809601885, 2272.5909336319455, 2273.783990520898, 2283.2008796921027, 2223.399682085828, 2268.4895898422888, 2296.666983287431, 2306.5848147333472, 2306.988465057681, 8409.032961209477, 8424.915750842474, 8471.195236452528, 8474.915250847474, 8476.830463390697, 5183.714895680736, 5328.760205790749, 5329.360476742777, 5335.3864305604575, 5338.092524270884, 3248.171716212351, 3457.3258214648154, 3458.4639380896, 3462.4460086386057, 3506.0358401439807, 1353.1137105196015, 1441.149721664223, 2092.884891330976, 2118.925837595692, 2122.554263604645, 11051.281666691639, 11103.333799971946, 11190.888091119066, 11191.440427978569, 11202.38386888729, 4302.7633480158265, 4467.508574056851, 4509.684322097487, 4543.931841022388, 4544.204764166324, 9220.492872892055, 9224.40041397307, 9262.72211833646, 9263.95368023169, 9264.583093760797, 5217.843464696065, 5241.947580524146, 5249.238860365225, 5251.684898906078, 5254.448282930313, 4758.16732071893, 4772.76136193189, 4877.0, 4883.389576302962, 4940.505949405031, 3722.5532936047307, 3732.1602639405914, 3763.6800871925643, 3811.142492939122, 3819.1597848473293, 1159.1885680024018, 1170.7014711248578, 1172.0623501199007, 1174.9177557570888, 1185.1052455396293, 1006.104566935428, 1009.5457044329934, 1016.9288149829441, 1022.9386236825815, 1032.7831155457288, 5711.257536520309, 5801.622894511843, 5873.941260587425, 5909.940900590939, 6154.553679885224, 990.3315262197988, 1023.1712313026472, 1037.9464843184173, 1039.2257767962917, 1053.378506681062, 3758.4550240215563, 3885.4948856648457, 3899.8495443843567, 3958.3072962231495, 3959.821808018646, 10041.799164016826, 10409.635662751918, 10487.37075775456, 10511.211659125443, 10525.421101839473, 10144.340617859963, 10209.54057067419, 10211.540480678388, 10332.586696532206, 10339.0694837465, 7229.710811567584, 7478.962605187048, 7497.10034795828, 7879.960600196962, 8018.0, 5770.278715160605, 5851.093080572518, 5909.527237820878, 5923.49650279731, 5989.7304621293015, 8724.912750872663, 8913.643454261757, 8918.420302680564, 9012.053734357798, 9094.727158185266, 8343.45767525109, 8982.371234013557, 9096.590653420744, 9160.404573702954, 9163.541822908695, 6786.778379891667, 7047.541909775849, 7184.712611495482, 7276.4178865689555, 7380.409567234501, 7772.417068719982, 7825.060992680915, 7845.450818442882, 7901.209879012053, 7911.406644501571, 7114.181869084914, 7132.393746531396, 7142.857142857218, 7147.8570428592175, 7217.386522145676, 7005.0, 7032.542884712478, 7119.466040046914, 7214.531055481377, 7242.311980361857, 6477.967610161919, 6525.64108974011, 6590.90113648286, 6592.868142637216, 6599.5050371223315, 4663.580277775017, 4796.784144713426, 4802.73584952831, 4817.084753896748, 4906.288588154626, 5064.924026139684, 5085.262636917552, 5180.507851754077, 5211.342215470062, 5215.869603259949], "value": 4513.417603003608, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.69879644479073, 387.3685891996046, 396.11270753512133, 396.2787726338064, 397.128303374094, 5058.4435712071645, 5185.429602743695, 5269.394019687732, 5338.412774594796, 5381.654586353407, 5093.439721630618, 5174.870628234296, 5188.04021256067, 5217.399999000116, 5249.26510288559, 4127.484064491939, 4165.27107756143, 4169.4162817205615, 4172.7287726297845, 4200.894977625569, 3936.8779897729155, 3995.3008223560905, 4177.0, 4187.455630768011, 4237.957620423803, 4169.56219596941, 4176.060386413048, 4208.957910420887, 4209.936850947238, 4211.4946206455115, 4181.0, 4181.874543763692, 4195.769232692201, 4196.202721482939, 4210.97894510527, 3821.99345343694, 3838.213166300902, 3846.8653597123966, 3850.3454412749898, 3859.186182494251, 5001.574866136347, 5073.746312684351, 5076.680063183562, 5097.694138351673, 5147.510986456281, 4829.855104346875, 4839.128956787777, 4841.973766396002, 4859.979404325096, 4879.536444037811, 5324.201369794523, 5465.059903734157, 5515.889682206333, 5527.170924361378, 5557.777688892439, 4150.481189851269, 4150.8547200848125, 4173.561776013506, 4196.538380778112, 4222.324428091521, 5686.658800471985, 5692.77228910843, 5693.231413759131, 5703.486686198262, 5719.599628025998, 4319.0, 4350.195213885441, 4353.9129217415475, 4356.172327257811, 4364.62900653448, 4259.829606815754, 4338.934915976263, 4368.716033457815, 4387.319965405367, 4391.890202744893, 4823.311840855672, 4832.44426890905, 4838.056578967067, 4854.732989685601, 4875.658703890694, 5546.947629377156, 5574.58190635704, 5594.412586678422, 5608.513743857881, 5637.43625637433, 1325.8740419660116, 1330.5077121464926, 1360.768669326217, 1361.3669643615767, 1394.0520446096752, 941.152962333905, 961.7451375385529, 974.6637410093506, 975.2100798353357, 979.5200351827554, 4994.602590756457, 5023.924641130386, 5025.874353141201, 5032.597392208614, 5049.318342023853, 5442.374126975448, 5444.91832622511, 5446.346438427414, 5460.262864513319, 5470.990954974748, 4889.437714662859, 5022.970291090318, 5038.64729468941, 5049.166887463601, 5063.696178229318, 2871.4113606710994, 2893.2477555835635, 2897.638110088255, 2907.912762617125, 2910.185148158519, 5672.858178545569, 5686.772529098873, 5691.743871525791, 5712.057510510802, 5741.85645358861, 5412.783488660488, 5544.944550554524, 5579.74891129892, 5596.809818403471, 5618.85952851182, 5602.6918519481005, 5618.803341883015, 5637.844241930313, 5659.490645841894, 5671.347795003545, 5246.737663116905, 5396.83809485716, 5426.593005524523, 5430.972845135749, 5462.453754624665, 5316.494932981361, 5333.466653334635, 5344.198370244494, 5388.191771234347, 5414.35027796667, 5643.984082864959, 5662.886742265049, 5665.960254308528, 5672.716364181857, 5696.316442026983, 3936.7834769087976, 3979.960200398075, 4000.219957108336, 4030.6372426481757, 4034.3545032794614, 5361.731913404392, 5407.188921661782, 5427.24018637399, 5461.754221060141, 5486.670799752028, 5310.707911064928, 5384.5423139032055, 5480.451590010664, 5487.972560137174, 5503.174523821459, 5478.80824171168, 5479.945200548103, 5486.61593688438, 5515.641483303572, 5521.365043020104, 5233.816816411408, 5374.050073196276, 5427.430119837518, 5432.429594892479, 5450.727463626724, 5455.9454405455435, 5459.208414779914, 5462.180672899097, 5468.726563671721, 5525.171224316224, 5331.1470164775, 5332.120200166929, 5346.358436987586, 5349.7860085597695, 5362.597805164706], "value": 4217.100924471365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.2275747010461, 795.8686816675249, 818.5620692929281, 892.3842548641437, 909.8043920557079, 16131.193440327981, 16841.242144103515, 16851.0, 16989.660206795856, 17026.31894724211, 13987.720245595108, 14023.298835058258, 14031.438742450315, 14098.71802563948, 14141.787873181911, 643.4691379611816, 657.7829316325601, 734.320753303195, 748.2367984655648, 762.0284137724418, 754.9849003019937, 756.7994481462417, 759.3469616130124, 760.0727112922253, 761.4251240313555, 796.9561674107922, 801.6072124658933, 802.0535767794, 802.0535767794, 802.9397795165386, 684.0491716514025, 688.3667026335758, 777.9922200777976, 791.7664289034749, 804.7183485779989, 579.6666916522973, 580.5181699189662, 580.7560824453698, 582.2663444060514, 583.107844997155, 15990.840091599051, 16277.91861040699, 16319.18404079803, 16333.509994700178, 17013.0, 14521.78217326741, 14878.925605372013, 15144.0, 15240.466583669519, 15446.227688615525, 13703.520376786764, 13729.725405491934, 13776.10455320401, 13790.517331893336, 13800.309984500735, 4456.930336719196, 4459.509453960094, 4492.124035813018, 4492.348609451644, 4541.795619197144, 75249.62375188143, 76175.61912190459, 76689.0, 77874.0, 78154.3568796653, 11897.107716921093, 11982.221155624857, 11984.28094314344, 12064.457099430547, 12232.81650775239, 23265.767342326697, 23426.88286558556, 23575.646365304536, 23593.528129437316, 23609.88195059048, 8205.79485512867, 8263.0, 8344.958275208584, 8392.580370981426, 8469.280111190494, 4506.481754598198, 4527.977360113178, 4605.171069207508, 4642.489326174118, 4674.906501869944, 3370.9494357584654, 3417.5898892133105, 3429.091290807938, 3466.8093254871224, 3469.3061387722555, 577.532198918877, 580.4340767751409, 581.877805660816, 594.1770647653032, 596.2725474920677, 736.1828370508731, 756.3835474088601, 757.4243574883128, 760.4904713841739, 765.2577000309691, 10081.294309398272, 10510.737231569272, 10672.466376681135, 11118.722031949104, 11200.943995280135, 702.4275215699291, 727.0875051809944, 735.1949615171379, 747.7196051480695, 773.8607050730923, 4793.664443488922, 4936.160852655057, 5032.521910418504, 5128.6666366686795, 5129.3075434816565, 78179.60910195412, 78415.0, 80155.0, 81221.18778812254, 82486.58756706178, 70728.64635676789, 70992.64503677552, 71649.28350716426, 72564.27435725575, 72734.27265727276, 61081.389186108456, 61144.38855611476, 61145.0, 61593.38406615966, 61645.999999999105, 9745.902540974499, 9994.900050999688, 10032.548535316075, 10051.748706282402, 10096.596136154472, 41726.48923193854, 42068.36897446602, 42386.5761342395, 44105.0, 44338.11323773442, 45472.54527454815, 46979.765101175646, 47404.762976184895, 51672.0, 51873.740631296605, 13927.860721392657, 14026.368813403216, 14109.0, 14179.716405671623, 14317.713645726819, 14740.11559306445, 15559.922200388926, 15640.061596304258, 15862.619095985166, 16178.527190634322, 10658.946705266424, 13032.934835325763, 14330.0, 14434.783478247624, 14477.420903164177, 14620.707585848437, 14649.414023439369, 14943.850561494246, 15468.92265538665, 15724.0, 14423.78364324515, 14579.271036448346, 14830.0, 15340.539783806504, 15643.452479163174, 12190.71997440256, 12341.197822141532, 12370.195937264049, 12796.424160912968, 12963.416646250753, 9315.72052838416, 9423.623055077995, 9432.62269509212, 9450.243980481682, 9509.144177024102], "value": 7364.10574090136, "unit": "score"}], "name": "dromaeo_css", "value": 7274.833421517138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 111.0, 110.0, 112.0, 110.0, 111.0, 114.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 121.0, 159.0, 121.0, 120.0, 119.0, 120.0, 148.0, 119.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 163.0, 163.0, 165.0, 165.0, 162.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 111.0, 75.0, 76.0, 76.0, 85.0, 91.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 82.0, 83.0, 83.0, 93.0, 84.0, 83.0, 106.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 52.0, 52.0, 52.0, 53.0, 52.0, 50.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 82.0, 81.0, 82.0, 89.0, 88.0, 83.0, 83.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 128.0, 135.0, 126.0, 126.0, 126.0, 161.0, 132.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 167.0, 166.0, 166.0, 167.0, 172.0, 171.0, 167.0, 169.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 68.0, 63.0, 63.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1502.6000000000001, "alertThreshold": 2.0}]} 11:52:37 INFO - Return code: 0 11:52:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:37 ERROR - # TBPL SUCCESS # 11:52:37 INFO - Running post-action listener: _resource_record_post_action 11:52:37 INFO - [mozharness: 2017-01-18 19:52:37.414406Z] Finished run-tests step (success) 11:52:37 INFO - Running post-run listener: _resource_record_post_run 11:52:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418619392; Read time: 4; Write time: 296984 11:52:37 INFO - TinderboxPrint: CPU usage
13.1% 11:52:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 11:52:37 INFO - TinderboxPrint: I/O write bytes / time
418,619,392 / 296,984 11:52:37 INFO - TinderboxPrint: CPU idle
8,264.4 (86.9%) 11:52:37 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 11:52:37 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105938944; Read time: 0; Write time: 91932 11:52:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297705472; Read time: 4; Write time: 198112 11:52:38 INFO - Running post-run listener: _upload_blobber_files 11:52:38 INFO - Blob upload gear active. 11:52:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:38 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 11:52:38 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:52:38 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:52:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:39 INFO - (blobuploader) - INFO - Done attempting. 11:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:44 INFO - (blobuploader) - INFO - Done attempting. 11:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:45 INFO - (blobuploader) - INFO - Done attempting. 11:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:46 INFO - (blobuploader) - INFO - Done attempting. 11:52:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:46 INFO - Return code: 0 11:52:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d008d52ecae424e811b559c3caf781f721aa5872f753a1eb6021fcf7616d2492ed693926897afff38be06748c643090f2a65b0bb1398c905257e4234cfbf4044", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed550f21ffb0b3157cd3d7a7239ad9930838368a86ae8e85cf8f9204871c1d524984f40fdc55993ba45c031be4d49b23638b95ce2256048ae73c4f3da230ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb4a10dc516d791d2601f09e03d29a26278c26478f7291a29b70283571b730fb22f63507d779aeb534b0cd6bacfc0789f6a5289fdd8706428217208df675220a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d30e1a6f29bf3afca444c5d083242c6149af0ea8317968302ebf4d9f50db78add1bce7249d3f6d5dc1f2c4ae5a6309e6333b92f90d1d6ff8016b8a57ac56011"} 11:52:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:46 INFO - Contents: 11:52:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d008d52ecae424e811b559c3caf781f721aa5872f753a1eb6021fcf7616d2492ed693926897afff38be06748c643090f2a65b0bb1398c905257e4234cfbf4044", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed550f21ffb0b3157cd3d7a7239ad9930838368a86ae8e85cf8f9204871c1d524984f40fdc55993ba45c031be4d49b23638b95ce2256048ae73c4f3da230ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb4a10dc516d791d2601f09e03d29a26278c26478f7291a29b70283571b730fb22f63507d779aeb534b0cd6bacfc0789f6a5289fdd8706428217208df675220a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d30e1a6f29bf3afca444c5d083242c6149af0ea8317968302ebf4d9f50db78add1bce7249d3f6d5dc1f2c4ae5a6309e6333b92f90d1d6ff8016b8a57ac56011"} 11:52:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:46 INFO - Copying logs to upload dir... 11:52:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.666009 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 11:52:46.282866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 11:52:46.285949) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d008d52ecae424e811b559c3caf781f721aa5872f753a1eb6021fcf7616d2492ed693926897afff38be06748c643090f2a65b0bb1398c905257e4234cfbf4044", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed550f21ffb0b3157cd3d7a7239ad9930838368a86ae8e85cf8f9204871c1d524984f40fdc55993ba45c031be4d49b23638b95ce2256048ae73c4f3da230ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb4a10dc516d791d2601f09e03d29a26278c26478f7291a29b70283571b730fb22f63507d779aeb534b0cd6bacfc0789f6a5289fdd8706428217208df675220a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d30e1a6f29bf3afca444c5d083242c6149af0ea8317968302ebf4d9f50db78add1bce7249d3f6d5dc1f2c4ae5a6309e6333b92f90d1d6ff8016b8a57ac56011"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484761370/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d008d52ecae424e811b559c3caf781f721aa5872f753a1eb6021fcf7616d2492ed693926897afff38be06748c643090f2a65b0bb1398c905257e4234cfbf4044", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed550f21ffb0b3157cd3d7a7239ad9930838368a86ae8e85cf8f9204871c1d524984f40fdc55993ba45c031be4d49b23638b95ce2256048ae73c4f3da230ffc", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eb4a10dc516d791d2601f09e03d29a26278c26478f7291a29b70283571b730fb22f63507d779aeb534b0cd6bacfc0789f6a5289fdd8706428217208df675220a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d30e1a6f29bf3afca444c5d083242c6149af0ea8317968302ebf4d9f50db78add1bce7249d3f6d5dc1f2c4ae5a6309e6333b92f90d1d6ff8016b8a57ac56011"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 11:52:46.310667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:52:46.311013) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1484767928.596786-1631116138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:52:46.396354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 11:52:46.396669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 11:52:46.396951) ========= ========= Total master_lag: 0.17 =========