builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1481646524.87 results: success (0) buildid: 20161213081859 builduid: 51432d91a2f54d53b4a44f021eb513e4 revision: 620f6fd4477004d81ee133fcd8dfb24ab1009512 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.870220) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.870699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.870974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.885682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.886097) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-13 08:28:45-- 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 2016-12-13 08:28:45 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.068176 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.968578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:44.969010) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.018461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.018992) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 620f6fd4477004d81ee133fcd8dfb24ab1009512 --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 620f6fd4477004d81ee133fcd8dfb24ab1009512 --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=5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-13 08:28:45,525 truncating revision to first 12 chars 2016-12-13 08:28:45,525 Setting DEBUG logging. 2016-12-13 08:28:45,525 attempt 1/10 2016-12-13 08:28:45,525 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/620f6fd44770?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 08:28:45,967 unpacking tar archive at: mozilla-inbound-620f6fd44770/testing/mozharness/ program finished with exit code 0 elapsedTime=0.757466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.791662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.792194) ========= script_repo_revision: 620f6fd4477004d81ee133fcd8dfb24ab1009512 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.792905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.793357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:28:45.805201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-13 08:28:45.805793) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:28:46 INFO - MultiFileLogger online at 20161213 08:28:46 in /builds/slave/test 08:28:46 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 08:28:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:46 INFO - {'append_to_log': False, 08:28:46 INFO - 'base_work_dir': '/builds/slave/test', 08:28:46 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:28:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:46 INFO - 'branch': 'Mozilla-Inbound', 08:28:46 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:46 INFO - 'config_files': ('talos/linux_config.py',), 08:28:46 INFO - 'default_actions': ('clobber', 08:28:46 INFO - 'read-buildbot-config', 08:28:46 INFO - 'download-and-extract', 08:28:46 INFO - 'populate-webroot', 08:28:46 INFO - 'create-virtualenv', 08:28:46 INFO - 'install', 08:28:46 INFO - 'run-tests'), 08:28:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:46 INFO - 'download_minidump_stackwalk': True, 08:28:46 INFO - 'download_symbols': 'ondemand', 08:28:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:46 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:46 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:46 INFO - 'installer_path': 'installer.exe', 08:28:46 INFO - 'log_level': 'info', 08:28:46 INFO - 'log_name': 'talos', 08:28:46 INFO - 'log_to_console': True, 08:28:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:28:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:28:46 INFO - 'opt_config_files': (), 08:28:46 INFO - 'pip_index': False, 08:28:46 INFO - 'sps_profile': False, 08:28:46 INFO - 'sps_profile_interval': 0, 08:28:46 INFO - 'suite': 'dromaeojs', 08:28:46 INFO - 'system_bits': '32', 08:28:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:46 INFO - 'title': 'talos-linux64-ix-051', 08:28:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:46 INFO - 'use_talos_json': True, 08:28:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:46 INFO - 'work_dir': 'build'} 08:28:46 INFO - [mozharness: 2016-12-13 16:28:46.418526Z] Running clobber step. 08:28:46 INFO - Running pre-action listener: _resource_record_pre_action 08:28:46 INFO - Running main action method: clobber 08:28:46 INFO - rmtree: /builds/slave/test/build 08:28:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:46 INFO - Running post-action listener: _resource_record_post_action 08:28:46 INFO - [mozharness: 2016-12-13 16:28:46.884683Z] Finished clobber step (success) 08:28:46 INFO - [mozharness: 2016-12-13 16:28:46.884784Z] Running read-buildbot-config step. 08:28:46 INFO - Running pre-action listener: _resource_record_pre_action 08:28:46 INFO - Running main action method: read_buildbot_config 08:28:46 INFO - Using buildbot properties: 08:28:46 INFO - { 08:28:46 INFO - "project": "", 08:28:46 INFO - "product": "firefox", 08:28:46 INFO - "script_repo_revision": "production", 08:28:46 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:28:46 INFO - "repository": "", 08:28:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 08:28:46 INFO - "buildid": "20161213081859", 08:28:46 INFO - "stage_platform": "linux64-pgo", 08:28:46 INFO - "basedir": "/builds/slave/test", 08:28:46 INFO - "buildnumber": 2248, 08:28:46 INFO - "platform": "ubuntu64_hw", 08:28:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:28:46 INFO - "slavebuilddir": "test", 08:28:46 INFO - "branch": "mozilla-inbound", 08:28:46 INFO - "revision": "620f6fd4477004d81ee133fcd8dfb24ab1009512", 08:28:46 INFO - "slavename": "talos-linux64-ix-051", 08:28:46 INFO - "builduid": "51432d91a2f54d53b4a44f021eb513e4", 08:28:46 INFO - "repo_path": "integration/mozilla-inbound" 08:28:46 INFO - } 08:28:46 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:28:46 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 08:28:46 INFO - Running post-action listener: _resource_record_post_action 08:28:46 INFO - [mozharness: 2016-12-13 16:28:46.887136Z] Finished read-buildbot-config step (success) 08:28:46 INFO - [mozharness: 2016-12-13 16:28:46.887222Z] Running download-and-extract step. 08:28:46 INFO - Running pre-action listener: _resource_record_pre_action 08:28:46 INFO - Running main action method: download_and_extract 08:28:46 INFO - mkdir: /builds/slave/test/build/tests 08:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:46 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:28:46 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/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 08:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/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 08:28:46 INFO - Downloaded 1361 bytes. 08:28:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:28:46 INFO - Using the following test package requirements: 08:28:46 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:46 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:28:46 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:28:46 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'jsshell-linux-x86_64.zip'], 08:28:46 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:28:46 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:46 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:28:46 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:28:46 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:28:46 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:46 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:28:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:28:46 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/1481639716/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:28:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:28:47 INFO - Expected file size: 21788852 08:28:47 INFO - Obtained file size: 21788852 08:28:51 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 08:28:51 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/1481639716/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:28:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:28:51 INFO - Expected file size: 21788852 08:28:51 INFO - Obtained file size: 21788852 08:28:55 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/1481639716/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:28:55 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:28:56 INFO - Expected file size: 14409734 08:28:56 INFO - Obtained file size: 14409734 08:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:56 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:28:56 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/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 08:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/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 08:28:56 INFO - Downloaded 59873666 bytes. 08:28:56 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:28:56 INFO - mkdir: /builds/slave/test/properties 08:28:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:56 INFO - Contents: 08:28:56 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:28:57 INFO - Running post-action listener: _resource_record_post_action 08:28:57 INFO - Running post-action listener: set_extra_try_arguments 08:28:57 INFO - [mozharness: 2016-12-13 16:28:57.254290Z] Finished download-and-extract step (success) 08:28:57 INFO - [mozharness: 2016-12-13 16:28:57.254517Z] Running populate-webroot step. 08:28:57 INFO - Running pre-action listener: _resource_record_pre_action 08:28:57 INFO - Running main action method: populate_webroot 08:28:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:57 INFO - '--tppagecycles', 08:28:57 INFO - '7'], 08:28:57 INFO - 'tests': ['tsvgm']}}, 08:28:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['damp', 'tps']}, 08:28:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'tests': ['damp', 'tps']}, 08:28:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['dromaeo_dom']}, 08:28:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['basic_compositor_video']}, 08:28:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['a11yr', 08:28:57 INFO - 'ts_paint', 08:28:57 INFO - 'tpaint', 08:28:57 INFO - 'sessionrestore', 08:28:57 INFO - 'sessionrestore_no_auto_restore', 08:28:57 INFO - 'tabpaint']}, 08:28:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:57 INFO - 'ts_paint', 08:28:57 INFO - 'tpaint', 08:28:57 INFO - 'sessionrestore', 08:28:57 INFO - 'sessionrestore_no_auto_restore', 08:28:57 INFO - 'tabpaint']}, 08:28:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:57 INFO - 'ts_paint', 08:28:57 INFO - 'tpaint', 08:28:57 INFO - 'sessionrestore', 08:28:57 INFO - 'sessionrestore_no_auto_restore', 08:28:57 INFO - 'tabpaint']}, 08:28:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:57 INFO - 'ts_paint', 08:28:57 INFO - 'tpaint', 08:28:57 INFO - 'sessionrestore', 08:28:57 INFO - 'sessionrestore_no_auto_restore', 08:28:57 INFO - 'tabpaint']}, 08:28:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['a11yr', 08:28:57 INFO - 'ts_paint', 08:28:57 INFO - 'tpaint', 08:28:57 INFO - 'sessionrestore', 08:28:57 INFO - 'sessionrestore_no_auto_restore', 08:28:57 INFO - 'tabpaint']}, 08:28:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['a11yr', 08:28:57 INFO - 'ts_paint', 08:28:57 INFO - 'tpaint', 08:28:57 INFO - 'sessionrestore', 08:28:57 INFO - 'sessionrestore_no_auto_restore', 08:28:57 INFO - 'tabpaint']}, 08:28:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['tsvgx', 08:28:57 INFO - 'tsvgr_opacity', 08:28:57 INFO - 'tart', 08:28:57 INFO - 'tscrollx', 08:28:57 INFO - 'cart', 08:28:57 INFO - 'tsvg_static']}, 08:28:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:57 INFO - 'tsvgr_opacity', 08:28:57 INFO - 'tart', 08:28:57 INFO - 'tscrollx', 08:28:57 INFO - 'cart', 08:28:57 INFO - 'tsvg_static']}, 08:28:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'talos_options': ['--disable-e10s'], 08:28:57 INFO - 'tests': ['tp5o']}, 08:28:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:28:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'talos_options': ['--disable-e10s', 08:28:57 INFO - '--xperf_path', 08:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:57 INFO - 'tests': ['tp5n']}, 08:28:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:28:57 INFO - 'talos_options': ['--xperf_path', 08:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:57 INFO - 'tests': ['tp5n']}}, 08:28:57 INFO - 'talos.zip': {'path': '', 08:28:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:57 INFO - Running post-action listener: _resource_record_post_action 08:28:57 INFO - [mozharness: 2016-12-13 16:28:57.271422Z] Finished populate-webroot step (success) 08:28:57 INFO - [mozharness: 2016-12-13 16:28:57.271510Z] Running create-virtualenv step. 08:28:57 INFO - Running pre-action listener: _resource_record_pre_action 08:28:57 INFO - Running main action method: create_virtualenv 08:28:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:57 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 08:28:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:57 INFO - Using real prefix '/usr' 08:28:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:59 INFO - Installing pip.................done. 08:28:59 INFO - Return code: 0 08:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:29:00 INFO - Reading from file tmpfile_stdout 08:29:00 INFO - Output received: 08:29:00 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) 08:29:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29:00 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')]} 08:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 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')]} 08:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:00 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 08:29:00 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 08:29:00 INFO - Using env: {'DISPLAY': ':0', 08:29:00 INFO - 'HOME': '/home/cltbld', 08:29:00 INFO - 'LANG': 'en_US.UTF-8', 08:29:00 INFO - 'LANGUAGE': 'en_US:en', 08:29:00 INFO - 'LOGNAME': 'cltbld', 08:29:00 INFO - 'MAIL': '/var/mail/cltbld', 08:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:00 INFO - 'MOZ_NO_REMOTE': '1', 08:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:00 INFO - 'NO_EM_RESTART': '1', 08:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:00 INFO - 'PWD': '/builds/slave/test', 08:29:00 INFO - 'SHELL': '/bin/bash', 08:29:00 INFO - 'SHLVL': '1', 08:29:00 INFO - 'TERM': 'linux', 08:29:00 INFO - 'TMOUT': '86400', 08:29:00 INFO - 'USER': 'cltbld', 08:29:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:00 INFO - '_': '/tools/buildbot/bin/python'} 08:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:00 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 08:29:00 INFO - Cleaning up... 08:29:00 INFO - Return code: 0 08:29:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29:00 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')]} 08:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 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')]} 08:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:00 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 08:29:00 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 08:29:00 INFO - Using env: {'DISPLAY': ':0', 08:29:00 INFO - 'HOME': '/home/cltbld', 08:29:00 INFO - 'LANG': 'en_US.UTF-8', 08:29:00 INFO - 'LANGUAGE': 'en_US:en', 08:29:00 INFO - 'LOGNAME': 'cltbld', 08:29:00 INFO - 'MAIL': '/var/mail/cltbld', 08:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:00 INFO - 'MOZ_NO_REMOTE': '1', 08:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:00 INFO - 'NO_EM_RESTART': '1', 08:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:00 INFO - 'PWD': '/builds/slave/test', 08:29:00 INFO - 'SHELL': '/bin/bash', 08:29:00 INFO - 'SHLVL': '1', 08:29:00 INFO - 'TERM': 'linux', 08:29:00 INFO - 'TMOUT': '86400', 08:29:00 INFO - 'USER': 'cltbld', 08:29:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:00 INFO - '_': '/tools/buildbot/bin/python'} 08:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:00 INFO - Downloading/unpacking psutil>=3.1.1 08:29:00 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 08:29:00 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 08:29:00 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 08:29:00 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 08:29:00 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 08:29:00 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 08:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:02 INFO - Installing collected packages: psutil 08:29:02 INFO - Running setup.py install for psutil 08:29:02 INFO - building 'psutil._psutil_linux' extension 08:29:02 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 08:29:02 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 08:29:02 INFO - building 'psutil._psutil_posix' extension 08:29:02 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 08:29:03 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 08:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:03 INFO - Successfully installed psutil 08:29:03 INFO - Cleaning up... 08:29:03 INFO - Return code: 0 08:29:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:03 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:03 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 08:29:03 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 08:29:03 INFO - Using env: {'DISPLAY': ':0', 08:29:03 INFO - 'HOME': '/home/cltbld', 08:29:03 INFO - 'LANG': 'en_US.UTF-8', 08:29:03 INFO - 'LANGUAGE': 'en_US:en', 08:29:03 INFO - 'LOGNAME': 'cltbld', 08:29:03 INFO - 'MAIL': '/var/mail/cltbld', 08:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:03 INFO - 'MOZ_NO_REMOTE': '1', 08:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:03 INFO - 'NO_EM_RESTART': '1', 08:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:03 INFO - 'PWD': '/builds/slave/test', 08:29:03 INFO - 'SHELL': '/bin/bash', 08:29:03 INFO - 'SHLVL': '1', 08:29:03 INFO - 'TERM': 'linux', 08:29:03 INFO - 'TMOUT': '86400', 08:29:03 INFO - 'USER': 'cltbld', 08:29:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:03 INFO - '_': '/tools/buildbot/bin/python'} 08:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:03 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 08:29:03 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 08:29:03 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 08:29:03 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 08:29:03 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 08:29:03 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 08:29:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:05 INFO - Installing collected packages: mozsystemmonitor 08:29:05 INFO - Running setup.py install for mozsystemmonitor 08:29:05 INFO - Successfully installed mozsystemmonitor 08:29:05 INFO - Cleaning up... 08:29:05 INFO - Return code: 0 08:29:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29:05 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')]} 08:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:05 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')]} 08:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:05 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:05 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 08:29:05 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 08:29:05 INFO - Using env: {'DISPLAY': ':0', 08:29:05 INFO - 'HOME': '/home/cltbld', 08:29:05 INFO - 'LANG': 'en_US.UTF-8', 08:29:05 INFO - 'LANGUAGE': 'en_US:en', 08:29:05 INFO - 'LOGNAME': 'cltbld', 08:29:05 INFO - 'MAIL': '/var/mail/cltbld', 08:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:05 INFO - 'MOZ_NO_REMOTE': '1', 08:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:05 INFO - 'NO_EM_RESTART': '1', 08:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:05 INFO - 'PWD': '/builds/slave/test', 08:29:05 INFO - 'SHELL': '/bin/bash', 08:29:05 INFO - 'SHLVL': '1', 08:29:05 INFO - 'TERM': 'linux', 08:29:05 INFO - 'TMOUT': '86400', 08:29:05 INFO - 'USER': 'cltbld', 08:29:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:05 INFO - '_': '/tools/buildbot/bin/python'} 08:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:05 INFO - Downloading/unpacking jsonschema==2.5.1 08:29:05 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 08:29:05 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 08:29:05 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 08:29:05 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 08:29:05 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 08:29:05 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 08:29:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:29:07 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 08:29:07 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 08:29:07 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 08:29:07 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 08:29:07 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 08:29:07 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 08:29:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:08 INFO - warning: no files found matching '*.txt' 08:29:08 INFO - no previously-included directories found matching 'build' 08:29:08 INFO - no previously-included directories found matching 'dist' 08:29:08 INFO - no previously-included directories found matching '.git*' 08:29:08 INFO - Installing collected packages: jsonschema, functools32 08:29:08 INFO - Running setup.py install for functools32 08:29:08 INFO - warning: no files found matching '*.txt' 08:29:08 INFO - no previously-included directories found matching 'build' 08:29:08 INFO - no previously-included directories found matching 'dist' 08:29:08 INFO - no previously-included directories found matching '.git*' 08:29:08 INFO - Successfully installed jsonschema functools32 08:29:08 INFO - Cleaning up... 08:29:08 INFO - Return code: 0 08:29:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:29:08 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')]} 08:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:08 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')]} 08:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:08 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:08 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 08:29:08 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 08:29:08 INFO - Using env: {'DISPLAY': ':0', 08:29:08 INFO - 'HOME': '/home/cltbld', 08:29:08 INFO - 'LANG': 'en_US.UTF-8', 08:29:08 INFO - 'LANGUAGE': 'en_US:en', 08:29:08 INFO - 'LOGNAME': 'cltbld', 08:29:08 INFO - 'MAIL': '/var/mail/cltbld', 08:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:08 INFO - 'MOZ_NO_REMOTE': '1', 08:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:08 INFO - 'NO_EM_RESTART': '1', 08:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:08 INFO - 'PWD': '/builds/slave/test', 08:29:08 INFO - 'SHELL': '/bin/bash', 08:29:08 INFO - 'SHLVL': '1', 08:29:08 INFO - 'TERM': 'linux', 08:29:08 INFO - 'TMOUT': '86400', 08:29:08 INFO - 'USER': 'cltbld', 08:29:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:08 INFO - '_': '/tools/buildbot/bin/python'} 08:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:29:08 INFO - Cleaning up... 08:29:08 INFO - Return code: 0 08:29:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:08 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')]} 08:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:08 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')]} 08:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:08 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:08 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 08:29:08 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 08:29:08 INFO - Using env: {'DISPLAY': ':0', 08:29:08 INFO - 'HOME': '/home/cltbld', 08:29:08 INFO - 'LANG': 'en_US.UTF-8', 08:29:08 INFO - 'LANGUAGE': 'en_US:en', 08:29:08 INFO - 'LOGNAME': 'cltbld', 08:29:08 INFO - 'MAIL': '/var/mail/cltbld', 08:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:08 INFO - 'MOZ_NO_REMOTE': '1', 08:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:08 INFO - 'NO_EM_RESTART': '1', 08:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:08 INFO - 'PWD': '/builds/slave/test', 08:29:08 INFO - 'SHELL': '/bin/bash', 08:29:08 INFO - 'SHLVL': '1', 08:29:08 INFO - 'TERM': 'linux', 08:29:08 INFO - 'TMOUT': '86400', 08:29:08 INFO - 'USER': 'cltbld', 08:29:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:08 INFO - '_': '/tools/buildbot/bin/python'} 08:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:08 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 08:29:08 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 08:29:08 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 08:29:08 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 08:29:08 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 08:29:08 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 08:29:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:10 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 08:29:10 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 08:29:10 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 08:29:10 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 08:29:10 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 08:29:10 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 08:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:29:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29:11 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 08:29:11 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 08:29:11 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 08:29:11 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 08:29:11 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 08:29:11 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 08:29:11 INFO - Downloading docopt-0.6.1.tar.gz 08:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:11 INFO - Running setup.py install for blobuploader 08:29:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:11 INFO - Running setup.py install for requests 08:29:11 INFO - Running setup.py install for docopt 08:29:12 INFO - Successfully installed blobuploader requests docopt 08:29:12 INFO - Cleaning up... 08:29:12 INFO - Return code: 0 08:29:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:12 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')]} 08:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:12 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')]} 08:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:12 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:12 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 08:29:12 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 08:29:12 INFO - Using env: {'DISPLAY': ':0', 08:29:12 INFO - 'HOME': '/home/cltbld', 08:29:12 INFO - 'LANG': 'en_US.UTF-8', 08:29:12 INFO - 'LANGUAGE': 'en_US:en', 08:29:12 INFO - 'LOGNAME': 'cltbld', 08:29:12 INFO - 'MAIL': '/var/mail/cltbld', 08:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:12 INFO - 'MOZ_NO_REMOTE': '1', 08:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:12 INFO - 'NO_EM_RESTART': '1', 08:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:12 INFO - 'PWD': '/builds/slave/test', 08:29:12 INFO - 'SHELL': '/bin/bash', 08:29:12 INFO - 'SHLVL': '1', 08:29:12 INFO - 'TERM': 'linux', 08:29:12 INFO - 'TMOUT': '86400', 08:29:12 INFO - 'USER': 'cltbld', 08:29:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:12 INFO - '_': '/tools/buildbot/bin/python'} 08:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:12 INFO - Running setup.py (path:/tmp/pip-vq1acx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:12 INFO - Running setup.py (path:/tmp/pip-zTMZvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:12 INFO - Running setup.py (path:/tmp/pip-E_JD2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:12 INFO - Running setup.py (path:/tmp/pip-zYhtES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:12 INFO - Running setup.py (path:/tmp/pip-CS6BTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:12 INFO - Running setup.py (path:/tmp/pip-NBdZKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:12 INFO - Running setup.py (path:/tmp/pip-cmxUKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:12 INFO - Running setup.py (path:/tmp/pip-Qj9YEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:12 INFO - Running setup.py (path:/tmp/pip-TTw14D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:12 INFO - Running setup.py (path:/tmp/pip-fB5tvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:13 INFO - Running setup.py (path:/tmp/pip-8IIK5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:13 INFO - Running setup.py (path:/tmp/pip-pyDoHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:13 INFO - Running setup.py (path:/tmp/pip-9oerWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:13 INFO - Running setup.py (path:/tmp/pip-BfaIYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:13 INFO - Running setup.py (path:/tmp/pip-X2hcpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:13 INFO - Running setup.py (path:/tmp/pip-rRjyIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:13 INFO - Running setup.py (path:/tmp/pip-xPTxRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:13 INFO - Running setup.py install for manifestparser 08:29:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:13 INFO - Running setup.py install for mozcrash 08:29:13 INFO - Running setup.py install for mozdebug 08:29:13 INFO - Running setup.py install for mozdevice 08:29:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:29:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:13 INFO - Running setup.py install for mozfile 08:29:14 INFO - Running setup.py install for mozhttpd 08:29:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Running setup.py install for mozinfo 08:29:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Running setup.py install for mozInstall 08:29:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Running setup.py install for mozleak 08:29:14 INFO - Running setup.py install for mozlog 08:29:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Running setup.py install for moznetwork 08:29:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Running setup.py install for mozprocess 08:29:14 INFO - Running setup.py install for mozprofile 08:29:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:14 INFO - Running setup.py install for mozrunner 08:29:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:15 INFO - Running setup.py install for mozscreenshot 08:29:15 INFO - Running setup.py install for moztest 08:29:15 INFO - Running setup.py install for mozversion 08:29:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:15 INFO - Cleaning up... 08:29:15 INFO - Return code: 0 08:29:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:15 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')]} 08:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:15 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')]} 08:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:15 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:15 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 08:29:15 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 08:29:15 INFO - Using env: {'DISPLAY': ':0', 08:29:15 INFO - 'HOME': '/home/cltbld', 08:29:15 INFO - 'LANG': 'en_US.UTF-8', 08:29:15 INFO - 'LANGUAGE': 'en_US:en', 08:29:15 INFO - 'LOGNAME': 'cltbld', 08:29:15 INFO - 'MAIL': '/var/mail/cltbld', 08:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:15 INFO - 'MOZ_NO_REMOTE': '1', 08:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:15 INFO - 'NO_EM_RESTART': '1', 08:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:15 INFO - 'PWD': '/builds/slave/test', 08:29:15 INFO - 'SHELL': '/bin/bash', 08:29:15 INFO - 'SHLVL': '1', 08:29:15 INFO - 'TERM': 'linux', 08:29:15 INFO - 'TMOUT': '86400', 08:29:15 INFO - 'USER': 'cltbld', 08:29:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:15 INFO - '_': '/tools/buildbot/bin/python'} 08:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:15 INFO - Running setup.py (path:/tmp/pip-Mwrvy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:15 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)) 08:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:15 INFO - Running setup.py (path:/tmp/pip-TM6omF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:15 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)) 08:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:15 INFO - Running setup.py (path:/tmp/pip-Xfvmy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:15 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)) 08:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:15 INFO - Running setup.py (path:/tmp/pip-MHNmG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:15 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)) 08:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:15 INFO - Running setup.py (path:/tmp/pip-VXWhI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:15 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)) 08:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:15 INFO - Running setup.py (path:/tmp/pip-bWMzsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:16 INFO - Running setup.py (path:/tmp/pip-NImHJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:16 INFO - Running setup.py (path:/tmp/pip-pSFxmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:16 INFO - Running setup.py (path:/tmp/pip-9wyCRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:16 INFO - Running setup.py (path:/tmp/pip-KUCqFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:16 INFO - Running setup.py (path:/tmp/pip-HPS6V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:16 INFO - Running setup.py (path:/tmp/pip-FUbaui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:16 INFO - Running setup.py (path:/tmp/pip-LrGeHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:16 INFO - Running setup.py (path:/tmp/pip-GQvp9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:16 INFO - Running setup.py (path:/tmp/pip-oPwQgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:16 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)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:16 INFO - Running setup.py (path:/tmp/pip-fukhZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:16 INFO - Running setup.py (path:/tmp/pip-tpjrIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:16 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 08:29:16 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 08:29:16 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 08:29:16 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 08:29:16 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 08:29:16 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 08:29:18 INFO - Downloading blessings-1.6.tar.gz 08:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:18 INFO - Installing collected packages: blessings 08:29:18 INFO - Running setup.py install for blessings 08:29:19 INFO - Successfully installed blessings 08:29:19 INFO - Cleaning up... 08:29:19 INFO - Return code: 0 08:29:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:19 INFO - Reading from file tmpfile_stdout 08:29:19 INFO - Current package versions: 08:29:19 INFO - argparse == 1.2.1 08:29:19 INFO - blessings == 1.6 08:29:19 INFO - blobuploader == 1.2.4 08:29:19 INFO - docopt == 0.6.1 08:29:19 INFO - functools32 == 3.2.3-2 08:29:19 INFO - jsonschema == 2.5.1 08:29:19 INFO - manifestparser == 1.1 08:29:19 INFO - mozInstall == 1.12 08:29:19 INFO - mozcrash == 1.0 08:29:19 INFO - mozdebug == 0.1 08:29:19 INFO - mozdevice == 0.49 08:29:19 INFO - mozfile == 1.2 08:29:19 INFO - mozhttpd == 0.7 08:29:19 INFO - mozinfo == 0.9 08:29:19 INFO - mozleak == 0.1 08:29:19 INFO - mozlog == 3.4 08:29:19 INFO - moznetwork == 0.27 08:29:19 INFO - mozprocess == 0.23 08:29:19 INFO - mozprofile == 0.28 08:29:19 INFO - mozrunner == 6.13 08:29:19 INFO - mozscreenshot == 0.1 08:29:19 INFO - mozsystemmonitor == 0.3 08:29:19 INFO - moztest == 0.7 08:29:19 INFO - mozversion == 1.4 08:29:19 INFO - psutil == 3.1.1 08:29:19 INFO - requests == 1.2.3 08:29:19 INFO - wsgiref == 0.1.2 08:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:19 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')]} 08:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:19 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')]} 08:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:19 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:19 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 08:29:19 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 08:29:19 INFO - Using env: {'DISPLAY': ':0', 08:29:19 INFO - 'HOME': '/home/cltbld', 08:29:19 INFO - 'LANG': 'en_US.UTF-8', 08:29:19 INFO - 'LANGUAGE': 'en_US:en', 08:29:19 INFO - 'LOGNAME': 'cltbld', 08:29:19 INFO - 'MAIL': '/var/mail/cltbld', 08:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:19 INFO - 'MOZ_NO_REMOTE': '1', 08:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:19 INFO - 'NO_EM_RESTART': '1', 08:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:19 INFO - 'PWD': '/builds/slave/test', 08:29:19 INFO - 'SHELL': '/bin/bash', 08:29:19 INFO - 'SHLVL': '1', 08:29:19 INFO - 'TERM': 'linux', 08:29:19 INFO - 'TMOUT': '86400', 08:29:19 INFO - 'USER': 'cltbld', 08:29:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:19 INFO - '_': '/tools/buildbot/bin/python'} 08:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 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)) 08:29:19 INFO - Cleaning up... 08:29:19 INFO - Return code: 0 08:29:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:19 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')]} 08:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:19 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')]} 08:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:19 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 0x7f63aba27e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2895a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', '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 08:29:19 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 08:29:19 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 08:29:19 INFO - Using env: {'DISPLAY': ':0', 08:29:19 INFO - 'HOME': '/home/cltbld', 08:29:19 INFO - 'LANG': 'en_US.UTF-8', 08:29:19 INFO - 'LANGUAGE': 'en_US:en', 08:29:19 INFO - 'LOGNAME': 'cltbld', 08:29:19 INFO - 'MAIL': '/var/mail/cltbld', 08:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:19 INFO - 'MOZ_NO_REMOTE': '1', 08:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:19 INFO - 'NO_EM_RESTART': '1', 08:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:19 INFO - 'PWD': '/builds/slave/test', 08:29:19 INFO - 'SHELL': '/bin/bash', 08:29:19 INFO - 'SHLVL': '1', 08:29:19 INFO - 'TERM': 'linux', 08:29:19 INFO - 'TMOUT': '86400', 08:29:19 INFO - 'USER': 'cltbld', 08:29:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:19 INFO - '_': '/tools/buildbot/bin/python'} 08:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:19 INFO - Cleaning up... 08:29:19 INFO - Return code: 0 08:29:19 INFO - Running post-action listener: _resource_record_post_action 08:29:19 INFO - Running post-action listener: _start_resource_monitoring 08:29:19 INFO - Starting resource monitoring. 08:29:19 INFO - [mozharness: 2016-12-13 16:29:19.789963Z] Finished create-virtualenv step (success) 08:29:19 INFO - [mozharness: 2016-12-13 16:29:19.790482Z] Running install step. 08:29:19 INFO - Running pre-action listener: _resource_record_pre_action 08:29:19 INFO - Running main action method: install 08:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:19 INFO - Reading from file tmpfile_stdout 08:29:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:20 INFO - Reading from file tmpfile_stdout 08:29:20 INFO - Output received: 08:29:20 INFO - Usage: mozinstall [options] installer 08:29:20 INFO - Options: 08:29:20 INFO - -h, --help show this help message and exit 08:29:20 INFO - -d DEST, --destination=DEST 08:29:20 INFO - Directory to install application into. [default: 08:29:20 INFO - "/builds/slave/test"] 08:29:20 INFO - --app=APP Application being installed. [default: firefox] 08:29:20 INFO - mkdir: /builds/slave/test/build/application 08:29:20 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'] 08:29:20 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 08:29:37 INFO - Reading from file tmpfile_stdout 08:29:37 INFO - Output received: 08:29:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:37 INFO - Running post-action listener: _resource_record_post_action 08:29:37 INFO - [mozharness: 2016-12-13 16:29:37.082653Z] Finished install step (success) 08:29:37 INFO - [mozharness: 2016-12-13 16:29:37.082922Z] Running run-tests step. 08:29:37 INFO - Running pre-action listener: _resource_record_pre_action 08:29:37 INFO - Running main action method: run_tests 08:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:37 INFO - Python 2.7.3 08:29:37 INFO - Return code: 0 08:29:37 INFO - grabbing minidump binary from tooltool 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 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 0x2ac3f20>, '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 0x2a30c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a30f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:37 INFO - Return code: 0 08:29:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:37 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/1481639716/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:29:37 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/1481639716/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 08:29:37 INFO - Using env: {'DISPLAY': ':0', 08:29:37 INFO - 'HOME': '/home/cltbld', 08:29:37 INFO - 'LANG': 'en_US.UTF-8', 08:29:37 INFO - 'LANGUAGE': 'en_US:en', 08:29:37 INFO - 'LOGNAME': 'cltbld', 08:29:37 INFO - 'MAIL': '/var/mail/cltbld', 08:29:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:37 INFO - 'MOZ_NO_REMOTE': '1', 08:29:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:37 INFO - 'NO_EM_RESTART': '1', 08:29:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:37 INFO - 'PWD': '/builds/slave/test', 08:29:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:37 INFO - 'SHELL': '/bin/bash', 08:29:37 INFO - 'SHLVL': '1', 08:29:37 INFO - 'TERM': 'linux', 08:29:37 INFO - 'TMOUT': '86400', 08:29:37 INFO - 'USER': 'cltbld', 08:29:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251', 08:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:37 INFO - '_': '/tools/buildbot/bin/python'} 08:29:37 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/1481639716/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 08:29:37 INFO - mozversion application_buildid: 20161213063516 08:29:37 INFO - mozversion application_changeset: 620f6fd4477004d81ee133fcd8dfb24ab1009512 08:29:37 INFO - mozversion application_display_name: Nightly 08:29:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:37 INFO - mozversion application_name: Firefox 08:29:37 INFO - mozversion application_remotingname: firefox 08:29:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:29:37 INFO - mozversion application_vendor: Mozilla 08:29:37 INFO - mozversion application_version: 53.0a1 08:29:37 INFO - mozversion platform_buildid: 20161213063516 08:29:37 INFO - mozversion platform_changeset: 620f6fd4477004d81ee133fcd8dfb24ab1009512 08:29:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:29:37 INFO - mozversion platform_version: 53.0a1 08:29:37 INFO - using testdate: 1481646577 08:29:37 INFO - actual date: 1481646577 08:29:37 INFO - starting webserver on 'localhost:41099' 08:29:37 INFO - SUITE-START | Running 2 tests 08:29:37 INFO - TEST-START | dromaeo_css 08:29:37 INFO - operating with platform_type : linux_ 08:29:37 INFO - Initialising browser for dromaeo_css test... 08:29:37 INFO - TEST-INFO | started process 13472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAHo985/profile http://localhost:41099/getInfo.html) 08:29:41 INFO - PROCESS | 13472 | __metrics Screen width/height:1600/1200 08:29:41 INFO - PROCESS | 13472 | colorDepth:24 08:29:41 INFO - PROCESS | 13472 | Browser inner width/height: 1024/697 08:29:41 INFO - PROCESS | 13472 | __metrics 08:29:41 INFO - PROCESS | 13472 | 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" 08:29:41 INFO - PROCESS | 13472 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:43 INFO - TEST-INFO | 13472: exit 0 08:29:43 INFO - Browser initialized. 08:29:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:43 INFO - TEST-INFO | started process 13557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAHo985/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:55 INFO - PROCESS | 13557 | RSS: Main: 172175360 08:29:55 INFO - PROCESS | 13557 | 08:30:47 INFO - PROCESS | 13557 | 1481646647001 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:32:57 INFO - PROCESS | 13557 | Cycle 1(1): loaded http://localhost:41099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41099/tests/dromaeo/cssquery-ext.html) 08:32:59 INFO - PROCESS | 13557 | RSS: Main: 318271488 08:32:59 INFO - PROCESS | 13557 | 08:36:01 INFO - PROCESS | 13557 | Cycle 1(1): loaded http://localhost:41099/tests/dromaeo/cssquery-ext.html (next: http://localhost:41099/tests/dromaeo/cssquery-jquery.html) 08:36:02 INFO - PROCESS | 13557 | RSS: Main: 277864448 08:36:02 INFO - PROCESS | 13557 | 08:39:04 INFO - PROCESS | 13557 | Cycle 1(1): loaded http://localhost:41099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41099/tests/dromaeo/cssquery-mootools.html) 08:39:04 INFO - PROCESS | 13557 | RSS: Main: 259899392 08:39:04 INFO - PROCESS | 13557 | 08:42:06 INFO - PROCESS | 13557 | Cycle 1(1): loaded http://localhost:41099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41099/tests/dromaeo/cssquery-prototype.html) 08:42:07 INFO - PROCESS | 13557 | RSS: Main: 219656192 08:42:07 INFO - PROCESS | 13557 | 08:45:10 INFO - PROCESS | 13557 | Cycle 1(1): loaded http://localhost:41099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41099/tests/dromaeo/cssquery-yui.html) 08:45:10 INFO - PROCESS | 13557 | RSS: Main: 221929472 08:45:10 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | Cycle 1(1): loaded http://localhost:41099/tests/dromaeo/cssquery-yui.html (next: http://localhost:41099/tests/dromaeo/cssquery-dojo.html) 08:48:13 INFO - PROCESS | 13557 | RSS: Main: 317804544 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | __start_tp_report 08:48:13 INFO - PROCESS | 13557 | _x_x_mozilla_page_load 08:48:13 INFO - PROCESS | 13557 | _x_x_mozilla_page_load_details 08:48:13 INFO - PROCESS | 13557 | |i|pagename|runs| 08:48:13 INFO - PROCESS | 13557 | |0;dojo.html;3211.437998350289;3252.3983063133323;3261.7716759826812;3275.5741753572033;3302.818344991026;5152.330197074384;5213.3743950725875;5269.841904742859;5349.732513374331;5358.303420555328;5261.684298942057;5280.551153151987;5300.734963251842;5316.0962636351815;5405.972970135143;4803.303520989454;4854.223324268118;4868.0750657375165;4873.366462359906;4881.389826271716;4855.174620314555;4877.512248775111;4921.114199444099;4929.11275970327;5039.496050394968;4952.05910876934;4979.526944940243;4980.576650984653;5010.674306170087;5025.572826309768;4759.428868535798;4763.404574428197;4791.496892826238;4804.663673542854;4902.534259245366;4810.687305325143;4814.807407703687;4816.940273139903;4836.322914791932;4898.632602554787;5271.367435907678;5285.07511185541;5295.973520132375;5319;5391.973040134813;5492.752826122834;5673.23411339468;5681.545476361881;5696.572757043238;5700.942990570083;5576.386597474275;5684.261046064026;5743.310802703702;5751.166080918243;5825.242718446617;5350.946490535122;5357.651752636066;5361.81233656824;5373.382061062989;5379.246905433242;5826.446487583673;5828.6502809831545;5832.037713777264;5833.154192642128;5841.503472204825;5408.486193811582;5426.457354264542;5469.781208751605;5567.387587365387;5696.857578560486;5620.325560932714;5661.462161094772;5694.202811606378;5707.6290041147195;5729.083346664514;5672.602917795714;5675.120356344691;5676.318841739017;5676.659400435987;5677.261955945701;5522.282103326542;5523.447655234444;5579.079451890474;5644.604877658607;5720.48515633595;4369.300911854088;4373.518912919576;4375.5405682403525;4376.496702879146;4378.759168245713;3993;3994.2211268802885;3999.1002024544828;3999.6200360965663;4001.779902105354;5346.064438723208;5350.759215835296;5355.196720491879;5355.785768569213;5355.919661205085;5640.379558248589;5678.602497825113;5691;5695.686737229492;5698.344690360662;5331.040412725747;5345.278387417648;5346.679199248058;5348.064088784447;5350.946490535122;4865.148598995162;4884.3161957326;4886.315915771795;4926.852194434173;4926.926096108561;5908.763649454059;5928.318243401977;5929.9110513341475;5932.555058370639;5935.673537955454;5534.446555344433;5575.77696892136;5773.1051686988585;5779.479846813807;5784.479396854304;5776.884462310814;5777.104548794943;5794.420557944172;5823.941760582509;5905.645661260338;5611.466910643482;5617.578681598815;5658.094704847204;5662.292213473316;5663.631863928831;5613;5673.659580425187;5682.857928551819;5694.17434471991;5715.771369145187;5294.708791016531;5328.973355133199;5563.721813909369;5573.247611572386;5577.27495425592;5470.5350045245;5503.614746967834;5530;5566.415526369835;5631.971840140773;5530.585206109638;5552.056150454352;5552.194931734956;5554.083576210041;5555.333359996826;5427.674339539482;5596.636218645775;5599.860003499945;5606.131049687305;5614.157876318585;5333.839984800462;5408.5673146149;5410.21551874968;5413.296271484682;5417.241586178017 08:48:13 INFO - PROCESS | 13557 | |1;ext.html;531.3437904188328;557.9609427340085;569.1320735877788;569.2258528401373;583.6293953339629;32441.83779081104;33064.66935330646;33107.834460827726;33135.83432082839;33169.83415082924;32953.17617059575;40833.387499187535;41626.79186604063;41802.372964405484;46109.30836037462;8642.611082501287;8800.42797218182;8800.647974081028;8807.2513836324;8809;8597.269232115246;8682.696105636303;8687.478751274912;8697.434666746673;8733.650653973833;7934.365250779923;8115.837683246332;10181.389116653025;10402.427866467342;10435.947820260888;10245.231607629421;10297.382157070524;10301.381917084924;10303.27877048607;10305.227107966895;10081.243906707026;10146.311227524711;10146.441945692985;10147.64483243083;10155.187584993182;39509.60490395088;39679;39711.8014409929;39874.40188397176;39882.40176397356;3238;3339.3154403347257;3342.498625206214;3550.9644903550893;3626.2203626220225;26131.60802587963;27790;28045;28330.858345708344;29051.12846614605;4030.415589739501;4084.6323830855067;4087.3255912774357;4089.0799570096788;4149.792510374469;298202;298488;298677;299466;299534.50232748914;48349;48355.50489674106;48409.27386089211;48458;48566;50605.24092138621;50867;50921.490785092414;50930.85106382961;50965.49034509682;13104.2137471752;13767.31163441824;13769.242691651854;13777.173369597856;13780.65548361299;10271.640492582725;10295.536700848479;10309.74225644365;10314.432706201082;10314.742131446625;14339.283035848166;14662.340194691264;16119.113448760196;16283.755743663854;16324.224881770127;6193.256809182927;6267.4045965633195;6343.5876668016435;6431.517636177306;6628.038934354491;841.4152164245912;992.5682328187262;1028.1723212813608;1051.4742628685658;1067.1622776120707;30783.2304192397;31027.379452410827;31048.22379440532;31195.532067019012;31468.685313146576;996.9900300996898;1009.5961615353771;1012.8987101289812;1016.9135623472088;1029.8764148302103;16181.59546011359;16605.3357865684;16635.584110397336;16688.415905443253;16839.57901052459;450985;452876;453042;454095;456474;48099;49126;54586.72706636521;54850.45149548533;57113.42886571164;1234.6357824441811;1271.4532750917194;1272.0650322013312;1273.8980881529455;1291.9547815826402;28312.71687283101;30046.69953300439;30895.69104309018;30958.69041309558;31341;47616.7619161902;48351.27473087836;48360.274595880386;48404.25531914877;48517.5148248513;417549;606989;617397;628106;629514;36229;36236;36431.453528196565;36613.63386366102;36681.44977825388;40723.17487520282;40992.59007409888;41177.38233926553;41214.79392603018;41711.58288417077;35121.64878351184;35374.46938295876;35548.466772998945;35585.46621800727;35746;35083.29833403369;35146.297074058886;35183.82408087943;35275.64724352724;35377.82311088428;34774.65225347714;34775.65224347724;35215;35413.114672132375;35617;30416.847915760278;31604.36791264208;32323;32330.676693232766;32752;24457.26628201157;24668.13661521838;24696.426534972863;26219.868900655376;26570.468590628465 08:48:13 INFO - PROCESS | 13557 | |2;jquery.html;344.8655024540431;372.296742403504;378.5400738103205;381.8682554518691;403.10309561226273;13966.511172108978;16974.236159372827;17734.556636084104;18892.338768143083;19083.71374429381;17950;18222.635547289046;18295.176717047732;18463.90768046158;18576.814231857676;5364.383095943977;5653.886922261552;5659.377468478464;5660.179274005287;5662.462066103713;4116.217918595472;4325.351197320411;5525.723713814314;5983.940160598382;6232.407921247474;6315.400036996478;6320.178376811008;6320.589161704497;6322.810315690536;6326.272478664943;6071.78748743794;6221.160143380654;6237.251529816405;6245.906311405332;6247.593906396115;5306.09796334624;5486.341639003305;5501.367342755594;5506.807261745819;5507.614466987313;21529.138834446603;21561.245356412608;21650.783492165192;21738;21850.453738656503;2175.086463685256;2220.555888822242;2226.0984301357976;2259.0624890670515;2354.7762962518705;13176.143550669176;13742.244176570284;14000.649983750385;14203;14545.418183272657;1834.5230240137528;1845.6954602490707;1905.3140869287045;1917.4822797844643;1930.054273406035;67711;68328.6583567084;68791.65604171947;78062.60968695176;79122.60438697769;9828.361156524803;10073.29486935922;10242.897571024343;10579.312344697724;10789.946050269855;14856.18290993984;14866.702665946621;14868.107913525007;14869.3643699193;14890.478833241;7150.96311034897;7358.668859901317;7366.189719130892;7506.699732010768;7585.62071896414;6871.965640171868;6919.550229235084;7111.715531378791;7129.180144283474;7131.857362852714;4260.616544511009;4359.14996575671;4383.167198232326;4473.865784026484;4491;1744.127936031984;1847.7782666079888;1878.806957581918;1989.0253775649828;2000.1299434745931;710.4032612605333;783.6904422752981;918.228687902152;946.6970569417858;949.2643201518878;16302.592435188977;17321.653566928842;18691.532711682317;18715.344962926232;19187.712184317246;892.5269607108243;940.1679513630486;941.9199368053655;954.4702690006974;972.6109556177586;10213.846792298122;10490.21323400748;10501.53937828986;10557.366558006544;10590.788184236426;388183;401109;401347;401893;402927;76500;77373;80137.19862801414;89934;90954.54522727344;955.7897262602216;964.9758756031156;997.2122023601419;1001.4241810958728;1003.0521157506087;15856.207189640241;16369.918150409649;16529.504114876574;16680.582985425463;16773.832261677228;31810.840945795124;38834.80582597069;39165.608343916196;39293.803530982164;40012.7999360013;54149;54348;55811.88420721208;56600;57735.422645774684;7818.6481608328895;7861.646225919733;7939.28546430824;7970;7999.080105787909;10159.492025398848;11879;12109.091818113853;12410.503579857066;12429.440675169459;10452.32059916103;10556.15550755953;10660.733481663021;10677.412742299248;10812.0458349683;10364.637237696645;10445.32105413176;10658.573657053632;10725.731856703645;10878.184136189659;10275.640352587623;10333.844992325272;10674.35953842772;11092.778144436905;11135.665930022113;7659.961700191463;8037.477563958324;8176.550289733884;8226.753197404087;8267.643721539333;10117.19062475015;10184.23618228621;10235.488225588542;10503.317284376797;10520.736981575521 08:48:13 INFO - PROCESS | 13557 | |3;mootools.html;1402.7755559110542;1418.4184484361415;1503.7744338349246;1687.3588036546112;1723.750056241845;7287.526310789795;7536.660850261737;7902.762917112489;8315.708950186738;8329.666813327467;7804.492707973992;8114.513129212251;8115.75652730419;8237.958810205955;8243;2180.8364372672036;2219.999999999992;2220.04538048639;2221.5112675211426;2224.92212772553;1936.1964784614368;1991.531989982353;2184.5958497677902;2193.1008286602496;2262.1969200933677;2150.6558950567915;2222.277759728087;2225.8887055647233;2228.6322756745117;2231.6764069209953;2132.115172203534;2140.6788981652876;2164.653655415126;2167.306461932182;2168.3169801512554;2216.711827462436;2219.6781466687403;2239.8432109752325;2241.652543855705;2241.730992280937;7838.059432868035;7962.522248665098;7963.800904977422;7973.481723687942;7979.760607181794;4956.132676781549;5097.337346145015;5147.510986456281;5154.123798954187;5157.30376399185;3080.3531258435755;3218.7585931055264;3222.871085156591;3288.128645908836;3289.654586268455;1039.5789705169418;1077.498962982217;1091.1489038549944;1125.1673761416494;1127.8364637127652;11113.944430277797;11120.332780033224;11155.888441115647;11179.4969226385;11187.216894817366;4277.657787377002;4486.080353527519;4566.337881007235;4572.291294849304;4591.265397536378;9629.903700963041;9635.807283854423;9640.662576809778;9640.662576809778;9644.662436814679;5091.159958606862;5096.719680417613;5097.745112744348;5136.383633963874;5147.948520514822;4551.362809206714;4687.648426368036;4696.976515117471;4726.196546587088;4772.7136371817805;3570.7143428525656;3635.836387362575;3654.086478380405;3682.4476328550395;3768.6419790119894;1158.0851127609094;1187.8871507206802;1249.6001279590625;1250.0811903251104;1266.1516783754905;839.5634270179472;868.0971789339017;910.4764760262875;938.394735395666;947.7583216279804;5574.470425309589;5651.463111004448;5675.404082571271;5824.301083869963;5891.941080589139;898.2364989758653;903.746950853762;905.2757793764962;919.0809190809191;937.5452905340904;3532.788032718045;3703;3723.1809002019513;3769.7361184716806;3801.0877389426337;9967.601295948225;10136.54385552652;10282.794344113076;10285.382877027403;10293.94853025745;10167.186625069977;10198.388096714221;10205.234607404474;10245.129164021142;10246.077852993267;7705.229477052362;7841.059072911401;7847.803804904923;7853.450258481851;7857.449978501564;5562.72186390687;5613.747381367766;5655.773769049192;5725.713714314351;5829.3296270927685;9160.587773550073;9214.907850921405;9288.396254243453;9314.115159059878;9316;9176.082391761038;9358.953205233931;9426.151646351862;9601.663941762004;9611.375260608318;6961.269066747918;7049.506534542533;7082.893756593552;7096.680649370687;7102.857942841218;7912.604369781603;7951.721689740832;7958.482698624571;7959.124496305518;7963.482373645695;6915.204751453647;7014.614196219053;7106.395956343768;7210.423166146591;7284.781456556312;7061.364477197077;7103.431725462054;7108.182559005781;7181.569105853666;7234.927650723425;6546.705398257185;6666.566673166229;6690.531662783753;6702;6723.193216814014;4946.307516947702;5018.247262910592;5074.441811400669;5102.056119617882;5103.030424219386;4917.385326834145;5071.188609822559;5082.390113186441;5137.922931155961;5180.896382072413 08:48:13 INFO - PROCESS | 13557 | |4;prototype.html;357.5316335600363;358.56792564959227;361.6058496239099;365.6398447529185;368.96863766579855;5214.608904332176;5237.816676416322;5261.394939581949;5263.894722105556;5276.498732620405;5198.45416231295;5209.791608335671;5211.791528338871;5214.895702085956;5224.693826543365;3529.92940141197;3910.7262491625524;3979.8607048753156;4077.857274995376;4096.67226621871;4060.4924384451942;4066.7356621819636;4091.3658382950543;4092.6521245694153;4093.1813637272517;4034.0752954108184;4056.127932494513;4057.8376864925367;4058.147788964306;4061.8172182251724;3905.668018218455;3997.700172487046;4020.4170395292517;4063.837446502166;4069.369247766601;3624.963750362489;3656.213914008474;3656.744027918047;3662.285854258421;3688.114852435423;5091.389033316026;5094.974525127351;5094.974525127388;5108.872278193037;5149.76826042829;4546.38623785788;4626.21354369758;4646.674732768707;4657.324687920266;4659.5573420525;5413.404525502192;5420.701861397661;5427.402985671573;5443;5449.3188351456065;3997.2818483431256;4005.419214213952;4019.0756126091164;4020.43713880057;4029.597040295947;5476.58925580583;5541.0580201365865;5577;5658.603897727161;5661.490465858093;4070.1452694934396;4089.1412803311637;4092.956296144464;4100.835966561304;4109.527404348479;4145.958540414617;4154.439150714615;4159.875203743893;4164.83340666376;4170.582941705866;4540.205464043779;4662.207424737802;4711.717296962193;4721.811127554928;4735.431748190239;5448.902172663553;5460.535854452337;5467.6719396836315;5471.534919531805;5476.342838859283;1388.187910072619;1390.8956828237922;1395.1768456610446;1399.4542128569865;1405.4659229492727;905.8100563985915;940.6425558287807;944.4239014201331;945.0909163489849;951.4861974533812;5039.513343563657;5041.420236672756;5047.394312682502;5054.49455054499;5055.848324550269;5367.812126575629;5390.407055223922;5392.91910621341;5393.460653934575;5438.04230477028;5000.549950504472;5033.7734801934;5111.258867464197;5130.4100028497205;5278.656887302313;2847.007095033485;2878.2516545698268;2879.92800179993;2902.3034471726633;2908.432855593139;5564.4991950724625;5575.163725441216;5612.186232996192;5635.971820140955;5656.8020119295625;5444;5530.336359636869;5687.374388817227;5740.368559458456;5743.310802703702;5526.861828454321;5632.746526406321;5640.971795140998;5740.741666624928;5772.451617096369;5563.944360556343;5591.608587398843;5614.88770224585;5617.466340697627;5617.943820561742;5445.210444485607;5484.055947542914;5532.336119665666;5566.888662226652;5567.610267281251;5714.542836572981;5725.227094342211;5735.283089613798;5744.420284421817;5745.3105627324985;3923.2545816295956;3955.426463162883;3956.7625942443547;3966.305896468049;3969.6030396960073;5358.812441564526;5599.188117722989;5610.943890561205;5633.38032816398;5650.773969041356;5471.398146203994;5486.451354864482;5511.889762204653;5529.502344788988;5536.2249285099315;5489.39616642177;5526.949879522877;5527.364353099445;5532.529734972572;5533.253010843485;5320.2817619620855;5452.91820622683;5525.336959564878;5535.8892822142525;5546.168074788814;5516.6969763582865;5517.200005999188;5576.9163462547285;5579;5585.664860108406;5223.5559977402345;5393.919091213714;5414.5668346532975;5419.539339156216;5432.266644003009 08:48:13 INFO - PROCESS | 13557 | |5;yui.html;642.8200103970888;745.7725393754903;778.45508144299;784.4979213303487;800.8998875140605;14013.789793153099;15506.379744810194;15538.611534711623;15556;15688.607784805386;15219.923900380483;15329.770053449207;15761.054336739804;15932.20338983052;16029.839701602981;772.1660606544932;795.4630624328584;795.4869109424418;796.9481983671072;797.0435477427111;647.9805605831832;660.9669516524178;760.9923900761005;783.5377127494777;788.1684822512248;834.2158371131147;836.3351135847016;836.4688422851502;836.5440834745078;837.0833936839151;828.4904783558129;829.7718127514921;830.0910502999207;830.8338332333558;830.9529992209799;506.283608693698;515.9896802063976;583.3146053387295;595.3094410483861;603.2610052685469;14972.925135374253;15084.24578771068;15103.54689359321;15109.39562417502;15129.394824207018;13017.28404937728;13337.466501339935;13565.45738170472;13661.453541858315;13707.862921370759;12579.245245285312;12712.809307860389;12934.547290844775;12983.87016129836;13146.934265328708;4365.3451982202605;4424.292113261895;4446.822127114911;4463.085067561175;4579;76677.849832252;77832.22167778306;78597.21402786013;79406.20593794045;80548.59725701335;10645.338665333667;10809.189310801721;10857.728556785985;11043.723906902393;11083.833742493869;20211.8989405052;20232.39302820918;20249;20339.983000849898;20429.897850510653;7665.846683066307;7929.643166057541;7969.960150199212;7998.160193179749;8185.79535511617;4255.404024034481;4544.886377840514;4588.357629931812;4697.295405689174;4721.079389519011;3253.6583658715967;3263.2494526259093;3295.2256219788333;3322.1030321812973;3364.8149351785396;548.9917651235155;558.020673717623;563.433749082178;563.5660541383112;576.075398984632;545.3101826189873;568.9943100569025;669.0299066353709;670.1355251725317;684.9965750171317;8732.78168045804;9002.774930626787;9036.915570131494;9272.324928304246;9338.393004454689;640.891258123449;643.5313659375968;649.8050584824533;654.5287393076977;682.9043933849265;4331.913361732748;4539.039403378292;4611.216093264086;4654.837080702227;4711.481737008926;77996.61001695068;79331.60334198408;79569;80922.5953870227;81560.18439815645;57529.71235143798;65701;65884;67395.73753448755;67977.32022679709;62998.68500657468;63769;65520.67239663771;66190;66434.33565664379;8782.253508451853;8972.327075469497;9128.269738421042;9152.313576481658;9330.766730831783;44016.77991610021;44467.77766111149;44528.332075018254;45111.36107986502;46561.30158047564;57322.7133864328;59208.40791592029;60904.69547652411;61658.38341616526;62829.68585157228;10470.21473389514;10690.572377104829;10793.19051071157;10810.67567972962;11061.889381106086;11887.821682674594;12062.879371206527;12283.447244873823;12745.10784245094;12756.553520626734;11689.707757305796;11810.586629467927;12035.879641203475;12455.813162802746;12532.248065116122;10931.125509959344;10955;11010.889891100986;11210.327380357205;11402.82895756581;10319.48402579883;10482;11042.558297668003;11106;11394.37330946806;9604.855927161238;9905.702828915144;10007.899921000697;10148.695539133838;10615.575376984834;9572.138507534077;9645.08371704687;9822.968588298127;9923.156531694887;9980.850287245843 08:48:13 INFO - PROCESS | 13557 | __end_tp_report 08:48:13 INFO - PROCESS | 13557 | __start_cc_report 08:48:13 INFO - PROCESS | 13557 | _x_x_mozilla_cycle_collect,1348 08:48:13 INFO - PROCESS | 13557 | __end_cc_report 08:48:13 INFO - PROCESS | 13557 | __startTimestamp1481647693902__endTimestamp 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | ------- Summary: start ------- 08:48:13 INFO - PROCESS | 13557 | Number of tests: 6 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | [#0] dojo.html Cycles:165 Average:5288.44 Median:5417.24 stddev:560.76 (10.4%) stddev-sans-first:538.29 08:48:13 INFO - PROCESS | 13557 | Values: 3211.4 3252.4 3261.8 3275.6 3302.8 5152.3 5213.4 5269.8 5349.7 5358.3 5261.7 5280.6 5300.7 5316.1 5406.0 4803.3 4854.2 4868.1 4873.4 4881.4 4855.2 4877.5 4921.1 4929.1 5039.5 4952.1 4979.5 4980.6 5010.7 5025.6 4759.4 4763.4 4791.5 4804.7 4902.5 4810.7 4814.8 4816.9 4836.3 4898.6 5271.4 5285.1 5296.0 5319.0 5392.0 5492.8 5673.2 5681.5 5696.6 5700.9 5576.4 5684.3 5743.3 5751.2 5825.2 5350.9 5357.7 5361.8 5373.4 5379.2 5826.4 5828.7 5832.0 5833.2 5841.5 5408.5 5426.5 5469.8 5567.4 5696.9 5620.3 5661.5 5694.2 5707.6 5729.1 5672.6 5675.1 5676.3 5676.7 5677.3 5522.3 5523.4 5579.1 5644.6 5720.5 4369.3 4373.5 4375.5 4376.5 4378.8 3993.0 3994.2 3999.1 3999.6 4001.8 5346.1 5350.8 5355.2 5355.8 5355.9 5640.4 5678.6 5691.0 5695.7 5698.3 5331.0 5345.3 5346.7 5348.1 5350.9 4865.1 4884.3 4886.3 4926.9 4926.9 5908.8 5928.3 5929.9 5932.6 5935.7 5534.4 5575.8 5773.1 5779.5 5784.5 5776.9 5777.1 5794.4 5823.9 5905.6 5611.5 5617.6 5658.1 5662.3 5663.6 5613.0 5673.7 5682.9 5694.2 5715.8 5294.7 5329.0 5563.7 5573.2 5577.3 5470.5 5503.6 5530.0 5566.4 5632.0 5530.6 5552.1 5552.2 5554.1 5555.3 5427.7 5596.6 5599.9 5606.1 5614.2 5333.8 5408.6 5410.2 5413.3 5417.2 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | [#1] ext.html Cycles:180 Average:58249.51 Median:35245.32 stddev:123111.50 (349.3%) stddev-sans-first:123380.59 08:48:13 INFO - PROCESS | 13557 | Values: 531.3 558.0 569.1 569.2 583.6 32441.8 33064.7 33107.8 33135.8 33169.8 32953.2 40833.4 41626.8 41802.4 46109.3 8642.6 8800.4 8800.6 8807.3 8809.0 8597.3 8682.7 8687.5 8697.4 8733.7 7934.4 8115.8 10181.4 10402.4 10435.9 10245.2 10297.4 10301.4 10303.3 10305.2 10081.2 10146.3 10146.4 10147.6 10155.2 39509.6 39679.0 39711.8 39874.4 39882.4 3238.0 3339.3 3342.5 3551.0 3626.2 26131.6 27790.0 28045.0 28330.9 29051.1 4030.4 4084.6 4087.3 4089.1 4149.8 298202.0 298488.0 298677.0 299466.0 299534.5 48349.0 48355.5 48409.3 48458.0 48566.0 50605.2 50867.0 50921.5 50930.9 50965.5 13104.2 13767.3 13769.2 13777.2 13780.7 10271.6 10295.5 10309.7 10314.4 10314.7 14339.3 14662.3 16119.1 16283.8 16324.2 6193.3 6267.4 6343.6 6431.5 6628.0 841.4 992.6 1028.2 1051.5 1067.2 30783.2 31027.4 31048.2 31195.5 31468.7 997.0 1009.6 1012.9 1016.9 1029.9 16181.6 16605.3 16635.6 16688.4 16839.6 450985.0 452876.0 453042.0 454095.0 456474.0 48099.0 49126.0 54586.7 54850.5 57113.4 1234.6 1271.5 1272.1 1273.9 1292.0 28312.7 30046.7 30895.7 30958.7 31341.0 47616.8 48351.3 48360.3 48404.3 48517.5 417549.0 606989.0 617397.0 628106.0 629514.0 36229.0 36236.0 36431.5 36613.6 36681.4 40723.2 40992.6 41177.4 41214.8 41711.6 35121.6 35374.5 35548.5 35585.5 35746.0 35083.3 35146.3 35183.8 35275.6 35377.8 34774.7 34775.7 35215.0 35413.1 35617.0 30416.8 31604.4 32323.0 32330.7 32752.0 24457.3 24668.1 24696.4 26219.9 26570.5 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | [#2] jquery.html Cycles:180 Average:25451.96 Median:194282.43 stddev:66028.78 (34.0%) stddev-sans-first:66187.10 08:48:13 INFO - PROCESS | 13557 | Values: 344.9 372.3 378.5 381.9 403.1 13966.5 16974.2 17734.6 18892.3 19083.7 17950.0 18222.6 18295.2 18463.9 18576.8 5364.4 5653.9 5659.4 5660.2 5662.5 4116.2 4325.4 5525.7 5983.9 6232.4 6315.4 6320.2 6320.6 6322.8 6326.3 6071.8 6221.2 6237.3 6245.9 6247.6 5306.1 5486.3 5501.4 5506.8 5507.6 21529.1 21561.2 21650.8 21738.0 21850.5 2175.1 2220.6 2226.1 2259.1 2354.8 13176.1 13742.2 14000.6 14203.0 14545.4 1834.5 1845.7 1905.3 1917.5 1930.1 67711.0 68328.7 68791.7 78062.6 79122.6 9828.4 10073.3 10242.9 10579.3 10789.9 14856.2 14866.7 14868.1 14869.4 14890.5 7151.0 7358.7 7366.2 7506.7 7585.6 6872.0 6919.6 7111.7 7129.2 7131.9 4260.6 4359.1 4383.2 4473.9 4491.0 1744.1 1847.8 1878.8 1989.0 2000.1 710.4 783.7 918.2 946.7 949.3 16302.6 17321.7 18691.5 18715.3 19187.7 892.5 940.2 941.9 954.5 972.6 10213.8 10490.2 10501.5 10557.4 10590.8 388183.0 401109.0 401347.0 401893.0 402927.0 76500.0 77373.0 80137.2 89934.0 90954.5 955.8 965.0 997.2 1001.4 1003.1 15856.2 16369.9 16529.5 16680.6 16773.8 31810.8 38834.8 39165.6 39293.8 40012.8 54149.0 54348.0 55811.9 56600.0 57735.4 7818.6 7861.6 7939.3 7970.0 7999.1 10159.5 11879.0 12109.1 12410.5 12429.4 10452.3 10556.2 10660.7 10677.4 10812.0 10364.6 10445.3 10658.6 10725.7 10878.2 10275.6 10333.8 10674.4 11092.8 11135.7 7660.0 8037.5 8176.6 8226.8 8267.6 10117.2 10184.2 10235.5 10503.3 10520.7 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | [#3] mootools.html Cycles:180 Average:5435.22 Median:5102.54 stddev:3020.90 (59.2%) stddev-sans-first:3014.17 08:48:13 INFO - PROCESS | 13557 | Values: 1402.8 1418.4 1503.8 1687.4 1723.8 7287.5 7536.7 7902.8 8315.7 8329.7 7804.5 8114.5 8115.8 8238.0 8243.0 2180.8 2220.0 2220.0 2221.5 2224.9 1936.2 1991.5 2184.6 2193.1 2262.2 2150.7 2222.3 2225.9 2228.6 2231.7 2132.1 2140.7 2164.7 2167.3 2168.3 2216.7 2219.7 2239.8 2241.7 2241.7 7838.1 7962.5 7963.8 7973.5 7979.8 4956.1 5097.3 5147.5 5154.1 5157.3 3080.4 3218.8 3222.9 3288.1 3289.7 1039.6 1077.5 1091.1 1125.2 1127.8 11113.9 11120.3 11155.9 11179.5 11187.2 4277.7 4486.1 4566.3 4572.3 4591.3 9629.9 9635.8 9640.7 9640.7 9644.7 5091.2 5096.7 5097.7 5136.4 5147.9 4551.4 4687.6 4697.0 4726.2 4772.7 3570.7 3635.8 3654.1 3682.4 3768.6 1158.1 1187.9 1249.6 1250.1 1266.2 839.6 868.1 910.5 938.4 947.8 5574.5 5651.5 5675.4 5824.3 5891.9 898.2 903.7 905.3 919.1 937.5 3532.8 3703.0 3723.2 3769.7 3801.1 9967.6 10136.5 10282.8 10285.4 10293.9 10167.2 10198.4 10205.2 10245.1 10246.1 7705.2 7841.1 7847.8 7853.5 7857.4 5562.7 5613.7 5655.8 5725.7 5829.3 9160.6 9214.9 9288.4 9314.1 9316.0 9176.1 9359.0 9426.2 9601.7 9611.4 6961.3 7049.5 7082.9 7096.7 7102.9 7912.6 7951.7 7958.5 7959.1 7963.5 6915.2 7014.6 7106.4 7210.4 7284.8 7061.4 7103.4 7108.2 7181.6 7234.9 6546.7 6666.6 6690.5 6702.0 6723.2 4946.3 5018.2 5074.4 5102.1 5103.0 4917.4 5071.2 5082.4 5137.9 5180.9 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | [#4] prototype.html Cycles:180 Average:4588.60 Median:5231.26 stddev:1336.85 (25.6%) stddev-sans-first:1302.33 08:48:13 INFO - PROCESS | 13557 | Values: 357.5 358.6 361.6 365.6 369.0 5214.6 5237.8 5261.4 5263.9 5276.5 5198.5 5209.8 5211.8 5214.9 5224.7 3529.9 3910.7 3979.9 4077.9 4096.7 4060.5 4066.7 4091.4 4092.7 4093.2 4034.1 4056.1 4057.8 4058.1 4061.8 3905.7 3997.7 4020.4 4063.8 4069.4 3625.0 3656.2 3656.7 3662.3 3688.1 5091.4 5095.0 5095.0 5108.9 5149.8 4546.4 4626.2 4646.7 4657.3 4659.6 5413.4 5420.7 5427.4 5443.0 5449.3 3997.3 4005.4 4019.1 4020.4 4029.6 5476.6 5541.1 5577.0 5658.6 5661.5 4070.1 4089.1 4093.0 4100.8 4109.5 4146.0 4154.4 4159.9 4164.8 4170.6 4540.2 4662.2 4711.7 4721.8 4735.4 5448.9 5460.5 5467.7 5471.5 5476.3 1388.2 1390.9 1395.2 1399.5 1405.5 905.8 940.6 944.4 945.1 951.5 5039.5 5041.4 5047.4 5054.5 5055.8 5367.8 5390.4 5392.9 5393.5 5438.0 5000.5 5033.8 5111.3 5130.4 5278.7 2847.0 2878.3 2879.9 2902.3 2908.4 5564.5 5575.2 5612.2 5636.0 5656.8 5444.0 5530.3 5687.4 5740.4 5743.3 5526.9 5632.7 5641.0 5740.7 5772.5 5563.9 5591.6 5614.9 5617.5 5617.9 5445.2 5484.1 5532.3 5566.9 5567.6 5714.5 5725.2 5735.3 5744.4 5745.3 3923.3 3955.4 3956.8 3966.3 3969.6 5358.8 5599.2 5610.9 5633.4 5650.8 5471.4 5486.5 5511.9 5529.5 5536.2 5489.4 5526.9 5527.4 5532.5 5533.3 5320.3 5452.9 5525.3 5535.9 5546.2 5516.7 5517.2 5576.9 5579.0 5585.7 5223.6 5393.9 5414.6 5419.5 5432.3 08:48:13 INFO - PROCESS | 13557 | 08:48:13 INFO - PROCESS | 13557 | [#5] yui.html Cycles:180 Average:17321.02 Median:547.15 stddev:22809.36 (4168.8%) stddev-sans-first:22838.96 08:48:13 INFO - PROCESS | 13557 | Values: 642.8 745.8 778.5 784.5 800.9 14013.8 15506.4 15538.6 15556.0 15688.6 15219.9 15329.8 15761.1 15932.2 16029.8 772.2 795.5 795.5 796.9 797.0 648.0 661.0 761.0 783.5 788.2 834.2 836.3 836.5 836.5 837.1 828.5 829.8 830.1 830.8 831.0 506.3 516.0 583.3 595.3 603.3 14972.9 15084.2 15103.5 15109.4 15129.4 13017.3 13337.5 13565.5 13661.5 13707.9 12579.2 12712.8 12934.5 12983.9 13146.9 4365.3 4424.3 4446.8 4463.1 4579.0 76677.8 77832.2 78597.2 79406.2 80548.6 10645.3 10809.2 10857.7 11043.7 11083.8 20211.9 20232.4 20249.0 20340.0 20429.9 7665.8 7929.6 7970.0 7998.2 8185.8 4255.4 4544.9 4588.4 4697.3 4721.1 3253.7 3263.2 3295.2 3322.1 3364.8 549.0 558.0 563.4 563.6 576.1 545.3 569.0 669.0 670.1 685.0 8732.8 9002.8 9036.9 9272.3 9338.4 640.9 643.5 649.8 654.5 682.9 4331.9 4539.0 4611.2 4654.8 4711.5 77996.6 79331.6 79569.0 80922.6 81560.2 57529.7 65701.0 65884.0 67395.7 67977.3 62998.7 63769.0 65520.7 66190.0 66434.3 8782.3 8972.3 9128.3 9152.3 9330.8 44016.8 44467.8 44528.3 45111.4 46561.3 57322.7 59208.4 60904.7 61658.4 62829.7 10470.2 10690.6 10793.2 10810.7 11061.9 11887.8 12062.9 12283.4 12745.1 12756.6 11689.7 11810.6 12035.9 12455.8 12532.2 10931.1 10955.0 11010.9 11210.3 11402.8 10319.5 10482.0 11042.6 11106.0 11394.4 9604.9 9905.7 10007.9 10148.7 10615.6 9572.1 9645.1 9823.0 9923.2 9980.9 08:48:13 INFO - PROCESS | 13557 | -------- Summary: end -------- 08:48:13 INFO - PROCESS | 13557 | 08:48:14 INFO - TEST-INFO | 13557: exit 0 08:48:14 INFO - TEST-OK | dromaeo_css | took 1117546ms 08:48:14 INFO - TEST-START | kraken 08:48:14 INFO - operating with platform_type : linux_ 08:48:14 INFO - Initialising browser for kraken test... 08:48:14 INFO - TEST-INFO | started process 13860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1TSba/profile http://localhost:41099/getInfo.html) 08:48:18 INFO - PROCESS | 13860 | __metrics Screen width/height:1600/1200 08:48:18 INFO - PROCESS | 13860 | colorDepth:24 08:48:18 INFO - PROCESS | 13860 | Browser inner width/height: 1024/697 08:48:18 INFO - PROCESS | 13860 | __metrics 08:48:19 INFO - PROCESS | 13860 | 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" 08:48:19 INFO - PROCESS | 13860 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:19 INFO - PROCESS | 13860 | console.error: PushService: 08:48:19 INFO - PROCESS | 13860 | stateChangeProcessEnqueue: Error transitioning state 08:48:19 INFO - PROCESS | 13860 | UnknownError 08:48:20 INFO - TEST-INFO | 13860: exit 0 08:48:20 INFO - Browser initialized. 08:48:20 INFO - Running cycle 1/1 for kraken test... 08:48:20 INFO - TEST-INFO | started process 13943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1TSba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:32 INFO - PROCESS | 13943 | RSS: Main: 172187648 08:48:32 INFO - PROCESS | 13943 | 08:48:35 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41099/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:36 INFO - PROCESS | 13943 | RSS: Main: 230363136 08:48:36 INFO - PROCESS | 13943 | 08:48:38 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41099/tests/kraken/driver.html?testName=audio-dft) 08:48:39 INFO - PROCESS | 13943 | RSS: Main: 216379392 08:48:39 INFO - PROCESS | 13943 | 08:48:42 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41099/tests/kraken/driver.html?testName=audio-fft) 08:48:43 INFO - PROCESS | 13943 | RSS: Main: 298622976 08:48:43 INFO - PROCESS | 13943 | 08:48:45 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41099/tests/kraken/driver.html?testName=audio-oscillator) 08:48:45 INFO - PROCESS | 13943 | RSS: Main: 208752640 08:48:45 INFO - PROCESS | 13943 | 08:48:47 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:48 INFO - PROCESS | 13943 | RSS: Main: 214614016 08:48:48 INFO - PROCESS | 13943 | 08:48:51 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41099/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:52 INFO - PROCESS | 13943 | RSS: Main: 253153280 08:48:52 INFO - PROCESS | 13943 | 08:48:55 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41099/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:56 INFO - PROCESS | 13943 | RSS: Main: 252600320 08:48:56 INFO - PROCESS | 13943 | 08:48:58 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41099/tests/kraken/driver.html?testName=json-parse-financial) 08:48:59 INFO - PROCESS | 13943 | RSS: Main: 251465728 08:48:59 INFO - PROCESS | 13943 | 08:49:01 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:01 INFO - PROCESS | 13943 | RSS: Main: 213860352 08:49:01 INFO - PROCESS | 13943 | 08:49:03 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:04 INFO - PROCESS | 13943 | RSS: Main: 220512256 08:49:04 INFO - PROCESS | 13943 | 08:49:06 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:06 INFO - PROCESS | 13943 | RSS: Main: 229941248 08:49:06 INFO - PROCESS | 13943 | 08:49:09 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:10 INFO - PROCESS | 13943 | RSS: Main: 239136768 08:49:10 INFO - PROCESS | 13943 | 08:49:12 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:13 INFO - PROCESS | 13943 | RSS: Main: 235679744 08:49:13 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | Cycle 1(1): loaded http://localhost:41099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41099/tests/kraken/driver.html?testName=ai-astar) 08:49:15 INFO - PROCESS | 13943 | RSS: Main: 286830592 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | __start_tp_report 08:49:15 INFO - PROCESS | 13943 | _x_x_mozilla_page_load 08:49:15 INFO - PROCESS | 13943 | _x_x_mozilla_page_load_details 08:49:15 INFO - PROCESS | 13943 | |i|pagename|runs| 08:49:15 INFO - PROCESS | 13943 | |0;ai-astar;110;112;112;111;113;113;111;112;113;114 08:49:15 INFO - PROCESS | 13943 | |1;audio-beat-detection;155;126;129;174;124;125;123;128;145;133 08:49:15 INFO - PROCESS | 13943 | |2;audio-dft;162;161;163;160;162;161;163;162;164;161 08:49:15 INFO - PROCESS | 13943 | |3;audio-fft;75;78;84;107;76;76;75;76;91;75 08:49:15 INFO - PROCESS | 13943 | |4;audio-oscillator;85;84;109;83;83;84;95;85;84;106 08:49:15 INFO - PROCESS | 13943 | |5;imaging-gaussian-blur;127;128;127;128;127;127;127;129;127;126 08:49:15 INFO - PROCESS | 13943 | |6;imaging-darkroom;146;146;146;146;146;147;145;145;146;146 08:49:15 INFO - PROCESS | 13943 | |7;imaging-desaturate;96;97;97;97;97;97;96;96;97;97 08:49:15 INFO - PROCESS | 13943 | |8;json-parse-financial;53;51;53;51;53;53;53;53;53;52 08:49:15 INFO - PROCESS | 13943 | |9;json-stringify-tinderbox;64;65;63;64;65;64;65;66;65;65 08:49:15 INFO - PROCESS | 13943 | |10;stanford-crypto-aes;81;83;87;81;81;83;80;90;83;88 08:49:15 INFO - PROCESS | 13943 | |11;stanford-crypto-ccm;133;133;132;133;131;155;131;143;180;153 08:49:15 INFO - PROCESS | 13943 | |12;stanford-crypto-pbkdf2;175;168;166;167;167;167;170;166;167;166 08:49:15 INFO - PROCESS | 13943 | |13;stanford-crypto-sha256-iterative;65;64;64;66;65;65;71;64;63;63 08:49:15 INFO - PROCESS | 13943 | __end_tp_report 08:49:15 INFO - PROCESS | 13943 | __start_cc_report 08:49:15 INFO - PROCESS | 13943 | _x_x_mozilla_cycle_collect,1659 08:49:15 INFO - PROCESS | 13943 | __end_cc_report 08:49:15 INFO - PROCESS | 13943 | __startTimestamp1481647755467__endTimestamp 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | ------- Summary: start ------- 08:49:15 INFO - PROCESS | 13943 | Number of tests: 14 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.20 (1.1%) stddev-sans-first:1.00 08:49:15 INFO - PROCESS | 13943 | Values: 110.0 112.0 112.0 111.0 113.0 113.0 111.0 112.0 113.0 114.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:131.00 stddev:16.80 (12.8%) stddev-sans-first:16.39 08:49:15 INFO - PROCESS | 13943 | Values: 155.0 126.0 129.0 174.0 124.0 125.0 123.0 128.0 145.0 133.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 08:49:15 INFO - PROCESS | 13943 | Values: 162.0 161.0 163.0 160.0 162.0 161.0 163.0 162.0 164.0 161.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:10.41 (13.7%) stddev-sans-first:10.79 08:49:15 INFO - PROCESS | 13943 | Values: 75.0 78.0 84.0 107.0 76.0 76.0 75.0 76.0 91.0 75.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:84.00 stddev:9.99 (11.9%) stddev-sans-first:10.44 08:49:15 INFO - PROCESS | 13943 | Values: 85.0 84.0 109.0 83.0 83.0 84.0 95.0 85.0 84.0 106.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#5] imaging-gaussian-blur Cycles:10 Average:127.30 Median:127.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:49:15 INFO - PROCESS | 13943 | Values: 127.0 128.0 127.0 128.0 127.0 127.0 127.0 129.0 127.0 126.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:49:15 INFO - PROCESS | 13943 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 145.0 145.0 146.0 146.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:49:15 INFO - PROCESS | 13943 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 08:49:15 INFO - PROCESS | 13943 | Values: 53.0 51.0 53.0 51.0 53.0 53.0 53.0 53.0 53.0 52.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 08:49:15 INFO - PROCESS | 13943 | Values: 64.0 65.0 63.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.43 (4.1%) stddev-sans-first:3.50 08:49:15 INFO - PROCESS | 13943 | Values: 81.0 83.0 87.0 81.0 81.0 83.0 80.0 90.0 83.0 88.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:138.00 stddev:16.05 (11.6%) stddev-sans-first:16.66 08:49:15 INFO - PROCESS | 13943 | Values: 133.0 133.0 132.0 133.0 131.0 155.0 131.0 143.0 180.0 153.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.00 stddev:2.77 (1.7%) stddev-sans-first:1.27 08:49:15 INFO - PROCESS | 13943 | Values: 175.0 168.0 166.0 167.0 167.0 167.0 170.0 166.0 167.0 166.0 08:49:15 INFO - PROCESS | 13943 | 08:49:15 INFO - PROCESS | 13943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.31 (3.6%) stddev-sans-first:2.45 08:49:15 INFO - PROCESS | 13943 | Values: 65.0 64.0 64.0 66.0 65.0 65.0 71.0 64.0 63.0 63.0 08:49:15 INFO - PROCESS | 13943 | -------- Summary: end -------- 08:49:15 INFO - PROCESS | 13943 | 08:49:16 INFO - TEST-INFO | 13943: exit 0 08:49:16 INFO - TEST-OK | kraken | took 61811ms 08:49:16 INFO - SUITE-END | took 1179s 08:49:17 INFO - Completed test suite (00:19:39) 08:49:17 INFO - javascript benchmark 08:49:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.437998350289, 3252.3983063133323, 3261.7716759826812, 3275.5741753572033, 3302.818344991026, 5152.330197074384, 5213.3743950725875, 5269.841904742859, 5349.732513374331, 5358.303420555328, 5261.684298942057, 5280.551153151987, 5300.734963251842, 5316.0962636351815, 5405.972970135143, 4803.303520989454, 4854.223324268118, 4868.0750657375165, 4873.366462359906, 4881.389826271716, 4855.174620314555, 4877.512248775111, 4921.114199444099, 4929.11275970327, 5039.496050394968, 4952.05910876934, 4979.526944940243, 4980.576650984653, 5010.674306170087, 5025.572826309768, 4759.428868535798, 4763.404574428197, 4791.496892826238, 4804.663673542854, 4902.534259245366, 4810.687305325143, 4814.807407703687, 4816.940273139903, 4836.322914791932, 4898.632602554787, 5271.367435907678, 5285.07511185541, 5295.973520132375, 5319.0, 5391.973040134813, 5492.752826122834, 5673.23411339468, 5681.545476361881, 5696.572757043238, 5700.942990570083, 5576.386597474275, 5684.261046064026, 5743.310802703702, 5751.166080918243, 5825.242718446617, 5350.946490535122, 5357.651752636066, 5361.81233656824, 5373.382061062989, 5379.246905433242, 5826.446487583673, 5828.6502809831545, 5832.037713777264, 5833.154192642128, 5841.503472204825, 5408.486193811582, 5426.457354264542, 5469.781208751605, 5567.387587365387, 5696.857578560486, 5620.325560932714, 5661.462161094772, 5694.202811606378, 5707.6290041147195, 5729.083346664514, 5672.602917795714, 5675.120356344691, 5676.318841739017, 5676.659400435987, 5677.261955945701, 5522.282103326542, 5523.447655234444, 5579.079451890474, 5644.604877658607, 5720.48515633595, 4369.300911854088, 4373.518912919576, 4375.5405682403525, 4376.496702879146, 4378.759168245713, 3993.0, 3994.2211268802885, 3999.1002024544828, 3999.6200360965663, 4001.779902105354, 5346.064438723208, 5350.759215835296, 5355.196720491879, 5355.785768569213, 5355.919661205085, 5640.379558248589, 5678.602497825113, 5691.0, 5695.686737229492, 5698.344690360662, 5331.040412725747, 5345.278387417648, 5346.679199248058, 5348.064088784447, 5350.946490535122, 4865.148598995162, 4884.3161957326, 4886.315915771795, 4926.852194434173, 4926.926096108561, 5908.763649454059, 5928.318243401977, 5929.9110513341475, 5932.555058370639, 5935.673537955454, 5534.446555344433, 5575.77696892136, 5773.1051686988585, 5779.479846813807, 5784.479396854304, 5776.884462310814, 5777.104548794943, 5794.420557944172, 5823.941760582509, 5905.645661260338, 5611.466910643482, 5617.578681598815, 5658.094704847204, 5662.292213473316, 5663.631863928831, 5613.0, 5673.659580425187, 5682.857928551819, 5694.17434471991, 5715.771369145187, 5294.708791016531, 5328.973355133199, 5563.721813909369, 5573.247611572386, 5577.27495425592, 5470.5350045245, 5503.614746967834, 5530.0, 5566.415526369835, 5631.971840140773, 5530.585206109638, 5552.056150454352, 5552.194931734956, 5554.083576210041, 5555.333359996826, 5427.674339539482, 5596.636218645775, 5599.860003499945, 5606.131049687305, 5614.157876318585, 5333.839984800462, 5408.5673146149, 5410.21551874968, 5413.296271484682, 5417.241586178017], "value": 5253.9657442289, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.3437904188328, 557.9609427340085, 569.1320735877788, 569.2258528401373, 583.6293953339629, 32441.83779081104, 33064.66935330646, 33107.834460827726, 33135.83432082839, 33169.83415082924, 32953.17617059575, 40833.387499187535, 41626.79186604063, 41802.372964405484, 46109.30836037462, 8642.611082501287, 8800.42797218182, 8800.647974081028, 8807.2513836324, 8809.0, 8597.269232115246, 8682.696105636303, 8687.478751274912, 8697.434666746673, 8733.650653973833, 7934.365250779923, 8115.837683246332, 10181.389116653025, 10402.427866467342, 10435.947820260888, 10245.231607629421, 10297.382157070524, 10301.381917084924, 10303.27877048607, 10305.227107966895, 10081.243906707026, 10146.311227524711, 10146.441945692985, 10147.64483243083, 10155.187584993182, 39509.60490395088, 39679.0, 39711.8014409929, 39874.40188397176, 39882.40176397356, 3238.0, 3339.3154403347257, 3342.498625206214, 3550.9644903550893, 3626.2203626220225, 26131.60802587963, 27790.0, 28045.0, 28330.858345708344, 29051.12846614605, 4030.415589739501, 4084.6323830855067, 4087.3255912774357, 4089.0799570096788, 4149.792510374469, 298202.0, 298488.0, 298677.0, 299466.0, 299534.50232748914, 48349.0, 48355.50489674106, 48409.27386089211, 48458.0, 48566.0, 50605.24092138621, 50867.0, 50921.490785092414, 50930.85106382961, 50965.49034509682, 13104.2137471752, 13767.31163441824, 13769.242691651854, 13777.173369597856, 13780.65548361299, 10271.640492582725, 10295.536700848479, 10309.74225644365, 10314.432706201082, 10314.742131446625, 14339.283035848166, 14662.340194691264, 16119.113448760196, 16283.755743663854, 16324.224881770127, 6193.256809182927, 6267.4045965633195, 6343.5876668016435, 6431.517636177306, 6628.038934354491, 841.4152164245912, 992.5682328187262, 1028.1723212813608, 1051.4742628685658, 1067.1622776120707, 30783.2304192397, 31027.379452410827, 31048.22379440532, 31195.532067019012, 31468.685313146576, 996.9900300996898, 1009.5961615353771, 1012.8987101289812, 1016.9135623472088, 1029.8764148302103, 16181.59546011359, 16605.3357865684, 16635.584110397336, 16688.415905443253, 16839.57901052459, 450985.0, 452876.0, 453042.0, 454095.0, 456474.0, 48099.0, 49126.0, 54586.72706636521, 54850.45149548533, 57113.42886571164, 1234.6357824441811, 1271.4532750917194, 1272.0650322013312, 1273.8980881529455, 1291.9547815826402, 28312.71687283101, 30046.69953300439, 30895.69104309018, 30958.69041309558, 31341.0, 47616.7619161902, 48351.27473087836, 48360.274595880386, 48404.25531914877, 48517.5148248513, 417549.0, 606989.0, 617397.0, 628106.0, 629514.0, 36229.0, 36236.0, 36431.453528196565, 36613.63386366102, 36681.44977825388, 40723.17487520282, 40992.59007409888, 41177.38233926553, 41214.79392603018, 41711.58288417077, 35121.64878351184, 35374.46938295876, 35548.466772998945, 35585.46621800727, 35746.0, 35083.29833403369, 35146.297074058886, 35183.82408087943, 35275.64724352724, 35377.82311088428, 34774.65225347714, 34775.65224347724, 35215.0, 35413.114672132375, 35617.0, 30416.847915760278, 31604.36791264208, 32323.0, 32330.676693232766, 32752.0, 24457.26628201157, 24668.13661521838, 24696.426534972863, 26219.868900655376, 26570.468590628465], "value": 18724.419870110123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.8655024540431, 372.296742403504, 378.5400738103205, 381.8682554518691, 403.10309561226273, 13966.511172108978, 16974.236159372827, 17734.556636084104, 18892.338768143083, 19083.71374429381, 17950.0, 18222.635547289046, 18295.176717047732, 18463.90768046158, 18576.814231857676, 5364.383095943977, 5653.886922261552, 5659.377468478464, 5660.179274005287, 5662.462066103713, 4116.217918595472, 4325.351197320411, 5525.723713814314, 5983.940160598382, 6232.407921247474, 6315.400036996478, 6320.178376811008, 6320.589161704497, 6322.810315690536, 6326.272478664943, 6071.78748743794, 6221.160143380654, 6237.251529816405, 6245.906311405332, 6247.593906396115, 5306.09796334624, 5486.341639003305, 5501.367342755594, 5506.807261745819, 5507.614466987313, 21529.138834446603, 21561.245356412608, 21650.783492165192, 21738.0, 21850.453738656503, 2175.086463685256, 2220.555888822242, 2226.0984301357976, 2259.0624890670515, 2354.7762962518705, 13176.143550669176, 13742.244176570284, 14000.649983750385, 14203.0, 14545.418183272657, 1834.5230240137528, 1845.6954602490707, 1905.3140869287045, 1917.4822797844643, 1930.054273406035, 67711.0, 68328.6583567084, 68791.65604171947, 78062.60968695176, 79122.60438697769, 9828.361156524803, 10073.29486935922, 10242.897571024343, 10579.312344697724, 10789.946050269855, 14856.18290993984, 14866.702665946621, 14868.107913525007, 14869.3643699193, 14890.478833241, 7150.96311034897, 7358.668859901317, 7366.189719130892, 7506.699732010768, 7585.62071896414, 6871.965640171868, 6919.550229235084, 7111.715531378791, 7129.180144283474, 7131.857362852714, 4260.616544511009, 4359.14996575671, 4383.167198232326, 4473.865784026484, 4491.0, 1744.127936031984, 1847.7782666079888, 1878.806957581918, 1989.0253775649828, 2000.1299434745931, 710.4032612605333, 783.6904422752981, 918.228687902152, 946.6970569417858, 949.2643201518878, 16302.592435188977, 17321.653566928842, 18691.532711682317, 18715.344962926232, 19187.712184317246, 892.5269607108243, 940.1679513630486, 941.9199368053655, 954.4702690006974, 972.6109556177586, 10213.846792298122, 10490.21323400748, 10501.53937828986, 10557.366558006544, 10590.788184236426, 388183.0, 401109.0, 401347.0, 401893.0, 402927.0, 76500.0, 77373.0, 80137.19862801414, 89934.0, 90954.54522727344, 955.7897262602216, 964.9758756031156, 997.2122023601419, 1001.4241810958728, 1003.0521157506087, 15856.207189640241, 16369.918150409649, 16529.504114876574, 16680.582985425463, 16773.832261677228, 31810.840945795124, 38834.80582597069, 39165.608343916196, 39293.803530982164, 40012.7999360013, 54149.0, 54348.0, 55811.88420721208, 56600.0, 57735.422645774684, 7818.6481608328895, 7861.646225919733, 7939.28546430824, 7970.0, 7999.080105787909, 10159.492025398848, 11879.0, 12109.091818113853, 12410.503579857066, 12429.440675169459, 10452.32059916103, 10556.15550755953, 10660.733481663021, 10677.412742299248, 10812.0458349683, 10364.637237696645, 10445.32105413176, 10658.573657053632, 10725.731856703645, 10878.184136189659, 10275.640352587623, 10333.844992325272, 10674.35953842772, 11092.778144436905, 11135.665930022113, 7659.961700191463, 8037.477563958324, 8176.550289733884, 8226.753197404087, 8267.643721539333, 10117.19062475015, 10184.23618228621, 10235.488225588542, 10503.317284376797, 10520.736981575521], "value": 8729.728240053502, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.7755559110542, 1418.4184484361415, 1503.7744338349246, 1687.3588036546112, 1723.750056241845, 7287.526310789795, 7536.660850261737, 7902.762917112489, 8315.708950186738, 8329.666813327467, 7804.492707973992, 8114.513129212251, 8115.75652730419, 8237.958810205955, 8243.0, 2180.8364372672036, 2219.999999999992, 2220.04538048639, 2221.5112675211426, 2224.92212772553, 1936.1964784614368, 1991.531989982353, 2184.5958497677902, 2193.1008286602496, 2262.1969200933677, 2150.6558950567915, 2222.277759728087, 2225.8887055647233, 2228.6322756745117, 2231.6764069209953, 2132.115172203534, 2140.6788981652876, 2164.653655415126, 2167.306461932182, 2168.3169801512554, 2216.711827462436, 2219.6781466687403, 2239.8432109752325, 2241.652543855705, 2241.730992280937, 7838.059432868035, 7962.522248665098, 7963.800904977422, 7973.481723687942, 7979.760607181794, 4956.132676781549, 5097.337346145015, 5147.510986456281, 5154.123798954187, 5157.30376399185, 3080.3531258435755, 3218.7585931055264, 3222.871085156591, 3288.128645908836, 3289.654586268455, 1039.5789705169418, 1077.498962982217, 1091.1489038549944, 1125.1673761416494, 1127.8364637127652, 11113.944430277797, 11120.332780033224, 11155.888441115647, 11179.4969226385, 11187.216894817366, 4277.657787377002, 4486.080353527519, 4566.337881007235, 4572.291294849304, 4591.265397536378, 9629.903700963041, 9635.807283854423, 9640.662576809778, 9640.662576809778, 9644.662436814679, 5091.159958606862, 5096.719680417613, 5097.745112744348, 5136.383633963874, 5147.948520514822, 4551.362809206714, 4687.648426368036, 4696.976515117471, 4726.196546587088, 4772.7136371817805, 3570.7143428525656, 3635.836387362575, 3654.086478380405, 3682.4476328550395, 3768.6419790119894, 1158.0851127609094, 1187.8871507206802, 1249.6001279590625, 1250.0811903251104, 1266.1516783754905, 839.5634270179472, 868.0971789339017, 910.4764760262875, 938.394735395666, 947.7583216279804, 5574.470425309589, 5651.463111004448, 5675.404082571271, 5824.301083869963, 5891.941080589139, 898.2364989758653, 903.746950853762, 905.2757793764962, 919.0809190809191, 937.5452905340904, 3532.788032718045, 3703.0, 3723.1809002019513, 3769.7361184716806, 3801.0877389426337, 9967.601295948225, 10136.54385552652, 10282.794344113076, 10285.382877027403, 10293.94853025745, 10167.186625069977, 10198.388096714221, 10205.234607404474, 10245.129164021142, 10246.077852993267, 7705.229477052362, 7841.059072911401, 7847.803804904923, 7853.450258481851, 7857.449978501564, 5562.72186390687, 5613.747381367766, 5655.773769049192, 5725.713714314351, 5829.3296270927685, 9160.587773550073, 9214.907850921405, 9288.396254243453, 9314.115159059878, 9316.0, 9176.082391761038, 9358.953205233931, 9426.151646351862, 9601.663941762004, 9611.375260608318, 6961.269066747918, 7049.506534542533, 7082.893756593552, 7096.680649370687, 7102.857942841218, 7912.604369781603, 7951.721689740832, 7958.482698624571, 7959.124496305518, 7963.482373645695, 6915.204751453647, 7014.614196219053, 7106.395956343768, 7210.423166146591, 7284.781456556312, 7061.364477197077, 7103.431725462054, 7108.182559005781, 7181.569105853666, 7234.927650723425, 6546.705398257185, 6666.566673166229, 6690.531662783753, 6702.0, 6723.193216814014, 4946.307516947702, 5018.247262910592, 5074.441811400669, 5102.056119617882, 5103.030424219386, 4917.385326834145, 5071.188609822559, 5082.390113186441, 5137.922931155961, 5180.896382072413], "value": 4380.896689435412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5316335600363, 358.56792564959227, 361.6058496239099, 365.6398447529185, 368.96863766579855, 5214.608904332176, 5237.816676416322, 5261.394939581949, 5263.894722105556, 5276.498732620405, 5198.45416231295, 5209.791608335671, 5211.791528338871, 5214.895702085956, 5224.693826543365, 3529.92940141197, 3910.7262491625524, 3979.8607048753156, 4077.857274995376, 4096.67226621871, 4060.4924384451942, 4066.7356621819636, 4091.3658382950543, 4092.6521245694153, 4093.1813637272517, 4034.0752954108184, 4056.127932494513, 4057.8376864925367, 4058.147788964306, 4061.8172182251724, 3905.668018218455, 3997.700172487046, 4020.4170395292517, 4063.837446502166, 4069.369247766601, 3624.963750362489, 3656.213914008474, 3656.744027918047, 3662.285854258421, 3688.114852435423, 5091.389033316026, 5094.974525127351, 5094.974525127388, 5108.872278193037, 5149.76826042829, 4546.38623785788, 4626.21354369758, 4646.674732768707, 4657.324687920266, 4659.5573420525, 5413.404525502192, 5420.701861397661, 5427.402985671573, 5443.0, 5449.3188351456065, 3997.2818483431256, 4005.419214213952, 4019.0756126091164, 4020.43713880057, 4029.597040295947, 5476.58925580583, 5541.0580201365865, 5577.0, 5658.603897727161, 5661.490465858093, 4070.1452694934396, 4089.1412803311637, 4092.956296144464, 4100.835966561304, 4109.527404348479, 4145.958540414617, 4154.439150714615, 4159.875203743893, 4164.83340666376, 4170.582941705866, 4540.205464043779, 4662.207424737802, 4711.717296962193, 4721.811127554928, 4735.431748190239, 5448.902172663553, 5460.535854452337, 5467.6719396836315, 5471.534919531805, 5476.342838859283, 1388.187910072619, 1390.8956828237922, 1395.1768456610446, 1399.4542128569865, 1405.4659229492727, 905.8100563985915, 940.6425558287807, 944.4239014201331, 945.0909163489849, 951.4861974533812, 5039.513343563657, 5041.420236672756, 5047.394312682502, 5054.49455054499, 5055.848324550269, 5367.812126575629, 5390.407055223922, 5392.91910621341, 5393.460653934575, 5438.04230477028, 5000.549950504472, 5033.7734801934, 5111.258867464197, 5130.4100028497205, 5278.656887302313, 2847.007095033485, 2878.2516545698268, 2879.92800179993, 2902.3034471726633, 2908.432855593139, 5564.4991950724625, 5575.163725441216, 5612.186232996192, 5635.971820140955, 5656.8020119295625, 5444.0, 5530.336359636869, 5687.374388817227, 5740.368559458456, 5743.310802703702, 5526.861828454321, 5632.746526406321, 5640.971795140998, 5740.741666624928, 5772.451617096369, 5563.944360556343, 5591.608587398843, 5614.88770224585, 5617.466340697627, 5617.943820561742, 5445.210444485607, 5484.055947542914, 5532.336119665666, 5566.888662226652, 5567.610267281251, 5714.542836572981, 5725.227094342211, 5735.283089613798, 5744.420284421817, 5745.3105627324985, 3923.2545816295956, 3955.426463162883, 3956.7625942443547, 3966.305896468049, 3969.6030396960073, 5358.812441564526, 5599.188117722989, 5610.943890561205, 5633.38032816398, 5650.773969041356, 5471.398146203994, 5486.451354864482, 5511.889762204653, 5529.502344788988, 5536.2249285099315, 5489.39616642177, 5526.949879522877, 5527.364353099445, 5532.529734972572, 5533.253010843485, 5320.2817619620855, 5452.91820622683, 5525.336959564878, 5535.8892822142525, 5546.168074788814, 5516.6969763582865, 5517.200005999188, 5576.9163462547285, 5579.0, 5585.664860108406, 5223.5559977402345, 5393.919091213714, 5414.5668346532975, 5419.539339156216, 5432.266644003009], "value": 4172.460959637104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.8200103970888, 745.7725393754903, 778.45508144299, 784.4979213303487, 800.8998875140605, 14013.789793153099, 15506.379744810194, 15538.611534711623, 15556.0, 15688.607784805386, 15219.923900380483, 15329.770053449207, 15761.054336739804, 15932.20338983052, 16029.839701602981, 772.1660606544932, 795.4630624328584, 795.4869109424418, 796.9481983671072, 797.0435477427111, 647.9805605831832, 660.9669516524178, 760.9923900761005, 783.5377127494777, 788.1684822512248, 834.2158371131147, 836.3351135847016, 836.4688422851502, 836.5440834745078, 837.0833936839151, 828.4904783558129, 829.7718127514921, 830.0910502999207, 830.8338332333558, 830.9529992209799, 506.283608693698, 515.9896802063976, 583.3146053387295, 595.3094410483861, 603.2610052685469, 14972.925135374253, 15084.24578771068, 15103.54689359321, 15109.39562417502, 15129.394824207018, 13017.28404937728, 13337.466501339935, 13565.45738170472, 13661.453541858315, 13707.862921370759, 12579.245245285312, 12712.809307860389, 12934.547290844775, 12983.87016129836, 13146.934265328708, 4365.3451982202605, 4424.292113261895, 4446.822127114911, 4463.085067561175, 4579.0, 76677.849832252, 77832.22167778306, 78597.21402786013, 79406.20593794045, 80548.59725701335, 10645.338665333667, 10809.189310801721, 10857.728556785985, 11043.723906902393, 11083.833742493869, 20211.8989405052, 20232.39302820918, 20249.0, 20339.983000849898, 20429.897850510653, 7665.846683066307, 7929.643166057541, 7969.960150199212, 7998.160193179749, 8185.79535511617, 4255.404024034481, 4544.886377840514, 4588.357629931812, 4697.295405689174, 4721.079389519011, 3253.6583658715967, 3263.2494526259093, 3295.2256219788333, 3322.1030321812973, 3364.8149351785396, 548.9917651235155, 558.020673717623, 563.433749082178, 563.5660541383112, 576.075398984632, 545.3101826189873, 568.9943100569025, 669.0299066353709, 670.1355251725317, 684.9965750171317, 8732.78168045804, 9002.774930626787, 9036.915570131494, 9272.324928304246, 9338.393004454689, 640.891258123449, 643.5313659375968, 649.8050584824533, 654.5287393076977, 682.9043933849265, 4331.913361732748, 4539.039403378292, 4611.216093264086, 4654.837080702227, 4711.481737008926, 77996.61001695068, 79331.60334198408, 79569.0, 80922.5953870227, 81560.18439815645, 57529.71235143798, 65701.0, 65884.0, 67395.73753448755, 67977.32022679709, 62998.68500657468, 63769.0, 65520.67239663771, 66190.0, 66434.33565664379, 8782.253508451853, 8972.327075469497, 9128.269738421042, 9152.313576481658, 9330.766730831783, 44016.77991610021, 44467.77766111149, 44528.332075018254, 45111.36107986502, 46561.30158047564, 57322.7133864328, 59208.40791592029, 60904.69547652411, 61658.38341616526, 62829.68585157228, 10470.21473389514, 10690.572377104829, 10793.19051071157, 10810.67567972962, 11061.889381106086, 11887.821682674594, 12062.879371206527, 12283.447244873823, 12745.10784245094, 12756.553520626734, 11689.707757305796, 11810.586629467927, 12035.879641203475, 12455.813162802746, 12532.248065116122, 10931.125509959344, 10955.0, 11010.889891100986, 11210.327380357205, 11402.82895756581, 10319.48402579883, 10482.0, 11042.558297668003, 11106.0, 11394.37330946806, 9604.855927161238, 9905.702828915144, 10007.899921000697, 10148.695539133838, 10615.575376984834, 9572.138507534077, 9645.08371704687, 9822.968588298127, 9923.156531694887, 9980.850287245843], "value": 6889.077325900148, "unit": "score"}], "name": "dromaeo_css", "value": 6902.549103083557, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 111.0, 113.0, 113.0, 111.0, 112.0, 113.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 129.0, 174.0, 124.0, 125.0, 123.0, 128.0, 145.0, 133.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 162.0, 161.0, 163.0, 162.0, 164.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 84.0, 107.0, 76.0, 76.0, 75.0, 76.0, 91.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 83.0, 83.0, 84.0, 95.0, 85.0, 84.0, 106.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 127.0, 128.0, 127.0, 127.0, 127.0, 129.0, 127.0, 126.0], "value": 127.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 53.0, 51.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 87.0, 81.0, 81.0, 83.0, 80.0, 90.0, 83.0, 88.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 132.0, 133.0, 131.0, 155.0, 131.0, 143.0, 180.0, 153.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 168.0, 166.0, 167.0, 167.0, 167.0, 170.0, 166.0, 167.0, 166.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 71.0, 64.0, 63.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1527.3000000000002, "alertThreshold": 2.0}]} 08:49:17 INFO - Return code: 0 08:49:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:49:17 INFO - # TBPL SUCCESS # 08:49:17 INFO - Running post-action listener: _resource_record_post_action 08:49:17 INFO - [mozharness: 2016-12-13 16:49:17.283971Z] Finished run-tests step (success) 08:49:17 INFO - Running post-run listener: _resource_record_post_run 08:49:17 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 392609792; Read time: 0; Write time: 261640 08:49:17 INFO - TinderboxPrint: CPU usage
13.1% 08:49:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:49:17 INFO - TinderboxPrint: I/O write bytes / time
392,609,792 / 261,640 08:49:17 INFO - TinderboxPrint: CPU idle
8,296.2 (86.9%) 08:49:17 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 08:49:17 INFO - TinderboxPrint: Swap in / out
0 / 0 08:49:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104161280; Read time: 0; Write time: 90068 08:49:17 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288448512; Read time: 0; Write time: 171572 08:49:17 INFO - Running post-run listener: _upload_blobber_files 08:49:17 INFO - Blob upload gear active. 08:49:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:49:17 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 08:49:17 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'] 08:49:17 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 08:49:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:49:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:49:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:19 INFO - (blobuploader) - INFO - Done attempting. 08:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:19 INFO - (blobuploader) - INFO - Done attempting. 08:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:23 INFO - (blobuploader) - INFO - Done attempting. 08:49:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:23 INFO - Return code: 0 08:49:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbd0937988e83627f0c0ccb872eb7d6a0e990f4822e6af2d7d811db865400600006c49e960a5c526c8a643e34d833ceee2fbc3dc20b4400fd8fcf465ebd22952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4fa83e3d4ce80f13d6f70ec7d2fbee594a375b37ba6600ede7a7045638989c5607ab4e93cd5fcf19542df2ceed2cd5f843067d08008efc60d5446fa7a9ac561a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4d712b681b53e4255b09bf13b3e5b9cb1285c2d7c416733343704699a7af6983e8902c73fdb68a8d30f636bce851aa99c1c8a798cbfc47d8a763427feb4dd60"} 08:49:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:23 INFO - Contents: 08:49:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbd0937988e83627f0c0ccb872eb7d6a0e990f4822e6af2d7d811db865400600006c49e960a5c526c8a643e34d833ceee2fbc3dc20b4400fd8fcf465ebd22952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4fa83e3d4ce80f13d6f70ec7d2fbee594a375b37ba6600ede7a7045638989c5607ab4e93cd5fcf19542df2ceed2cd5f843067d08008efc60d5446fa7a9ac561a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4d712b681b53e4255b09bf13b3e5b9cb1285c2d7c416733343704699a7af6983e8902c73fdb68a8d30f636bce851aa99c1c8a798cbfc47d8a763427feb4dd60"} 08:49:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:23 INFO - Copying logs to upload dir... 08:49:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.222678 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-13 08:49:23.038109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:49:23.042210) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbd0937988e83627f0c0ccb872eb7d6a0e990f4822e6af2d7d811db865400600006c49e960a5c526c8a643e34d833ceee2fbc3dc20b4400fd8fcf465ebd22952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4fa83e3d4ce80f13d6f70ec7d2fbee594a375b37ba6600ede7a7045638989c5607ab4e93cd5fcf19542df2ceed2cd5f843067d08008efc60d5446fa7a9ac561a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4d712b681b53e4255b09bf13b3e5b9cb1285c2d7c416733343704699a7af6983e8902c73fdb68a8d30f636bce851aa99c1c8a798cbfc47d8a763427feb4dd60"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011806 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481639716/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbd0937988e83627f0c0ccb872eb7d6a0e990f4822e6af2d7d811db865400600006c49e960a5c526c8a643e34d833ceee2fbc3dc20b4400fd8fcf465ebd22952", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4fa83e3d4ce80f13d6f70ec7d2fbee594a375b37ba6600ede7a7045638989c5607ab4e93cd5fcf19542df2ceed2cd5f843067d08008efc60d5446fa7a9ac561a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4d712b681b53e4255b09bf13b3e5b9cb1285c2d7c416733343704699a7af6983e8902c73fdb68a8d30f636bce851aa99c1c8a798cbfc47d8a763427feb4dd60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:49:23.070734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:49:23.071079) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1481646524.552336-1557759251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:49:23.154531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:49:23.154841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:49:23.155156) ========= ========= Total master_lag: 0.17 =========