builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1480603864.58 results: success (0) buildid: 20161201064559 builduid: 00e1b1dbce9b4f8990d7b536f744b352 revision: 29fd1259e299250eb26e4c83dbef8c55de612305 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.581008) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.581501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.581788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.596181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.596474) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-01 06:51:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-12-01 06:51:05 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.735349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.735665) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.785138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:04.785496) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 29fd1259e299250eb26e4c83dbef8c55de612305 --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 29fd1259e299250eb26e4c83dbef8c55de612305 --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=5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-01 06:51:05,374 truncating revision to first 12 chars 2016-12-01 06:51:05,374 Setting DEBUG logging. 2016-12-01 06:51:05,374 attempt 1/10 2016-12-01 06:51:05,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/29fd1259e299?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 06:51:05,739 unpacking tar archive at: mozilla-inbound-29fd1259e299/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:05.456848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:05.457237) ========= script_repo_revision: 29fd1259e299250eb26e4c83dbef8c55de612305 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:05.457673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:05.457953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 06:51:05.467486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-01 06:51:05.467828) ========= /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=5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:06 INFO - MultiFileLogger online at 20161201 06:51:06 in /builds/slave/test 06:51:06 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 06:51:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:51:06 INFO - {'append_to_log': False, 06:51:06 INFO - 'base_work_dir': '/builds/slave/test', 06:51:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:51:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:51:06 INFO - 'branch': 'Mozilla-Inbound', 06:51:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:06 INFO - 'config_files': ('talos/linux_config.py',), 06:51:06 INFO - 'default_actions': ('clobber', 06:51:06 INFO - 'read-buildbot-config', 06:51:06 INFO - 'download-and-extract', 06:51:06 INFO - 'populate-webroot', 06:51:06 INFO - 'create-virtualenv', 06:51:06 INFO - 'install', 06:51:06 INFO - 'run-tests'), 06:51:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:06 INFO - 'download_minidump_stackwalk': True, 06:51:06 INFO - 'download_symbols': 'ondemand', 06:51:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:06 INFO - 'installer_path': 'installer.exe', 06:51:06 INFO - 'log_level': 'info', 06:51:06 INFO - 'log_name': 'talos', 06:51:06 INFO - 'log_to_console': True, 06:51:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:06 INFO - 'opt_config_files': (), 06:51:06 INFO - 'pip_index': False, 06:51:06 INFO - 'sps_profile': False, 06:51:06 INFO - 'sps_profile_interval': 0, 06:51:06 INFO - 'suite': 'dromaeojs', 06:51:06 INFO - 'system_bits': '32', 06:51:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:06 INFO - 'title': 'talos-linux64-ix-011', 06:51:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:06 INFO - 'use_talos_json': True, 06:51:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:51:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:06 INFO - 'work_dir': 'build'} 06:51:06 INFO - [mozharness: 2016-12-01 14:51:06.158301Z] Running clobber step. 06:51:06 INFO - Running pre-action listener: _resource_record_pre_action 06:51:06 INFO - Running main action method: clobber 06:51:06 INFO - rmtree: /builds/slave/test/build 06:51:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:51:06 INFO - Running post-action listener: _resource_record_post_action 06:51:06 INFO - [mozharness: 2016-12-01 14:51:06.621029Z] Finished clobber step (success) 06:51:06 INFO - [mozharness: 2016-12-01 14:51:06.621127Z] Running read-buildbot-config step. 06:51:06 INFO - Running pre-action listener: _resource_record_pre_action 06:51:06 INFO - Running main action method: read_buildbot_config 06:51:06 INFO - Using buildbot properties: 06:51:06 INFO - { 06:51:06 INFO - "project": "", 06:51:06 INFO - "product": "firefox", 06:51:06 INFO - "script_repo_revision": "production", 06:51:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:51:06 INFO - "repository": "", 06:51:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:51:06 INFO - "buildid": "20161201064559", 06:51:06 INFO - "stage_platform": "linux64-pgo", 06:51:06 INFO - "basedir": "/builds/slave/test", 06:51:06 INFO - "buildnumber": 2208, 06:51:06 INFO - "platform": "ubuntu64_hw", 06:51:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:06 INFO - "slavebuilddir": "test", 06:51:06 INFO - "branch": "mozilla-inbound", 06:51:06 INFO - "revision": "29fd1259e299250eb26e4c83dbef8c55de612305", 06:51:06 INFO - "slavename": "talos-linux64-ix-011", 06:51:06 INFO - "builduid": "00e1b1dbce9b4f8990d7b536f744b352", 06:51:06 INFO - "repo_path": "integration/mozilla-inbound" 06:51:06 INFO - } 06:51:06 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 06:51:06 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 06:51:06 INFO - Running post-action listener: _resource_record_post_action 06:51:06 INFO - [mozharness: 2016-12-01 14:51:06.623501Z] Finished read-buildbot-config step (success) 06:51:06 INFO - [mozharness: 2016-12-01 14:51:06.623589Z] Running download-and-extract step. 06:51:06 INFO - Running pre-action listener: _resource_record_pre_action 06:51:06 INFO - Running main action method: download_and_extract 06:51:06 INFO - mkdir: /builds/slave/test/build/tests 06:51:06 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')]} 06:51:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:51:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/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 06:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/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 06:51:06 INFO - Downloaded 1361 bytes. 06:51:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:51:06 INFO - Using the following test package requirements: 06:51:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:51:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'jsshell-linux-x86_64.zip'], 06:51:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:51:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:51:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:06 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/1480592041/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:51:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:51:06 INFO - Expected file size: 21773123 06:51:06 INFO - Obtained file size: 21773123 06:51:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:51:10 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/1480592041/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:51:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:51:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:51:11 INFO - Expected file size: 21773123 06:51:11 INFO - Obtained file size: 21773123 06:51:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:51:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:51:15 INFO - Expected file size: 14409702 06:51:15 INFO - Obtained file size: 14409702 06:51:16 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')]} 06:51:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:51:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/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 06:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/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 06:51:16 INFO - Downloaded 59863648 bytes. 06:51:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:51:16 INFO - mkdir: /builds/slave/test/properties 06:51:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:16 INFO - Contents: 06:51:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:51:17 INFO - Running post-action listener: _resource_record_post_action 06:51:17 INFO - Running post-action listener: set_extra_try_arguments 06:51:17 INFO - [mozharness: 2016-12-01 14:51:17.040015Z] Finished download-and-extract step (success) 06:51:17 INFO - [mozharness: 2016-12-01 14:51:17.040316Z] Running populate-webroot step. 06:51:17 INFO - Running pre-action listener: _resource_record_pre_action 06:51:17 INFO - Running main action method: populate_webroot 06:51:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:17 INFO - '--tppagecycles', 06:51:17 INFO - '7'], 06:51:17 INFO - 'tests': ['tsvgm']}}, 06:51:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['damp', 'tps']}, 06:51:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'tests': ['damp', 'tps']}, 06:51:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['dromaeo_dom']}, 06:51:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['basic_compositor_video']}, 06:51:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:51:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['a11yr', 06:51:17 INFO - 'ts_paint', 06:51:17 INFO - 'tpaint', 06:51:17 INFO - 'sessionrestore', 06:51:17 INFO - 'sessionrestore_no_auto_restore', 06:51:17 INFO - 'tabpaint']}, 06:51:17 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:17 INFO - 'ts_paint', 06:51:17 INFO - 'tpaint', 06:51:17 INFO - 'sessionrestore', 06:51:17 INFO - 'sessionrestore_no_auto_restore', 06:51:17 INFO - 'tabpaint']}, 06:51:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:17 INFO - 'ts_paint', 06:51:17 INFO - 'tpaint', 06:51:17 INFO - 'sessionrestore', 06:51:17 INFO - 'sessionrestore_no_auto_restore', 06:51:17 INFO - 'tabpaint']}, 06:51:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:17 INFO - 'ts_paint', 06:51:17 INFO - 'tpaint', 06:51:17 INFO - 'sessionrestore', 06:51:17 INFO - 'sessionrestore_no_auto_restore', 06:51:17 INFO - 'tabpaint']}, 06:51:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['a11yr', 06:51:17 INFO - 'ts_paint', 06:51:17 INFO - 'tpaint', 06:51:17 INFO - 'sessionrestore', 06:51:17 INFO - 'sessionrestore_no_auto_restore', 06:51:17 INFO - 'tabpaint']}, 06:51:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['a11yr', 06:51:17 INFO - 'ts_paint', 06:51:17 INFO - 'tpaint', 06:51:17 INFO - 'sessionrestore', 06:51:17 INFO - 'sessionrestore_no_auto_restore', 06:51:17 INFO - 'tabpaint']}, 06:51:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['tsvgx', 06:51:17 INFO - 'tsvgr_opacity', 06:51:17 INFO - 'tart', 06:51:17 INFO - 'tscrollx', 06:51:17 INFO - 'cart', 06:51:17 INFO - 'tsvg_static']}, 06:51:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:17 INFO - 'tsvgr_opacity', 06:51:17 INFO - 'tart', 06:51:17 INFO - 'tscrollx', 06:51:17 INFO - 'cart', 06:51:17 INFO - 'tsvg_static']}, 06:51:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'talos_options': ['--disable-e10s'], 06:51:17 INFO - 'tests': ['tp5o']}, 06:51:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:51:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'talos_options': ['--disable-e10s', 06:51:17 INFO - '--xperf_path', 06:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:17 INFO - 'tests': ['tp5n']}, 06:51:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:51:17 INFO - 'talos_options': ['--xperf_path', 06:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:17 INFO - 'tests': ['tp5n']}}, 06:51:17 INFO - 'talos.zip': {'path': '', 06:51:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:17 INFO - Running post-action listener: _resource_record_post_action 06:51:17 INFO - [mozharness: 2016-12-01 14:51:17.063199Z] Finished populate-webroot step (success) 06:51:17 INFO - [mozharness: 2016-12-01 14:51:17.063293Z] Running create-virtualenv step. 06:51:17 INFO - Running pre-action listener: _resource_record_pre_action 06:51:17 INFO - Running main action method: create_virtualenv 06:51:17 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:17 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 06:51:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:17 INFO - Using real prefix '/usr' 06:51:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:19 INFO - Installing pip.................done. 06:51:19 INFO - Return code: 0 06:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:51:19 INFO - Reading from file tmpfile_stdout 06:51:19 INFO - Output received: 06:51:19 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) 06:51:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51: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', 'pip>=1.5'] in /builds/slave/test/build 06:51: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 pip>=1.5 06:51:19 INFO - Using env: {'DISPLAY': ':0', 06:51:19 INFO - 'HOME': '/home/cltbld', 06:51:19 INFO - 'LANG': 'en_US.UTF-8', 06:51:19 INFO - 'LANGUAGE': 'en_US:en', 06:51:19 INFO - 'LOGNAME': 'cltbld', 06:51:19 INFO - 'MAIL': '/var/mail/cltbld', 06:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:19 INFO - 'MOZ_NO_REMOTE': '1', 06:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:19 INFO - 'NO_EM_RESTART': '1', 06:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:19 INFO - 'PWD': '/builds/slave/test', 06:51:19 INFO - 'SHELL': '/bin/bash', 06:51:19 INFO - 'SHLVL': '1', 06:51:19 INFO - 'TERM': 'linux', 06:51:19 INFO - 'TMOUT': '86400', 06:51:19 INFO - 'USER': 'cltbld', 06:51:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:19 INFO - '_': '/tools/buildbot/bin/python'} 06:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:20 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 06:51:20 INFO - Cleaning up... 06:51:20 INFO - Return code: 0 06:51:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:20 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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:20 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 06:51:20 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 06:51:20 INFO - Using env: {'DISPLAY': ':0', 06:51:20 INFO - 'HOME': '/home/cltbld', 06:51:20 INFO - 'LANG': 'en_US.UTF-8', 06:51:20 INFO - 'LANGUAGE': 'en_US:en', 06:51:20 INFO - 'LOGNAME': 'cltbld', 06:51:20 INFO - 'MAIL': '/var/mail/cltbld', 06:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:20 INFO - 'MOZ_NO_REMOTE': '1', 06:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:20 INFO - 'NO_EM_RESTART': '1', 06:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:20 INFO - 'PWD': '/builds/slave/test', 06:51:20 INFO - 'SHELL': '/bin/bash', 06:51:20 INFO - 'SHLVL': '1', 06:51:20 INFO - 'TERM': 'linux', 06:51:20 INFO - 'TMOUT': '86400', 06:51:20 INFO - 'USER': 'cltbld', 06:51:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:20 INFO - '_': '/tools/buildbot/bin/python'} 06:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:20 INFO - Downloading/unpacking psutil>=3.1.1 06:51:20 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 06:51:20 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 06:51:20 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 06:51:20 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 06:51:20 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 06:51:20 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 06:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:22 INFO - Installing collected packages: psutil 06:51:22 INFO - Running setup.py install for psutil 06:51:22 INFO - building 'psutil._psutil_linux' extension 06:51:22 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 06:51:22 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 06:51:22 INFO - building 'psutil._psutil_posix' extension 06:51:22 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 06:51:22 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 06:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:22 INFO - Successfully installed psutil 06:51:22 INFO - Cleaning up... 06:51:22 INFO - Return code: 0 06:51:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:51:22 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')]} 06:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:22 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')]} 06:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:22 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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:22 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 06:51:22 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 06:51:22 INFO - Using env: {'DISPLAY': ':0', 06:51:22 INFO - 'HOME': '/home/cltbld', 06:51:22 INFO - 'LANG': 'en_US.UTF-8', 06:51:22 INFO - 'LANGUAGE': 'en_US:en', 06:51:22 INFO - 'LOGNAME': 'cltbld', 06:51:22 INFO - 'MAIL': '/var/mail/cltbld', 06:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:22 INFO - 'MOZ_NO_REMOTE': '1', 06:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:22 INFO - 'NO_EM_RESTART': '1', 06:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:22 INFO - 'PWD': '/builds/slave/test', 06:51:22 INFO - 'SHELL': '/bin/bash', 06:51:22 INFO - 'SHLVL': '1', 06:51:22 INFO - 'TERM': 'linux', 06:51:22 INFO - 'TMOUT': '86400', 06:51:22 INFO - 'USER': 'cltbld', 06:51:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:22 INFO - '_': '/tools/buildbot/bin/python'} 06:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:51:23 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 06:51:23 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 06:51:23 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 06:51:23 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 06:51:23 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 06:51:23 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 06:51:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:51:25 INFO - Installing collected packages: mozsystemmonitor 06:51:25 INFO - Running setup.py install for mozsystemmonitor 06:51:25 INFO - Successfully installed mozsystemmonitor 06:51:25 INFO - Cleaning up... 06:51:25 INFO - Return code: 0 06:51:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:51:25 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')]} 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:25 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')]} 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:25 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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:25 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 06:51:25 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 06:51:25 INFO - Using env: {'DISPLAY': ':0', 06:51:25 INFO - 'HOME': '/home/cltbld', 06:51:25 INFO - 'LANG': 'en_US.UTF-8', 06:51:25 INFO - 'LANGUAGE': 'en_US:en', 06:51:25 INFO - 'LOGNAME': 'cltbld', 06:51:25 INFO - 'MAIL': '/var/mail/cltbld', 06:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:25 INFO - 'MOZ_NO_REMOTE': '1', 06:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:25 INFO - 'NO_EM_RESTART': '1', 06:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:25 INFO - 'PWD': '/builds/slave/test', 06:51:25 INFO - 'SHELL': '/bin/bash', 06:51:25 INFO - 'SHLVL': '1', 06:51:25 INFO - 'TERM': 'linux', 06:51:25 INFO - 'TMOUT': '86400', 06:51:25 INFO - 'USER': 'cltbld', 06:51:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:25 INFO - '_': '/tools/buildbot/bin/python'} 06:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:25 INFO - Downloading/unpacking jsonschema==2.5.1 06:51:25 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 06:51:25 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 06:51:25 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 06:51:25 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 06:51:25 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 06:51:25 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 06:51:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:27 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:27 INFO - warning: no files found matching '*.txt' 06:51:27 INFO - no previously-included directories found matching 'build' 06:51:27 INFO - no previously-included directories found matching 'dist' 06:51:27 INFO - no previously-included directories found matching '.git*' 06:51:27 INFO - Installing collected packages: jsonschema, functools32 06:51:27 INFO - Running setup.py install for functools32 06:51:27 INFO - warning: no files found matching '*.txt' 06:51:27 INFO - no previously-included directories found matching 'build' 06:51:27 INFO - no previously-included directories found matching 'dist' 06:51:27 INFO - no previously-included directories found matching '.git*' 06:51:27 INFO - Successfully installed jsonschema functools32 06:51:27 INFO - Cleaning up... 06:51:28 INFO - Return code: 0 06:51:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:51:28 INFO - Using env: {'DISPLAY': ':0', 06:51:28 INFO - 'HOME': '/home/cltbld', 06:51:28 INFO - 'LANG': 'en_US.UTF-8', 06:51:28 INFO - 'LANGUAGE': 'en_US:en', 06:51:28 INFO - 'LOGNAME': 'cltbld', 06:51:28 INFO - 'MAIL': '/var/mail/cltbld', 06:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:28 INFO - 'MOZ_NO_REMOTE': '1', 06:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:28 INFO - 'NO_EM_RESTART': '1', 06:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:28 INFO - 'PWD': '/builds/slave/test', 06:51:28 INFO - 'SHELL': '/bin/bash', 06:51:28 INFO - 'SHLVL': '1', 06:51:28 INFO - 'TERM': 'linux', 06:51:28 INFO - 'TMOUT': '86400', 06:51:28 INFO - 'USER': 'cltbld', 06:51:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:28 INFO - '_': '/tools/buildbot/bin/python'} 06:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:51:28 INFO - Cleaning up... 06:51:28 INFO - Return code: 0 06:51:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:51:28 INFO - Using env: {'DISPLAY': ':0', 06:51:28 INFO - 'HOME': '/home/cltbld', 06:51:28 INFO - 'LANG': 'en_US.UTF-8', 06:51:28 INFO - 'LANGUAGE': 'en_US:en', 06:51:28 INFO - 'LOGNAME': 'cltbld', 06:51:28 INFO - 'MAIL': '/var/mail/cltbld', 06:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:28 INFO - 'MOZ_NO_REMOTE': '1', 06:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:28 INFO - 'NO_EM_RESTART': '1', 06:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:28 INFO - 'PWD': '/builds/slave/test', 06:51:28 INFO - 'SHELL': '/bin/bash', 06:51:28 INFO - 'SHLVL': '1', 06:51:28 INFO - 'TERM': 'linux', 06:51:28 INFO - 'TMOUT': '86400', 06:51:28 INFO - 'USER': 'cltbld', 06:51:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:28 INFO - '_': '/tools/buildbot/bin/python'} 06:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:28 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:30 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:31 INFO - Downloading docopt-0.6.1.tar.gz 06:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:31 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:31 INFO - Running setup.py install for blobuploader 06:51:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:31 INFO - Running setup.py install for requests 06:51:31 INFO - Running setup.py install for docopt 06:51:31 INFO - Successfully installed blobuploader requests docopt 06:51:31 INFO - Cleaning up... 06:51:31 INFO - Return code: 0 06:51:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:31 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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:31 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 06:51:31 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 06:51:31 INFO - Using env: {'DISPLAY': ':0', 06:51:31 INFO - 'HOME': '/home/cltbld', 06:51:31 INFO - 'LANG': 'en_US.UTF-8', 06:51:31 INFO - 'LANGUAGE': 'en_US:en', 06:51:31 INFO - 'LOGNAME': 'cltbld', 06:51:31 INFO - 'MAIL': '/var/mail/cltbld', 06:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:31 INFO - 'MOZ_NO_REMOTE': '1', 06:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:31 INFO - 'NO_EM_RESTART': '1', 06:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:31 INFO - 'PWD': '/builds/slave/test', 06:51:31 INFO - 'SHELL': '/bin/bash', 06:51:31 INFO - 'SHLVL': '1', 06:51:31 INFO - 'TERM': 'linux', 06:51:31 INFO - 'TMOUT': '86400', 06:51:31 INFO - 'USER': 'cltbld', 06:51:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:31 INFO - '_': '/tools/buildbot/bin/python'} 06:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:32 INFO - Running setup.py (path:/tmp/pip-AP18vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:32 INFO - Running setup.py (path:/tmp/pip-S38xKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:32 INFO - Running setup.py (path:/tmp/pip-sb1zxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:32 INFO - Running setup.py (path:/tmp/pip-w91rau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:32 INFO - Running setup.py (path:/tmp/pip-OPsSej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:32 INFO - Running setup.py (path:/tmp/pip-WfQ4LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:32 INFO - Running setup.py (path:/tmp/pip-h_bm46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:32 INFO - Running setup.py (path:/tmp/pip-mNuWIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:32 INFO - Running setup.py (path:/tmp/pip-LwBp5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:32 INFO - Running setup.py (path:/tmp/pip-52QQFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:32 INFO - Running setup.py (path:/tmp/pip-RCVGOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:32 INFO - Running setup.py (path:/tmp/pip-0GMex4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:32 INFO - Running setup.py (path:/tmp/pip-sZxSOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:33 INFO - Running setup.py (path:/tmp/pip-pwxh6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:33 INFO - Running setup.py (path:/tmp/pip-bV0Jjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:33 INFO - Running setup.py (path:/tmp/pip-OfKry3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:33 INFO - Running setup.py (path:/tmp/pip-mRn0q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:33 INFO - Running setup.py install for manifestparser 06:51:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:33 INFO - Running setup.py install for mozcrash 06:51:33 INFO - Running setup.py install for mozdebug 06:51:33 INFO - Running setup.py install for mozdevice 06:51:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:51:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:33 INFO - Running setup.py install for mozfile 06:51:33 INFO - Running setup.py install for mozhttpd 06:51:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:33 INFO - Running setup.py install for mozinfo 06:51:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:33 INFO - Running setup.py install for mozInstall 06:51:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Running setup.py install for mozleak 06:51:34 INFO - Running setup.py install for mozlog 06:51:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Running setup.py install for moznetwork 06:51:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Running setup.py install for mozprocess 06:51:34 INFO - Running setup.py install for mozprofile 06:51:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Running setup.py install for mozrunner 06:51:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:34 INFO - Running setup.py install for mozscreenshot 06:51:34 INFO - Running setup.py install for moztest 06:51:34 INFO - Running setup.py install for mozversion 06:51:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:35 INFO - Cleaning up... 06:51:35 INFO - Return code: 0 06:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:35 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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:35 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 06:51:35 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 06:51:35 INFO - Using env: {'DISPLAY': ':0', 06:51:35 INFO - 'HOME': '/home/cltbld', 06:51:35 INFO - 'LANG': 'en_US.UTF-8', 06:51:35 INFO - 'LANGUAGE': 'en_US:en', 06:51:35 INFO - 'LOGNAME': 'cltbld', 06:51:35 INFO - 'MAIL': '/var/mail/cltbld', 06:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:35 INFO - 'MOZ_NO_REMOTE': '1', 06:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:35 INFO - 'NO_EM_RESTART': '1', 06:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:35 INFO - 'PWD': '/builds/slave/test', 06:51:35 INFO - 'SHELL': '/bin/bash', 06:51:35 INFO - 'SHLVL': '1', 06:51:35 INFO - 'TERM': 'linux', 06:51:35 INFO - 'TMOUT': '86400', 06:51:35 INFO - 'USER': 'cltbld', 06:51:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:35 INFO - '_': '/tools/buildbot/bin/python'} 06:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:35 INFO - Running setup.py (path:/tmp/pip-MPXLQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:35 INFO - Running setup.py (path:/tmp/pip-V0XlId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:35 INFO - Running setup.py (path:/tmp/pip-St8AJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:35 INFO - Running setup.py (path:/tmp/pip-6ffbSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:35 INFO - Running setup.py (path:/tmp/pip-xn0CC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:35 INFO - Running setup.py (path:/tmp/pip-Qm4Ygb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:35 INFO - Running setup.py (path:/tmp/pip-d2EfHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:35 INFO - Running setup.py (path:/tmp/pip-mUXpye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:35 INFO - Running setup.py (path:/tmp/pip-NVNwt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:35 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)) 06:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:35 INFO - Running setup.py (path:/tmp/pip-wIMVua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:36 INFO - Running setup.py (path:/tmp/pip-5MlQhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:36 INFO - Running setup.py (path:/tmp/pip-3XbppC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:36 INFO - Running setup.py (path:/tmp/pip-GqkDf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:36 INFO - Running setup.py (path:/tmp/pip-45JOO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:36 INFO - Running setup.py (path:/tmp/pip-UaWXCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:36 INFO - Running setup.py (path:/tmp/pip-x1ZEbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:36 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)) 06:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:36 INFO - Running setup.py (path:/tmp/pip-7rNfLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:36 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)) 06:51:36 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)) 06:51:36 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)) 06:51:36 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)) 06:51:36 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)) 06:51:36 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)) 06:51:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:38 INFO - Downloading blessings-1.6.tar.gz 06:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:38 INFO - Installing collected packages: blessings 06:51:38 INFO - Running setup.py install for blessings 06:51:38 INFO - Successfully installed blessings 06:51:38 INFO - Cleaning up... 06:51:38 INFO - Return code: 0 06:51:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:38 INFO - Reading from file tmpfile_stdout 06:51:38 INFO - Current package versions: 06:51:38 INFO - argparse == 1.2.1 06:51:38 INFO - blessings == 1.6 06:51:38 INFO - blobuploader == 1.2.4 06:51:38 INFO - docopt == 0.6.1 06:51:38 INFO - functools32 == 3.2.3-2 06:51:38 INFO - jsonschema == 2.5.1 06:51:38 INFO - manifestparser == 1.1 06:51:39 INFO - mozInstall == 1.12 06:51:39 INFO - mozcrash == 1.0 06:51:39 INFO - mozdebug == 0.1 06:51:39 INFO - mozdevice == 0.49 06:51:39 INFO - mozfile == 1.2 06:51:39 INFO - mozhttpd == 0.7 06:51:39 INFO - mozinfo == 0.9 06:51:39 INFO - mozleak == 0.1 06:51:39 INFO - mozlog == 3.4 06:51:39 INFO - moznetwork == 0.27 06:51:39 INFO - mozprocess == 0.23 06:51:39 INFO - mozprofile == 0.28 06:51:39 INFO - mozrunner == 6.13 06:51:39 INFO - mozscreenshot == 0.1 06:51:39 INFO - mozsystemmonitor == 0.3 06:51:39 INFO - moztest == 0.7 06:51:39 INFO - mozversion == 1.4 06:51:39 INFO - psutil == 3.1.1 06:51:39 INFO - requests == 1.2.3 06:51:39 INFO - wsgiref == 0.1.2 06:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 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 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:39 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 06:51:39 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 06:51:39 INFO - Using env: {'DISPLAY': ':0', 06:51:39 INFO - 'HOME': '/home/cltbld', 06:51:39 INFO - 'LANG': 'en_US.UTF-8', 06:51:39 INFO - 'LANGUAGE': 'en_US:en', 06:51:39 INFO - 'LOGNAME': 'cltbld', 06:51:39 INFO - 'MAIL': '/var/mail/cltbld', 06:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:39 INFO - 'MOZ_NO_REMOTE': '1', 06:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:39 INFO - 'NO_EM_RESTART': '1', 06:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:39 INFO - 'PWD': '/builds/slave/test', 06:51:39 INFO - 'SHELL': '/bin/bash', 06:51:39 INFO - 'SHLVL': '1', 06:51:39 INFO - 'TERM': 'linux', 06:51:39 INFO - 'TMOUT': '86400', 06:51:39 INFO - 'USER': 'cltbld', 06:51:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:39 INFO - '_': '/tools/buildbot/bin/python'} 06:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 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)) 06:51:39 INFO - Cleaning up... 06:51:39 INFO - Return code: 0 06:51:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bf8e90e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e9130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', '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 06:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:51:39 INFO - Using env: {'DISPLAY': ':0', 06:51:39 INFO - 'HOME': '/home/cltbld', 06:51:39 INFO - 'LANG': 'en_US.UTF-8', 06:51:39 INFO - 'LANGUAGE': 'en_US:en', 06:51:39 INFO - 'LOGNAME': 'cltbld', 06:51:39 INFO - 'MAIL': '/var/mail/cltbld', 06:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:39 INFO - 'MOZ_NO_REMOTE': '1', 06:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:39 INFO - 'NO_EM_RESTART': '1', 06:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:39 INFO - 'PWD': '/builds/slave/test', 06:51:39 INFO - 'SHELL': '/bin/bash', 06:51:39 INFO - 'SHLVL': '1', 06:51:39 INFO - 'TERM': 'linux', 06:51:39 INFO - 'TMOUT': '86400', 06:51:39 INFO - 'USER': 'cltbld', 06:51:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:39 INFO - '_': '/tools/buildbot/bin/python'} 06:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:51:39 INFO - Cleaning up... 06:51:39 INFO - Return code: 0 06:51:39 INFO - Running post-action listener: _resource_record_post_action 06:51:39 INFO - Running post-action listener: _start_resource_monitoring 06:51:39 INFO - Starting resource monitoring. 06:51:39 INFO - [mozharness: 2016-12-01 14:51:39.508333Z] Finished create-virtualenv step (success) 06:51:39 INFO - [mozharness: 2016-12-01 14:51:39.508854Z] Running install step. 06:51:39 INFO - Running pre-action listener: _resource_record_pre_action 06:51:39 INFO - Running main action method: install 06:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:39 INFO - Reading from file tmpfile_stdout 06:51:39 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:39 INFO - Reading from file tmpfile_stdout 06:51:39 INFO - Output received: 06:51:39 INFO - Usage: mozinstall [options] installer 06:51:39 INFO - Options: 06:51:39 INFO - -h, --help show this help message and exit 06:51:39 INFO - -d DEST, --destination=DEST 06:51:39 INFO - Directory to install application into. [default: 06:51:39 INFO - "/builds/slave/test"] 06:51:39 INFO - --app=APP Application being installed. [default: firefox] 06:51:39 INFO - mkdir: /builds/slave/test/build/application 06:51:39 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'] 06:51:39 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 06:51:56 INFO - Reading from file tmpfile_stdout 06:51:56 INFO - Output received: 06:51:56 INFO - /builds/slave/test/build/application/firefox/firefox 06:51:56 INFO - Running post-action listener: _resource_record_post_action 06:51:56 INFO - [mozharness: 2016-12-01 14:51:56.793329Z] Finished install step (success) 06:51:56 INFO - [mozharness: 2016-12-01 14:51:56.793596Z] Running run-tests step. 06:51:56 INFO - Running pre-action listener: _resource_record_pre_action 06:51:56 INFO - Running main action method: run_tests 06:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:51:56 INFO - Python 2.7.3 06:51:56 INFO - Return code: 0 06:51:56 INFO - grabbing minidump binary from tooltool 06:51: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')]} 06:51:56 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 0x2677fc0>, '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 0x2678ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2679350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:51:56 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 06:51:56 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 06:51:56 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 06:51:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:56 INFO - Return code: 0 06:51:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:51:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:51:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:51:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:51:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:51:56 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/1480592041/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 06:51:56 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/1480592041/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 06:51:56 INFO - Using env: {'DISPLAY': ':0', 06:51:56 INFO - 'HOME': '/home/cltbld', 06:51:56 INFO - 'LANG': 'en_US.UTF-8', 06:51:56 INFO - 'LANGUAGE': 'en_US:en', 06:51:56 INFO - 'LOGNAME': 'cltbld', 06:51:56 INFO - 'MAIL': '/var/mail/cltbld', 06:51:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:56 INFO - 'MOZ_NO_REMOTE': '1', 06:51:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:56 INFO - 'NO_EM_RESTART': '1', 06:51:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:56 INFO - 'PWD': '/builds/slave/test', 06:51:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:56 INFO - 'SHELL': '/bin/bash', 06:51:56 INFO - 'SHLVL': '1', 06:51:56 INFO - 'TERM': 'linux', 06:51:56 INFO - 'TMOUT': '86400', 06:51:56 INFO - 'USER': 'cltbld', 06:51:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467', 06:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:56 INFO - '_': '/tools/buildbot/bin/python'} 06:51:56 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/1480592041/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 06:51:57 INFO - mozversion application_buildid: 20161201033401 06:51:57 INFO - mozversion application_changeset: 29fd1259e299250eb26e4c83dbef8c55de612305 06:51:57 INFO - mozversion application_display_name: Nightly 06:51:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:57 INFO - mozversion application_name: Firefox 06:51:57 INFO - mozversion application_remotingname: firefox 06:51:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:51:57 INFO - mozversion application_vendor: Mozilla 06:51:57 INFO - mozversion application_version: 53.0a1 06:51:57 INFO - mozversion platform_buildid: 20161201033401 06:51:57 INFO - mozversion platform_changeset: 29fd1259e299250eb26e4c83dbef8c55de612305 06:51:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:51:57 INFO - mozversion platform_version: 53.0a1 06:51:57 INFO - using testdate: 1480603917 06:51:57 INFO - actual date: 1480603917 06:51:57 INFO - starting webserver on 'localhost:37932' 06:51:57 INFO - SUITE-START | Running 2 tests 06:51:57 INFO - TEST-START | dromaeo_css 06:51:57 INFO - operating with platform_type : linux_ 06:51:57 INFO - Initialising browser for dromaeo_css test... 06:51:57 INFO - TEST-INFO | started process 21183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65ooXH/profile http://localhost:37932/getInfo.html) 06:52:01 INFO - PROCESS | 21183 | __metrics Screen width/height:1600/1200 06:52:01 INFO - PROCESS | 21183 | colorDepth:24 06:52:01 INFO - PROCESS | 21183 | Browser inner width/height: 1024/697 06:52:01 INFO - PROCESS | 21183 | __metrics 06:52:02 INFO - PROCESS | 21183 | 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" 06:52:02 INFO - PROCESS | 21183 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:52:03 INFO - PROCESS | 21183 | console.error: PushService: 06:52:03 INFO - PROCESS | 21183 | stateChangeProcessEnqueue: Error transitioning state 06:52:03 INFO - PROCESS | 21183 | UnknownError 06:52:03 INFO - TEST-INFO | 21183: exit 0 06:52:03 INFO - Browser initialized. 06:52:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:03 INFO - TEST-INFO | started process 21268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65ooXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:16 INFO - PROCESS | 21268 | RSS: Main: 173248512 06:52:16 INFO - PROCESS | 21268 | 06:53:07 INFO - PROCESS | 21268 | 1480603987537 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] 06:55:17 INFO - PROCESS | 21268 | Cycle 1(1): loaded http://localhost:37932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37932/tests/dromaeo/cssquery-ext.html) 06:55:19 INFO - PROCESS | 21268 | RSS: Main: 280584192 06:55:19 INFO - PROCESS | 21268 | 06:58:22 INFO - PROCESS | 21268 | Cycle 1(1): loaded http://localhost:37932/tests/dromaeo/cssquery-ext.html (next: http://localhost:37932/tests/dromaeo/cssquery-jquery.html) 06:58:23 INFO - PROCESS | 21268 | RSS: Main: 280780800 06:58:23 INFO - PROCESS | 21268 | 07:01:25 INFO - PROCESS | 21268 | Cycle 1(1): loaded http://localhost:37932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37932/tests/dromaeo/cssquery-mootools.html) 07:01:25 INFO - PROCESS | 21268 | RSS: Main: 220614656 07:01:25 INFO - PROCESS | 21268 | 07:04:27 INFO - PROCESS | 21268 | Cycle 1(1): loaded http://localhost:37932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37932/tests/dromaeo/cssquery-prototype.html) 07:04:28 INFO - PROCESS | 21268 | RSS: Main: 269733888 07:04:28 INFO - PROCESS | 21268 | 07:07:31 INFO - PROCESS | 21268 | Cycle 1(1): loaded http://localhost:37932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37932/tests/dromaeo/cssquery-yui.html) 07:07:31 INFO - PROCESS | 21268 | RSS: Main: 222773248 07:07:31 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | Cycle 1(1): loaded http://localhost:37932/tests/dromaeo/cssquery-yui.html (next: http://localhost:37932/tests/dromaeo/cssquery-dojo.html) 07:10:34 INFO - PROCESS | 21268 | RSS: Main: 318517248 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | __start_tp_report 07:10:34 INFO - PROCESS | 21268 | _x_x_mozilla_page_load 07:10:34 INFO - PROCESS | 21268 | _x_x_mozilla_page_load_details 07:10:34 INFO - PROCESS | 21268 | |i|pagename|runs| 07:10:34 INFO - PROCESS | 21268 | |0;dojo.html;3009.8946536871213;3035.7267845893866;3053.54956395712;3063.326068264981;3067.631884173898;5145.511176438242;5214.243934629481;5229.764660590273;5269.420363759983;5314.813981510643;5250.343707036621;5284.392294886089;5361.303030606015;5383.031054410205;5402.027635025694;4819.927701084486;4835.323054772335;4879.902401951958;4893.29047288143;4925.605951523869;4857.24712669535;4872.7563621818945;4947.703137811724;4953.975230123862;4989.525995030466;4699.835505757282;4856.271559266103;4856.660033797635;4918.139325618003;4956.529129732669;4718.386609740746;4770.189067858472;4779.3308936748535;4786.042791441726;4810.759462026919;4784.473707892129;4793.904121917542;4794.256890182028;4796.160671882441;4859.708417494926;5195.636305458619;5231.503007214308;5236.764345604457;5241.213817927303;5241.528262456397;5392.272043274186;5417.729113544307;5568.777248910039;5595.776168953237;5648;5644.604877658566;5656.830295091113;5669.829905102853;5730.312362516483;5731.570132240057;5279;5284.550813180923;5284.6564973277;5286;5288.1538953767595;5655.5475561954945;5689.544836413077;5736.254286942754;5765.509931655856;5821.417858214145;5532.640378375393;5560;5581.665100094007;5607.7476513556985;5629.408912064257;5613.803516876889;5642.351129620146;5662.2639056922335;5665.5467562594895;5668.716564171775;5506.256655351476;5530.198121272473;5601.691906945157;5656.6888821115235;5663.320401551758;5658.434156584391;5683.0338842396895;5696.430356964271;5708.429157084258;5746.42535746422;4404.229259879508;4413.7572433515825;4417.712848664826;4441.422615060022;4484.013517026249;3871.5741268460447;3962.900927476836;3971.384435412516;3986.920261594752;4042.0703238255364;5243.344581927259;5323.281357016831;5350.678959262379;5395.460453954652;5396.9730151348995;5738.196652468658;5738.971305143447;5739.85650358736;5739.971300143473;5774.769009239667;5383.946160538423;5409.648372855751;5420.647657902224;5425.674459532362;5431.375391829911;4764.094821983812;4841.394825646794;4854.101991131582;4884.072026314989;4969.3539839821315;5872.119182122716;5883.735231914574;5886.735096920735;5890.263717035371;5900.1149827526215;5702.173184888251;5705.343885453226;5709.9714501427225;5711.400302968129;5712.80005199816;5825.79609713658;5876.206712093813;5879.588428809942;5890.293164820249;5890.558208134321;5565.415631358811;5569.470900264469;5572.192032155233;5573.749181286933;5582.051051321204;5676.403977582295;5692.686902220252;5697.800576979786;5697.914531281951;5703.116017017369;5486.80796172148;5489.752961116679;5502.284702988586;5549.500544950974;5557.972210138923;5495.477929596682;5532.5020748132865;5536.889262214652;5538.113901775697;5541.944580554143;5353.518183363361;5391.973040134932;5530.198121272312;5534.833954981357;5572.136318870582;5504.944950550604;5540.944590554042;5571.13647384656;5581.386047534686;5630.887382252414;5469.699166545878;5496.477834605706;5501.5323697486165;5502.58730595199;5515.779368825362 07:10:34 INFO - PROCESS | 21268 | |1;ext.html;578.22229101858;584.2113147251209;584.225900681597;589.195747804247;589.5165963909591;31012.844935775316;40996.79501602495;41892.790536047316;41906.161876762526;44174.33738493925;43455;43914.56085439145;43926;43929.34105988413;43935.78032109835;7958.801029974268;8487.363447741429;8644.438111522762;8661.090585488528;8668.219860212579;7980.800479988017;10110.747231319203;10356.482175891175;10365.689029329133;10627.84058239127;10317.742056448575;10365.481725913674;10385.584576616926;10390.792184156313;10391.53238104287;10331;10344.637937672145;10411.84382234271;10419;10422.062014418738;10154.695359139238;10217.642382516651;10219.693409197736;10219.948900255526;10224.795504089876;40660.79669601662;41009;41026.589734102876;41033.58966410357;41105.588944110474;3356.2112903467664;3400.4049291373913;3441.5698037745283;3493.807840568768;3512.5609298837644;28515.714842851514;29982.550261745873;30543.541846872315;30927.226819329695;31637.52543711846;3833.271678381099;3873.612638736132;3900.6294402031763;4073.9388909166387;4134.028503301722;132073.33963330122;132224;132391;132941.6705832939;132974.33512832472;58819.70590147022;59181.40818591845;59210;59221.40778592159;59317.40682593205;61829.690851545456;62039;62067;62124;62129.689351553854;16097.11465869365;16752.748708769377;16771.413000544922;16775.748363774554;16776.245068971926;10488.632897848538;10827.67516974492;11152.386618736047;11258.943705281421;11277.379744113989;18258.63482730338;18669.719954200697;18724.81275187231;18738;18872;6762.526623136333;6954.756583519654;7015.403690686247;7148.392386647193;7181.928180718126;876.3602570123718;986.5807032011367;1021.8007488539663;1068.8022715797447;1120.1095129372006;31011.379772404427;31061.8446907764;31083.378332433225;31126;31752;1081.491698901515;1085.0885256384674;1088.4285749981323;1105.9170562207867;1107.7618312062946;15502.844971550367;16398.180090995404;16444.75332870008;16612.916935415487;16664.333426662797;495132;500117;500591;500593;500886;55984.440155598735;56689.716551416976;56735;56746.71626641923;56796;1205.52984336109;1271.0530654662336;1302.3032677517483;1352.452256835983;1359.238826257299;28108.71891281143;31169.53245701271;31753.523697145025;31868.68131318657;32053.198670033435;49015.137880697446;49575;49583;49601.75199123981;49635.25547116868;290254;290723;292106;293325;293515;27693.584596231474;27821.16536503908;28494.715052849206;28663.856680716464;29739.256518587208;45141.32288015616;45424.640550323646;45605.77197113993;45679.543204567526;47037.76481117709;37538.436923446716;38223.85921833467;38513;39299.07009299047;40360.39459408053;38302.659406920626;38766.61233387743;38776.80611596924;38906.61093389143;39234.60765392309;38784;38814.4177837327;38838.2232355357;38951.41572876466;39064.41403379008;32658.346833063682;34772.18105597674;35187.82406088056;35384.64615353814;35513.289734204656;26610.93556257728;26801;26909.192724218305;27139.72860271372;27143.321416963943 07:10:34 INFO - PROCESS | 21268 | |2;jquery.html;370.63677595955943;391.91573811630514;402.2718878829318;404.5408461396315;422.735790131168;13193.472261109557;15122.924385378072;18225.088745562734;18597.814021859776;18640.34758783443;18153.81846181538;18721.34475293365;18914.243430262773;19039.0480475976;19066.809331906676;5375.381831089436;5492.368377636563;5730.140478928152;5731.799387021455;5736.885262294752;5256.290400795901;5584.776608935637;5616.438356164392;5620.91568626471;5622.32532096149;5359.490848369399;5577.2191893135;5577.498025177733;5581.7209139543065;5582.27430434043;5492.093804522249;5521.696306703129;5557.305336832896;5562.221289019541;5566.387697353288;4819.831305904311;4925.926111108336;4998.125328067574;5002.799888004475;5008;21740.239091631876;21890.671639925415;22042.88978555113;22507.54984900309;22920.656190157162;2432.5621388150125;2471.6416119662726;2685.7582817546318;2693.5151672698908;2935.3688956874375;14019.369128389248;14162.433502659882;14267.357968891425;14529.128252304896;14892.404303827834;1722.0872937343229;1831.9908400458046;1875.5592435777717;1908.2557802457052;1943.1838627776367;79580.60209698972;83118.58440707758;83764.58117709434;83966.58016709877;84723.99999999939;10783.980485464082;10936.398498082683;11033;11145.72135696614;11378.544858205745;15267.847321526864;15272.465463708717;15293.311800968982;15301;15305.311260993281;7409.333160015624;7529.322360987538;7596.924030759732;7699.191584883619;7786.57173855432;6936.7572134975035;6977.93022069783;7019.262977387403;7190.712371505081;7239.095113110861;4669.929951050737;4681.531846815359;4723.7874295656775;4786.856394308176;4807.831725889577;1771.5711874432127;1813.791413987382;1839.5493104189559;1841.5580260737327;1875.7280194372013;932.6455946740195;935.8783358163531;942.072059021863;956.6364781383169;1015.7562185075676;17768.91115544414;19421.90289048574;19431.4170574883;19528.218871245273;19775.505612359808;953.427943234054;956.9665061722945;969.2343048991218;990.7473594233425;996.9651062212788;9957.908839143862;10657.893421065844;10667.359958402365;10727.624533141303;10744.570217191225;321878;323580;447808;450233;451082;83851.16148838433;93276.53361733147;97369.5131524352;98446.5077674607;99445;996.6910257820099;1014.5992333028413;1034.4982683398546;1056.392574269798;1058.4548957287004;16703;16908.23912923946;17322.913385432992;17694.469165925042;18099.72850407271;41767.373489397076;41836.3724544126;41902.37146442745;42471;43128.56871431371;55953.72023139858;56539.434605655064;58938;59443.40556594379;60491;7219.639018049182;8080.4343695940715;8190.877136842833;8254.54599997006;8269.751907442786;12304.815427768412;13141.934290328487;13191.868081319448;13225.0081243909;13285.66785830362;10954.56181752721;11244.66266012021;11265.662030138781;11408.486618102039;12030.699232518908;10507.579696812347;11228.214025018497;11365.886341136484;11398.97409233173;11488;10692.786144277226;10960.342379457257;11107.555697771999;11221.102311815199;11336.489857956576;7228.349448549656;7430.331270185709;7483.850322993619;7531.559874158717;7670.386369090571;9986.400815951067;10646.8402973957;10930.398828064534;11089.778204435705;11260.268082574607 07:10:34 INFO - PROCESS | 21268 | |3;mootools.html;1421.772516397376;1442.7835824626306;1563.4684207369498;1721.5523963769417;1745.1448790092843;7569.432292578051;7842.215778422155;7942.880856787146;8412.41113122081;8418.452800567966;7968;8179.345652347813;8221.218984196492;8396.874046889301;8402.411831171805;2264.909403623853;2293.9770602294016;2295.0360848443693;2298.770122987696;2306.1582522379376;2027.7059826325174;2093.0476633131966;2268.7731226877345;2295.6671282664006;2313.525727225923;2234.6871437998693;2300.470891694911;2300.723913130427;2305.5158416732424;2314.132200424841;2287.965680514794;2288.3249441414655;2311.641695537186;2313.421644588853;2316.9921084328203;2285.897134628946;2289.7366802817724;2315.7452680205165;2318.9072437102495;2332.47519308156;8352.24829765318;8404.915950840536;8459.154084591491;8472.237498625153;8487.872681909776;4994;5123.359580052494;5125.282460455539;5126.948730512684;5133.486651334874;3104.472239719253;3240.1575590346442;3318.0875259303643;3321.7674762766615;3388.8983330500123;1027.1423361493162;1051.8474821150967;1103.586155191803;1105.8783533811354;1134.2117228526179;11725.179237453382;11775.705607359885;11782.175247732663;11782.882171178264;11788.46951887167;4466.932996005063;4574.405327307429;4700.059988002413;4751.382320298409;4760;9731.56207970643;9732.951335243279;9734.610615575439;9735.853962190573;9739.220862331138;5222.843314700565;5226.608004399685;5227.372715274191;5228.2680424740565;5230.660007099526;4750.12122757291;4809.398825146856;4810.494898035726;4828.7102773833685;4877.341558889575;3715.4241092630687;3782;3819.7708137511836;3886.805659717003;3934.1344904121047;1140.3158105136852;1174.3599738142732;1217.0811037666506;1273.7961926091966;1280.3918138884142;796.4584082823619;823.7899335669366;927.6474939522938;932.4172392254841;939.4598106089027;5402.297701298806;5431.2396264522995;5554.750036248379;5594;5607.523360514402;963.4171326347599;972.4165500699523;976.3799987008159;986.6793292180071;999.93000489965;3767.171222331083;3803.4865293185067;3824.1969186470596;3833.597472265372;3847.461355410245;10243.38539687621;10486.632967846088;10607.734806629742;10619.044286014296;10622.097121744739;10509.421981791074;10517.789644207072;10518.053375196116;10543.31468454548;10547.630832920811;7608.733694320672;7876.488028278143;7888.368930485547;7999.240072193249;8011.959940200261;5629;5678.602497825113;5692.373838877803;5728.312602487728;5871.7651293947765;9031.142041506046;9176.6788162414;9200.401973871676;9215.631374744935;9283.535823208678;9305.348625596143;9337;9339.346245762732;9409.106134917172;9426.198773104363;7008.5094043416475;7121.216666166614;7129.82175445618;7130.714771409085;7131.393831524171;7694.461387702807;7776.611169441619;7947.284744373034;8012.559309238048;8150.918490815253;7303.525270857377;7326.194118647051;7402.148752893486;7501.062367204099;7677.193894641206;7232.602206878672;7287.417006639562;7322.597257150908;7371.4102871769055;7373.29953654402;6508.511861610304;6519.771807986698;6713.899291510729;6890.655467226518;6899.413549848319;4656.324832899279;4720.598749106364;4798.448178459382;4807.567318941312;4846.006568653488;4872.756362181947;4972.552470277692;5000.899982000413;5021.874453138701;5089.185730283285 07:10:34 INFO - PROCESS | 21268 | |4;prototype.html;328.5236407209547;333.9833008349582;339.0777086325196;343.7971596757913;344.77245018287937;5120.820771273006;5188.6886786792775;5228.633995620308;5273.446288139748;5328.254044433777;5017.297578339027;5094.566961808241;5107.7701503432345;5120.206368012955;5142.740028692966;4093.5497095319492;4116.650084742801;4121.9587804121875;4131.442255295527;4134.545200027995;3913.8825835224848;4009.9599004010024;4037.839755730685;4136.875893723193;4160.604742549453;4116.361963895601;4125.2780763366445;4133.111381053073;4146.274401979642;4147.813348399314;4081.999910022034;4098.856540021115;4116.897077573055;4143.544210136883;4153.937690934623;3560.038789526839;3651.8721844735305;3657.2868290683327;3662.34077865984;3663.523741913561;5043.831152604379;5055.5702765265;5056.974715126437;5077.492250774893;5082.720450375228;4636.3045543168455;4637.860864174047;4649.48891610228;4667.369905062807;4694.483606803249;5293.258943747878;5406.432324605899;5409.972950135263;5426.701531415771;5426.728663566806;3918.804059797027;3941.3002093565997;3953.6639385652256;3964.464797252363;3975.1254723960683;5615.213870058195;5631.155326700987;5644.745986430579;5654.802081927113;5656.490915817555;4066.3087275163293;4068.06434520062;4080;4099.139180772071;4123.567025462343;4042.6765858731233;4092.1406504633765;4113.91772164555;4121.175764846983;4160.9375859362135;4678.461976872635;4691.225947718588;4692.577668009895;4693.20215563355;4693.718376897397;5493.642913210629;5501.807436739775;5513.421090785409;5515.393306736256;5517.917231241535;1346.4748747988292;1390.7427125981726;1391.5041330569677;1391.6938273579797;1396.1692792788274;950.2682934140673;970.733193182903;976.3604838830578;978.9070038346346;981.5828272983953;5107.917621966168;5109.594861413067;5116.334876466036;5116.820911268088;5126.231065340155;5344.759485823147;5390.380106287827;5392.67879369557;5401.405845357008;5423.2136340230445;4892;5048.192289233705;5081.221572449613;5083.373320537393;5114.41184263807;2858.5283428234525;2868.4693331733697;2872.6840047594746;2875.971240287612;2878.409925965214;5579.721013949286;5590.2453168821685;5596.237185286622;5601.467860553241;5608.186812912187;5222.451642577551;5493.176023596492;5496;5508.283923090053;5510.1459273812625;5436.972815135899;5580.91628625571;5583.860403489945;5597.916031259534;5602.859928501739;5193.779461826392;5313.867153321198;5315.441878602691;5359.464053594766;5403.7838486460105;5231.686098834082;5259.21111833228;5274.235235890697;5278.8944221116135;5326.644214145219;5534.335879694462;5535.501804837584;5546.833594992157;5569.610127291051;5577.581681373832;3840.4815349927403;3948.861789837342;3952.2293152834923;3952.584978577208;3964.5044369453817;5489.666891571146;5512.3660779010925;5518;5553.416891226363;5563.388027317073;5434.184872269191;5436.184572314184;5479.726013699379;5516.4764892787525;5527.640703354269;5258.474152584711;5442.809501667422;5474.302966080528;5477.316894055684;5493.48929044516;5436.293281873332;5461.262729531462;5468.234447177478;5473.425290344616;5479.917801233064;5321.587487078139;5403.8108666196495;5421.783128674809;5445.727713614224;5450.454954504517;5302.693328402157;5353.304070470814;5377.946220537901;5391.899657696762;5406.135018397038 07:10:34 INFO - PROCESS | 21268 | |5;yui.html;708.5413614756795;723.612867116093;759.2748924776839;770.6339488742848;810.7608255564606;14387.42450301988;15973.121478318688;15989.520314390587;16012.919935400321;16022.839771602296;14592.41630334788;14664.706705865876;14680.706385872276;14786;14814.629634259149;643.6588608037747;658.282472105405;756.6670664907423;762.2111114995967;766.3524321947945;758.7723682895137;763.9847203055936;765.1506827421557;765.2385876053335;766.9578173200472;759.305235709328;763.2443880558263;770.6493545436813;783.3537331701341;786.0528063683248;680.5916450129932;699.0458024796117;788.7476007677545;811.0186674124317;812.8211793405442;595.8599729063667;601.0263373335181;601.3625556909647;601.7863658401292;601.8224623736008;14596.781048284285;14722.852771472362;14751.631209219748;14761.926190369088;14773.261336933218;13257.46970121194;13376.665583360495;13450.86549134506;13452.86547134526;13634.386452609657;12229.633111006684;12474.625761227178;12507.124501284914;12812.80780788289;13229.933850330686;4173.332266837322;4192.0777428965575;4255.659547236213;4285.678574106923;4393.033532622818;79455.60272198603;80996.19003809945;81027;82462;82743.58628206821;10831.458427078614;10865.185111116698;10877.83683244752;10905.127589792797;10945.890541094486;20047.899760501397;20064.59224893022;20122.59754804925;20161.798382016284;20176.29382971589;7854.72508462201;7928.801779955547;7971.641276142587;8094.51432914027;8104.756857294291;4259.361095835649;4309.07354918694;4315.719478233905;4409.4488188976375;4431.578999994996;3376.5104059911178;3880;4003.5195776507007;4024.376221685585;4071.246819338432;649.8505343770959;662.1160750398273;666.7666316789085;672.1161672400777;675.0144788608588;673.6227712481026;712.9750458734023;725.0393228971528;727.5852763924618;731.7914394397677;9423.623055077856;9550.761230969281;9710.854337184948;9751.268654850772;9758.75603109928;689.1282527602586;700.7022015643331;715.8675645005691;721.6355740351089;744.765398899345;4226.788660566959;4547.931781023287;4638.118757436144;4661.207594708908;4726.220173671374;80205.19794801978;82007.12975045964;86264.56867715747;87158.56420717982;88357.55821220853;62016.68991655103;66808.33191668119;68838.31161688319;70464.64767676129;73579.63210184022;62155.378446214956;62539.374606253354;63196;64279.35720642827;64422.67788661027;9849.45827979468;10261.127804136731;10476.68569942903;10549.578016879239;10732.839007415052;44629.330560042275;45150.77424612856;45650.54349456596;45830.770846145555;45849;53001;53389.73305133605;54037.72981135226;54794.726026369615;57718.7114064427;13025.674358141123;13195;13195.868041319463;13258.469661213443;13958.720825583228;14282;14399.496017639332;14778.48275310359;14849.703005939604;15975.680486389974;14153.363098660378;14280.42878284857;14532.695566118502;14744.189069600845;15214.16322102295;13737.587872363445;13837.377318020915;14247.572572822832;14584.270786460847;14713.264336782904;12586.748265034465;13550.254735989221;14019.50931717385;14648.560543183721;14679.48621798232;10860.67417977462;10944;11455.656330310105;11583;11661.883381166079;9012.41419307743;9767.120959113714;10011.24915631316;10831.891681083089;11359.432028398713 07:10:34 INFO - PROCESS | 21268 | __end_tp_report 07:10:34 INFO - PROCESS | 21268 | __start_cc_report 07:10:34 INFO - PROCESS | 21268 | _x_x_mozilla_cycle_collect,2422 07:10:34 INFO - PROCESS | 21268 | __end_cc_report 07:10:34 INFO - PROCESS | 21268 | __startTimestamp1480605034856__endTimestamp 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | ------- Summary: start ------- 07:10:34 INFO - PROCESS | 21268 | Number of tests: 6 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | [#0] dojo.html Cycles:165 Average:5270.11 Median:5495.48 stddev:585.62 (10.7%) stddev-sans-first:559.93 07:10:34 INFO - PROCESS | 21268 | Values: 3009.9 3035.7 3053.5 3063.3 3067.6 5145.5 5214.2 5229.8 5269.4 5314.8 5250.3 5284.4 5361.3 5383.0 5402.0 4819.9 4835.3 4879.9 4893.3 4925.6 4857.2 4872.8 4947.7 4954.0 4989.5 4699.8 4856.3 4856.7 4918.1 4956.5 4718.4 4770.2 4779.3 4786.0 4810.8 4784.5 4793.9 4794.3 4796.2 4859.7 5195.6 5231.5 5236.8 5241.2 5241.5 5392.3 5417.7 5568.8 5595.8 5648.0 5644.6 5656.8 5669.8 5730.3 5731.6 5279.0 5284.6 5284.7 5286.0 5288.2 5655.5 5689.5 5736.3 5765.5 5821.4 5532.6 5560.0 5581.7 5607.7 5629.4 5613.8 5642.4 5662.3 5665.5 5668.7 5506.3 5530.2 5601.7 5656.7 5663.3 5658.4 5683.0 5696.4 5708.4 5746.4 4404.2 4413.8 4417.7 4441.4 4484.0 3871.6 3962.9 3971.4 3986.9 4042.1 5243.3 5323.3 5350.7 5395.5 5397.0 5738.2 5739.0 5739.9 5740.0 5774.8 5383.9 5409.6 5420.6 5425.7 5431.4 4764.1 4841.4 4854.1 4884.1 4969.4 5872.1 5883.7 5886.7 5890.3 5900.1 5702.2 5705.3 5710.0 5711.4 5712.8 5825.8 5876.2 5879.6 5890.3 5890.6 5565.4 5569.5 5572.2 5573.7 5582.1 5676.4 5692.7 5697.8 5697.9 5703.1 5486.8 5489.8 5502.3 5549.5 5558.0 5495.5 5532.5 5536.9 5538.1 5541.9 5353.5 5392.0 5530.2 5534.8 5572.1 5504.9 5540.9 5571.1 5581.4 5630.9 5469.7 5496.5 5501.5 5502.6 5515.8 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | [#1] ext.html Cycles:180 Average:48646.12 Median:3420.99 stddev:91406.88 (2671.9%) stddev-sans-first:91592.06 07:10:34 INFO - PROCESS | 21268 | Values: 578.2 584.2 584.2 589.2 589.5 31012.8 40996.8 41892.8 41906.2 44174.3 43455.0 43914.6 43926.0 43929.3 43935.8 7958.8 8487.4 8644.4 8661.1 8668.2 7980.8 10110.7 10356.5 10365.7 10627.8 10317.7 10365.5 10385.6 10390.8 10391.5 10331.0 10344.6 10411.8 10419.0 10422.1 10154.7 10217.6 10219.7 10219.9 10224.8 40660.8 41009.0 41026.6 41033.6 41105.6 3356.2 3400.4 3441.6 3493.8 3512.6 28515.7 29982.6 30543.5 30927.2 31637.5 3833.3 3873.6 3900.6 4073.9 4134.0 132073.3 132224.0 132391.0 132941.7 132974.3 58819.7 59181.4 59210.0 59221.4 59317.4 61829.7 62039.0 62067.0 62124.0 62129.7 16097.1 16752.7 16771.4 16775.7 16776.2 10488.6 10827.7 11152.4 11258.9 11277.4 18258.6 18669.7 18724.8 18738.0 18872.0 6762.5 6954.8 7015.4 7148.4 7181.9 876.4 986.6 1021.8 1068.8 1120.1 31011.4 31061.8 31083.4 31126.0 31752.0 1081.5 1085.1 1088.4 1105.9 1107.8 15502.8 16398.2 16444.8 16612.9 16664.3 495132.0 500117.0 500591.0 500593.0 500886.0 55984.4 56689.7 56735.0 56746.7 56796.0 1205.5 1271.1 1302.3 1352.5 1359.2 28108.7 31169.5 31753.5 31868.7 32053.2 49015.1 49575.0 49583.0 49601.8 49635.3 290254.0 290723.0 292106.0 293325.0 293515.0 27693.6 27821.2 28494.7 28663.9 29739.3 45141.3 45424.6 45605.8 45679.5 47037.8 37538.4 38223.9 38513.0 39299.1 40360.4 38302.7 38766.6 38776.8 38906.6 39234.6 38784.0 38814.4 38838.2 38951.4 39064.4 32658.3 34772.2 35187.8 35384.6 35513.3 26610.9 26801.0 26909.2 27139.7 27143.3 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | [#2] jquery.html Cycles:180 Average:26435.58 Median:381.28 stddev:67360.50 (17667.1%) stddev-sans-first:67521.03 07:10:34 INFO - PROCESS | 21268 | Values: 370.6 391.9 402.3 404.5 422.7 13193.5 15122.9 18225.1 18597.8 18640.3 18153.8 18721.3 18914.2 19039.0 19066.8 5375.4 5492.4 5730.1 5731.8 5736.9 5256.3 5584.8 5616.4 5620.9 5622.3 5359.5 5577.2 5577.5 5581.7 5582.3 5492.1 5521.7 5557.3 5562.2 5566.4 4819.8 4925.9 4998.1 5002.8 5008.0 21740.2 21890.7 22042.9 22507.5 22920.7 2432.6 2471.6 2685.8 2693.5 2935.4 14019.4 14162.4 14267.4 14529.1 14892.4 1722.1 1832.0 1875.6 1908.3 1943.2 79580.6 83118.6 83764.6 83966.6 84724.0 10784.0 10936.4 11033.0 11145.7 11378.5 15267.8 15272.5 15293.3 15301.0 15305.3 7409.3 7529.3 7596.9 7699.2 7786.6 6936.8 6977.9 7019.3 7190.7 7239.1 4669.9 4681.5 4723.8 4786.9 4807.8 1771.6 1813.8 1839.5 1841.6 1875.7 932.6 935.9 942.1 956.6 1015.8 17768.9 19421.9 19431.4 19528.2 19775.5 953.4 957.0 969.2 990.7 997.0 9957.9 10657.9 10667.4 10727.6 10744.6 321878.0 323580.0 447808.0 450233.0 451082.0 83851.2 93276.5 97369.5 98446.5 99445.0 996.7 1014.6 1034.5 1056.4 1058.5 16703.0 16908.2 17322.9 17694.5 18099.7 41767.4 41836.4 41902.4 42471.0 43128.6 55953.7 56539.4 58938.0 59443.4 60491.0 7219.6 8080.4 8190.9 8254.5 8269.8 12304.8 13141.9 13191.9 13225.0 13285.7 10954.6 11244.7 11265.7 11408.5 12030.7 10507.6 11228.2 11365.9 11399.0 11488.0 10692.8 10960.3 11107.6 11221.1 11336.5 7228.3 7430.3 7483.9 7531.6 7670.4 9986.4 10646.8 10930.4 11089.8 11260.3 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | [#3] mootools.html Cycles:180 Average:5528.02 Median:5106.27 stddev:3087.74 (60.5%) stddev-sans-first:3080.98 07:10:34 INFO - PROCESS | 21268 | Values: 1421.8 1442.8 1563.5 1721.6 1745.1 7569.4 7842.2 7942.9 8412.4 8418.5 7968.0 8179.3 8221.2 8396.9 8402.4 2264.9 2294.0 2295.0 2298.8 2306.2 2027.7 2093.0 2268.8 2295.7 2313.5 2234.7 2300.5 2300.7 2305.5 2314.1 2288.0 2288.3 2311.6 2313.4 2317.0 2285.9 2289.7 2315.7 2318.9 2332.5 8352.2 8404.9 8459.2 8472.2 8487.9 4994.0 5123.4 5125.3 5126.9 5133.5 3104.5 3240.2 3318.1 3321.8 3388.9 1027.1 1051.8 1103.6 1105.9 1134.2 11725.2 11775.7 11782.2 11782.9 11788.5 4466.9 4574.4 4700.1 4751.4 4760.0 9731.6 9733.0 9734.6 9735.9 9739.2 5222.8 5226.6 5227.4 5228.3 5230.7 4750.1 4809.4 4810.5 4828.7 4877.3 3715.4 3782.0 3819.8 3886.8 3934.1 1140.3 1174.4 1217.1 1273.8 1280.4 796.5 823.8 927.6 932.4 939.5 5402.3 5431.2 5554.8 5594.0 5607.5 963.4 972.4 976.4 986.7 999.9 3767.2 3803.5 3824.2 3833.6 3847.5 10243.4 10486.6 10607.7 10619.0 10622.1 10509.4 10517.8 10518.1 10543.3 10547.6 7608.7 7876.5 7888.4 7999.2 8012.0 5629.0 5678.6 5692.4 5728.3 5871.8 9031.1 9176.7 9200.4 9215.6 9283.5 9305.3 9337.0 9339.3 9409.1 9426.2 7008.5 7121.2 7129.8 7130.7 7131.4 7694.5 7776.6 7947.3 8012.6 8150.9 7303.5 7326.2 7402.1 7501.1 7677.2 7232.6 7287.4 7322.6 7371.4 7373.3 6508.5 6519.8 6713.9 6890.7 6899.4 4656.3 4720.6 4798.4 4807.6 4846.0 4872.8 4972.6 5000.9 5021.9 5089.2 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | [#4] prototype.html Cycles:180 Average:4554.15 Median:5165.71 stddev:1307.93 (25.3%) stddev-sans-first:1272.56 07:10:34 INFO - PROCESS | 21268 | Values: 328.5 334.0 339.1 343.8 344.8 5120.8 5188.7 5228.6 5273.4 5328.3 5017.3 5094.6 5107.8 5120.2 5142.7 4093.5 4116.7 4122.0 4131.4 4134.5 3913.9 4010.0 4037.8 4136.9 4160.6 4116.4 4125.3 4133.1 4146.3 4147.8 4082.0 4098.9 4116.9 4143.5 4153.9 3560.0 3651.9 3657.3 3662.3 3663.5 5043.8 5055.6 5057.0 5077.5 5082.7 4636.3 4637.9 4649.5 4667.4 4694.5 5293.3 5406.4 5410.0 5426.7 5426.7 3918.8 3941.3 3953.7 3964.5 3975.1 5615.2 5631.2 5644.7 5654.8 5656.5 4066.3 4068.1 4080.0 4099.1 4123.6 4042.7 4092.1 4113.9 4121.2 4160.9 4678.5 4691.2 4692.6 4693.2 4693.7 5493.6 5501.8 5513.4 5515.4 5517.9 1346.5 1390.7 1391.5 1391.7 1396.2 950.3 970.7 976.4 978.9 981.6 5107.9 5109.6 5116.3 5116.8 5126.2 5344.8 5390.4 5392.7 5401.4 5423.2 4892.0 5048.2 5081.2 5083.4 5114.4 2858.5 2868.5 2872.7 2876.0 2878.4 5579.7 5590.2 5596.2 5601.5 5608.2 5222.5 5493.2 5496.0 5508.3 5510.1 5437.0 5580.9 5583.9 5597.9 5602.9 5193.8 5313.9 5315.4 5359.5 5403.8 5231.7 5259.2 5274.2 5278.9 5326.6 5534.3 5535.5 5546.8 5569.6 5577.6 3840.5 3948.9 3952.2 3952.6 3964.5 5489.7 5512.4 5518.0 5553.4 5563.4 5434.2 5436.2 5479.7 5516.5 5527.6 5258.5 5442.8 5474.3 5477.3 5493.5 5436.3 5461.3 5468.2 5473.4 5479.9 5321.6 5403.8 5421.8 5445.7 5450.5 5302.7 5353.3 5377.9 5391.9 5406.1 07:10:34 INFO - PROCESS | 21268 | 07:10:34 INFO - PROCESS | 21268 | [#5] yui.html Cycles:180 Average:17885.71 Median:25099.24 stddev:23139.38 (92.2%) stddev-sans-first:23168.34 07:10:34 INFO - PROCESS | 21268 | Values: 708.5 723.6 759.3 770.6 810.8 14387.4 15973.1 15989.5 16012.9 16022.8 14592.4 14664.7 14680.7 14786.0 14814.6 643.7 658.3 756.7 762.2 766.4 758.8 764.0 765.2 765.2 767.0 759.3 763.2 770.6 783.4 786.1 680.6 699.0 788.7 811.0 812.8 595.9 601.0 601.4 601.8 601.8 14596.8 14722.9 14751.6 14761.9 14773.3 13257.5 13376.7 13450.9 13452.9 13634.4 12229.6 12474.6 12507.1 12812.8 13229.9 4173.3 4192.1 4255.7 4285.7 4393.0 79455.6 80996.2 81027.0 82462.0 82743.6 10831.5 10865.2 10877.8 10905.1 10945.9 20047.9 20064.6 20122.6 20161.8 20176.3 7854.7 7928.8 7971.6 8094.5 8104.8 4259.4 4309.1 4315.7 4409.4 4431.6 3376.5 3880.0 4003.5 4024.4 4071.2 649.9 662.1 666.8 672.1 675.0 673.6 713.0 725.0 727.6 731.8 9423.6 9550.8 9710.9 9751.3 9758.8 689.1 700.7 715.9 721.6 744.8 4226.8 4547.9 4638.1 4661.2 4726.2 80205.2 82007.1 86264.6 87158.6 88357.6 62016.7 66808.3 68838.3 70464.6 73579.6 62155.4 62539.4 63196.0 64279.4 64422.7 9849.5 10261.1 10476.7 10549.6 10732.8 44629.3 45150.8 45650.5 45830.8 45849.0 53001.0 53389.7 54037.7 54794.7 57718.7 13025.7 13195.0 13195.9 13258.5 13958.7 14282.0 14399.5 14778.5 14849.7 15975.7 14153.4 14280.4 14532.7 14744.2 15214.2 13737.6 13837.4 14247.6 14584.3 14713.3 12586.7 13550.3 14019.5 14648.6 14679.5 10860.7 10944.0 11455.7 11583.0 11661.9 9012.4 9767.1 10011.2 10831.9 11359.4 07:10:34 INFO - PROCESS | 21268 | -------- Summary: end -------- 07:10:34 INFO - PROCESS | 21268 | 07:10:35 INFO - TEST-INFO | 21268: exit 0 07:10:35 INFO - TEST-OK | dromaeo_css | took 1118741ms 07:10:35 INFO - TEST-START | kraken 07:10:35 INFO - operating with platform_type : linux_ 07:10:35 INFO - Initialising browser for kraken test... 07:10:35 INFO - TEST-INFO | started process 21576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJkA7h/profile http://localhost:37932/getInfo.html) 07:10:40 INFO - PROCESS | 21576 | __metrics Screen width/height:1600/1200 07:10:40 INFO - PROCESS | 21576 | colorDepth:24 07:10:40 INFO - PROCESS | 21576 | Browser inner width/height: 1024/697 07:10:40 INFO - PROCESS | 21576 | __metrics 07:10:41 INFO - PROCESS | 21576 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:10:41 INFO - PROCESS | 21576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:42 INFO - PROCESS | 21576 | console.error: PushService: 07:10:42 INFO - PROCESS | 21576 | stateChangeProcessEnqueue: Error transitioning state 07:10:42 INFO - PROCESS | 21576 | UnknownError 07:10:42 INFO - TEST-INFO | 21576: exit 0 07:10:42 INFO - Browser initialized. 07:10:42 INFO - Running cycle 1/1 for kraken test... 07:10:42 INFO - TEST-INFO | started process 21663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJkA7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:54 INFO - PROCESS | 21663 | RSS: Main: 173740032 07:10:54 INFO - PROCESS | 21663 | 07:10:57 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37932/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:58 INFO - PROCESS | 21663 | RSS: Main: 235237376 07:10:58 INFO - PROCESS | 21663 | 07:11:00 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37932/tests/kraken/driver.html?testName=audio-dft) 07:11:01 INFO - PROCESS | 21663 | RSS: Main: 217362432 07:11:01 INFO - PROCESS | 21663 | 07:11:04 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37932/tests/kraken/driver.html?testName=audio-fft) 07:11:05 INFO - PROCESS | 21663 | RSS: Main: 298897408 07:11:05 INFO - PROCESS | 21663 | 07:11:07 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37932/tests/kraken/driver.html?testName=audio-oscillator) 07:11:07 INFO - PROCESS | 21663 | RSS: Main: 210157568 07:11:07 INFO - PROCESS | 21663 | 07:11:10 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:10 INFO - PROCESS | 21663 | RSS: Main: 213221376 07:11:10 INFO - PROCESS | 21663 | 07:11:13 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37932/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:14 INFO - PROCESS | 21663 | RSS: Main: 252727296 07:11:14 INFO - PROCESS | 21663 | 07:11:17 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37932/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:18 INFO - PROCESS | 21663 | RSS: Main: 253026304 07:11:18 INFO - PROCESS | 21663 | 07:11:20 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37932/tests/kraken/driver.html?testName=json-parse-financial) 07:11:21 INFO - PROCESS | 21663 | RSS: Main: 251666432 07:11:21 INFO - PROCESS | 21663 | 07:11:23 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:23 INFO - PROCESS | 21663 | RSS: Main: 213786624 07:11:23 INFO - PROCESS | 21663 | 07:11:25 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:26 INFO - PROCESS | 21663 | RSS: Main: 221175808 07:11:26 INFO - PROCESS | 21663 | 07:11:28 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:28 INFO - PROCESS | 21663 | RSS: Main: 229531648 07:11:28 INFO - PROCESS | 21663 | 07:11:31 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:32 INFO - PROCESS | 21663 | RSS: Main: 238530560 07:11:32 INFO - PROCESS | 21663 | 07:11:35 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:35 INFO - PROCESS | 21663 | RSS: Main: 235851776 07:11:35 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:37932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37932/tests/kraken/driver.html?testName=ai-astar) 07:11:37 INFO - PROCESS | 21663 | RSS: Main: 286666752 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | __start_tp_report 07:11:37 INFO - PROCESS | 21663 | _x_x_mozilla_page_load 07:11:37 INFO - PROCESS | 21663 | _x_x_mozilla_page_load_details 07:11:37 INFO - PROCESS | 21663 | |i|pagename|runs| 07:11:37 INFO - PROCESS | 21663 | |0;ai-astar;112;112;113;110;113;113;113;111;112;114 07:11:37 INFO - PROCESS | 21663 | |1;audio-beat-detection;155;122;124;168;126;125;124;122;143;124 07:11:37 INFO - PROCESS | 21663 | |2;audio-dft;162;162;161;161;161;161;162;162;162;160 07:11:37 INFO - PROCESS | 21663 | |3;audio-fft;76;75;74;112;79;77;76;76;92;76 07:11:37 INFO - PROCESS | 21663 | |4;audio-oscillator;83;83;111;83;82;83;104;85;86;110 07:11:37 INFO - PROCESS | 21663 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;117;117 07:11:37 INFO - PROCESS | 21663 | |6;imaging-darkroom;145;145;146;146;147;147;146;146;146;146 07:11:37 INFO - PROCESS | 21663 | |7;imaging-desaturate;95;95;96;96;96;95;96;96;96;96 07:11:37 INFO - PROCESS | 21663 | |8;json-parse-financial;50;52;52;51;52;53;52;53;52;53 07:11:37 INFO - PROCESS | 21663 | |9;json-stringify-tinderbox;63;63;62;63;64;63;64;62;63;63 07:11:37 INFO - PROCESS | 21663 | |10;stanford-crypto-aes;84;86;80;80;81;81;80;79;80;81 07:11:37 INFO - PROCESS | 21663 | |11;stanford-crypto-ccm;143;132;140;144;129;138;131;130;178;157 07:11:37 INFO - PROCESS | 21663 | |12;stanford-crypto-pbkdf2;171;173;174;166;167;165;166;167;167;164 07:11:37 INFO - PROCESS | 21663 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;66;71;65;65;66 07:11:37 INFO - PROCESS | 21663 | __end_tp_report 07:11:37 INFO - PROCESS | 21663 | __start_cc_report 07:11:37 INFO - PROCESS | 21663 | _x_x_mozilla_cycle_collect,1677 07:11:37 INFO - PROCESS | 21663 | __end_cc_report 07:11:37 INFO - PROCESS | 21663 | __startTimestamp1480605097559__endTimestamp 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | ------- Summary: start ------- 07:11:37 INFO - PROCESS | 21663 | Number of tests: 14 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 07:11:37 INFO - PROCESS | 21663 | Values: 112.0 112.0 113.0 110.0 113.0 113.0 113.0 111.0 112.0 114.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:125.50 stddev:16.35 (13.0%) stddev-sans-first:15.34 07:11:37 INFO - PROCESS | 21663 | Values: 155.0 122.0 124.0 168.0 126.0 125.0 124.0 122.0 143.0 124.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 07:11:37 INFO - PROCESS | 21663 | Values: 162.0 162.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 160.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.95 (15.7%) stddev-sans-first:12.52 07:11:37 INFO - PROCESS | 21663 | Values: 76.0 75.0 74.0 112.0 79.0 77.0 76.0 76.0 92.0 76.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:12.15 (14.6%) stddev-sans-first:12.53 07:11:37 INFO - PROCESS | 21663 | Values: 83.0 83.0 111.0 83.0 82.0 83.0 104.0 85.0 86.0 110.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:11:37 INFO - PROCESS | 21663 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 07:11:37 INFO - PROCESS | 21663 | Values: 145.0 145.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:11:37 INFO - PROCESS | 21663 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:0.67 07:11:37 INFO - PROCESS | 21663 | Values: 50.0 52.0 52.0 51.0 52.0 53.0 52.0 53.0 52.0 53.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 07:11:37 INFO - PROCESS | 21663 | Values: 63.0 63.0 62.0 63.0 64.0 63.0 64.0 62.0 63.0 63.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.15 (2.7%) stddev-sans-first:2.03 07:11:37 INFO - PROCESS | 21663 | Values: 84.0 86.0 80.0 80.0 81.0 81.0 80.0 79.0 80.0 81.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:141.50 stddev:15.20 (10.7%) stddev-sans-first:16.12 07:11:37 INFO - PROCESS | 21663 | Values: 143.0 132.0 140.0 144.0 129.0 138.0 131.0 130.0 178.0 157.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:167.00 stddev:3.43 (2.1%) stddev-sans-first:3.46 07:11:37 INFO - PROCESS | 21663 | Values: 171.0 173.0 174.0 166.0 167.0 165.0 166.0 167.0 167.0 164.0 07:11:37 INFO - PROCESS | 21663 | 07:11:37 INFO - PROCESS | 21663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.71 (2.6%) stddev-sans-first:1.81 07:11:37 INFO - PROCESS | 21663 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 71.0 65.0 65.0 66.0 07:11:37 INFO - PROCESS | 21663 | -------- Summary: end -------- 07:11:37 INFO - PROCESS | 21663 | 07:11:38 INFO - TEST-INFO | 21663: exit 0 07:11:38 INFO - TEST-OK | kraken | took 62973ms 07:11:38 INFO - SUITE-END | took 1181s 07:11:39 INFO - Completed test suite (00:19:42) 07:11:39 INFO - javascript benchmark 07:11:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.8946536871213, 3035.7267845893866, 3053.54956395712, 3063.326068264981, 3067.631884173898, 5145.511176438242, 5214.243934629481, 5229.764660590273, 5269.420363759983, 5314.813981510643, 5250.343707036621, 5284.392294886089, 5361.303030606015, 5383.031054410205, 5402.027635025694, 4819.927701084486, 4835.323054772335, 4879.902401951958, 4893.29047288143, 4925.605951523869, 4857.24712669535, 4872.7563621818945, 4947.703137811724, 4953.975230123862, 4989.525995030466, 4699.835505757282, 4856.271559266103, 4856.660033797635, 4918.139325618003, 4956.529129732669, 4718.386609740746, 4770.189067858472, 4779.3308936748535, 4786.042791441726, 4810.759462026919, 4784.473707892129, 4793.904121917542, 4794.256890182028, 4796.160671882441, 4859.708417494926, 5195.636305458619, 5231.503007214308, 5236.764345604457, 5241.213817927303, 5241.528262456397, 5392.272043274186, 5417.729113544307, 5568.777248910039, 5595.776168953237, 5648.0, 5644.604877658566, 5656.830295091113, 5669.829905102853, 5730.312362516483, 5731.570132240057, 5279.0, 5284.550813180923, 5284.6564973277, 5286.0, 5288.1538953767595, 5655.5475561954945, 5689.544836413077, 5736.254286942754, 5765.509931655856, 5821.417858214145, 5532.640378375393, 5560.0, 5581.665100094007, 5607.7476513556985, 5629.408912064257, 5613.803516876889, 5642.351129620146, 5662.2639056922335, 5665.5467562594895, 5668.716564171775, 5506.256655351476, 5530.198121272473, 5601.691906945157, 5656.6888821115235, 5663.320401551758, 5658.434156584391, 5683.0338842396895, 5696.430356964271, 5708.429157084258, 5746.42535746422, 4404.229259879508, 4413.7572433515825, 4417.712848664826, 4441.422615060022, 4484.013517026249, 3871.5741268460447, 3962.900927476836, 3971.384435412516, 3986.920261594752, 4042.0703238255364, 5243.344581927259, 5323.281357016831, 5350.678959262379, 5395.460453954652, 5396.9730151348995, 5738.196652468658, 5738.971305143447, 5739.85650358736, 5739.971300143473, 5774.769009239667, 5383.946160538423, 5409.648372855751, 5420.647657902224, 5425.674459532362, 5431.375391829911, 4764.094821983812, 4841.394825646794, 4854.101991131582, 4884.072026314989, 4969.3539839821315, 5872.119182122716, 5883.735231914574, 5886.735096920735, 5890.263717035371, 5900.1149827526215, 5702.173184888251, 5705.343885453226, 5709.9714501427225, 5711.400302968129, 5712.80005199816, 5825.79609713658, 5876.206712093813, 5879.588428809942, 5890.293164820249, 5890.558208134321, 5565.415631358811, 5569.470900264469, 5572.192032155233, 5573.749181286933, 5582.051051321204, 5676.403977582295, 5692.686902220252, 5697.800576979786, 5697.914531281951, 5703.116017017369, 5486.80796172148, 5489.752961116679, 5502.284702988586, 5549.500544950974, 5557.972210138923, 5495.477929596682, 5532.5020748132865, 5536.889262214652, 5538.113901775697, 5541.944580554143, 5353.518183363361, 5391.973040134932, 5530.198121272312, 5534.833954981357, 5572.136318870582, 5504.944950550604, 5540.944590554042, 5571.13647384656, 5581.386047534686, 5630.887382252414, 5469.699166545878, 5496.477834605706, 5501.5323697486165, 5502.58730595199, 5515.779368825362], "value": 5231.178552507453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.22229101858, 584.2113147251209, 584.225900681597, 589.195747804247, 589.5165963909591, 31012.844935775316, 40996.79501602495, 41892.790536047316, 41906.161876762526, 44174.33738493925, 43455.0, 43914.56085439145, 43926.0, 43929.34105988413, 43935.78032109835, 7958.801029974268, 8487.363447741429, 8644.438111522762, 8661.090585488528, 8668.219860212579, 7980.800479988017, 10110.747231319203, 10356.482175891175, 10365.689029329133, 10627.84058239127, 10317.742056448575, 10365.481725913674, 10385.584576616926, 10390.792184156313, 10391.53238104287, 10331.0, 10344.637937672145, 10411.84382234271, 10419.0, 10422.062014418738, 10154.695359139238, 10217.642382516651, 10219.693409197736, 10219.948900255526, 10224.795504089876, 40660.79669601662, 41009.0, 41026.589734102876, 41033.58966410357, 41105.588944110474, 3356.2112903467664, 3400.4049291373913, 3441.5698037745283, 3493.807840568768, 3512.5609298837644, 28515.714842851514, 29982.550261745873, 30543.541846872315, 30927.226819329695, 31637.52543711846, 3833.271678381099, 3873.612638736132, 3900.6294402031763, 4073.9388909166387, 4134.028503301722, 132073.33963330122, 132224.0, 132391.0, 132941.6705832939, 132974.33512832472, 58819.70590147022, 59181.40818591845, 59210.0, 59221.40778592159, 59317.40682593205, 61829.690851545456, 62039.0, 62067.0, 62124.0, 62129.689351553854, 16097.11465869365, 16752.748708769377, 16771.413000544922, 16775.748363774554, 16776.245068971926, 10488.632897848538, 10827.67516974492, 11152.386618736047, 11258.943705281421, 11277.379744113989, 18258.63482730338, 18669.719954200697, 18724.81275187231, 18738.0, 18872.0, 6762.526623136333, 6954.756583519654, 7015.403690686247, 7148.392386647193, 7181.928180718126, 876.3602570123718, 986.5807032011367, 1021.8007488539663, 1068.8022715797447, 1120.1095129372006, 31011.379772404427, 31061.8446907764, 31083.378332433225, 31126.0, 31752.0, 1081.491698901515, 1085.0885256384674, 1088.4285749981323, 1105.9170562207867, 1107.7618312062946, 15502.844971550367, 16398.180090995404, 16444.75332870008, 16612.916935415487, 16664.333426662797, 495132.0, 500117.0, 500591.0, 500593.0, 500886.0, 55984.440155598735, 56689.716551416976, 56735.0, 56746.71626641923, 56796.0, 1205.52984336109, 1271.0530654662336, 1302.3032677517483, 1352.452256835983, 1359.238826257299, 28108.71891281143, 31169.53245701271, 31753.523697145025, 31868.68131318657, 32053.198670033435, 49015.137880697446, 49575.0, 49583.0, 49601.75199123981, 49635.25547116868, 290254.0, 290723.0, 292106.0, 293325.0, 293515.0, 27693.584596231474, 27821.16536503908, 28494.715052849206, 28663.856680716464, 29739.256518587208, 45141.32288015616, 45424.640550323646, 45605.77197113993, 45679.543204567526, 47037.76481117709, 37538.436923446716, 38223.85921833467, 38513.0, 39299.07009299047, 40360.39459408053, 38302.659406920626, 38766.61233387743, 38776.80611596924, 38906.61093389143, 39234.60765392309, 38784.0, 38814.4177837327, 38838.2232355357, 38951.41572876466, 39064.41403379008, 32658.346833063682, 34772.18105597674, 35187.82406088056, 35384.64615353814, 35513.289734204656, 26610.93556257728, 26801.0, 26909.192724218305, 27139.72860271372, 27143.321416963943], "value": 19071.228985414265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.63677595955943, 391.91573811630514, 402.2718878829318, 404.5408461396315, 422.735790131168, 13193.472261109557, 15122.924385378072, 18225.088745562734, 18597.814021859776, 18640.34758783443, 18153.81846181538, 18721.34475293365, 18914.243430262773, 19039.0480475976, 19066.809331906676, 5375.381831089436, 5492.368377636563, 5730.140478928152, 5731.799387021455, 5736.885262294752, 5256.290400795901, 5584.776608935637, 5616.438356164392, 5620.91568626471, 5622.32532096149, 5359.490848369399, 5577.2191893135, 5577.498025177733, 5581.7209139543065, 5582.27430434043, 5492.093804522249, 5521.696306703129, 5557.305336832896, 5562.221289019541, 5566.387697353288, 4819.831305904311, 4925.926111108336, 4998.125328067574, 5002.799888004475, 5008.0, 21740.239091631876, 21890.671639925415, 22042.88978555113, 22507.54984900309, 22920.656190157162, 2432.5621388150125, 2471.6416119662726, 2685.7582817546318, 2693.5151672698908, 2935.3688956874375, 14019.369128389248, 14162.433502659882, 14267.357968891425, 14529.128252304896, 14892.404303827834, 1722.0872937343229, 1831.9908400458046, 1875.5592435777717, 1908.2557802457052, 1943.1838627776367, 79580.60209698972, 83118.58440707758, 83764.58117709434, 83966.58016709877, 84723.99999999939, 10783.980485464082, 10936.398498082683, 11033.0, 11145.72135696614, 11378.544858205745, 15267.847321526864, 15272.465463708717, 15293.311800968982, 15301.0, 15305.311260993281, 7409.333160015624, 7529.322360987538, 7596.924030759732, 7699.191584883619, 7786.57173855432, 6936.7572134975035, 6977.93022069783, 7019.262977387403, 7190.712371505081, 7239.095113110861, 4669.929951050737, 4681.531846815359, 4723.7874295656775, 4786.856394308176, 4807.831725889577, 1771.5711874432127, 1813.791413987382, 1839.5493104189559, 1841.5580260737327, 1875.7280194372013, 932.6455946740195, 935.8783358163531, 942.072059021863, 956.6364781383169, 1015.7562185075676, 17768.91115544414, 19421.90289048574, 19431.4170574883, 19528.218871245273, 19775.505612359808, 953.427943234054, 956.9665061722945, 969.2343048991218, 990.7473594233425, 996.9651062212788, 9957.908839143862, 10657.893421065844, 10667.359958402365, 10727.624533141303, 10744.570217191225, 321878.0, 323580.0, 447808.0, 450233.0, 451082.0, 83851.16148838433, 93276.53361733147, 97369.5131524352, 98446.5077674607, 99445.0, 996.6910257820099, 1014.5992333028413, 1034.4982683398546, 1056.392574269798, 1058.4548957287004, 16703.0, 16908.23912923946, 17322.913385432992, 17694.469165925042, 18099.72850407271, 41767.373489397076, 41836.3724544126, 41902.37146442745, 42471.0, 43128.56871431371, 55953.72023139858, 56539.434605655064, 58938.0, 59443.40556594379, 60491.0, 7219.639018049182, 8080.4343695940715, 8190.877136842833, 8254.54599997006, 8269.751907442786, 12304.815427768412, 13141.934290328487, 13191.868081319448, 13225.0081243909, 13285.66785830362, 10954.56181752721, 11244.66266012021, 11265.662030138781, 11408.486618102039, 12030.699232518908, 10507.579696812347, 11228.214025018497, 11365.886341136484, 11398.97409233173, 11488.0, 10692.786144277226, 10960.342379457257, 11107.555697771999, 11221.102311815199, 11336.489857956576, 7228.349448549656, 7430.331270185709, 7483.850322993619, 7531.559874158717, 7670.386369090571, 9986.400815951067, 10646.8402973957, 10930.398828064534, 11089.778204435705, 11260.268082574607], "value": 9000.689353017113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.772516397376, 1442.7835824626306, 1563.4684207369498, 1721.5523963769417, 1745.1448790092843, 7569.432292578051, 7842.215778422155, 7942.880856787146, 8412.41113122081, 8418.452800567966, 7968.0, 8179.345652347813, 8221.218984196492, 8396.874046889301, 8402.411831171805, 2264.909403623853, 2293.9770602294016, 2295.0360848443693, 2298.770122987696, 2306.1582522379376, 2027.7059826325174, 2093.0476633131966, 2268.7731226877345, 2295.6671282664006, 2313.525727225923, 2234.6871437998693, 2300.470891694911, 2300.723913130427, 2305.5158416732424, 2314.132200424841, 2287.965680514794, 2288.3249441414655, 2311.641695537186, 2313.421644588853, 2316.9921084328203, 2285.897134628946, 2289.7366802817724, 2315.7452680205165, 2318.9072437102495, 2332.47519308156, 8352.24829765318, 8404.915950840536, 8459.154084591491, 8472.237498625153, 8487.872681909776, 4994.0, 5123.359580052494, 5125.282460455539, 5126.948730512684, 5133.486651334874, 3104.472239719253, 3240.1575590346442, 3318.0875259303643, 3321.7674762766615, 3388.8983330500123, 1027.1423361493162, 1051.8474821150967, 1103.586155191803, 1105.8783533811354, 1134.2117228526179, 11725.179237453382, 11775.705607359885, 11782.175247732663, 11782.882171178264, 11788.46951887167, 4466.932996005063, 4574.405327307429, 4700.059988002413, 4751.382320298409, 4760.0, 9731.56207970643, 9732.951335243279, 9734.610615575439, 9735.853962190573, 9739.220862331138, 5222.843314700565, 5226.608004399685, 5227.372715274191, 5228.2680424740565, 5230.660007099526, 4750.12122757291, 4809.398825146856, 4810.494898035726, 4828.7102773833685, 4877.341558889575, 3715.4241092630687, 3782.0, 3819.7708137511836, 3886.805659717003, 3934.1344904121047, 1140.3158105136852, 1174.3599738142732, 1217.0811037666506, 1273.7961926091966, 1280.3918138884142, 796.4584082823619, 823.7899335669366, 927.6474939522938, 932.4172392254841, 939.4598106089027, 5402.297701298806, 5431.2396264522995, 5554.750036248379, 5594.0, 5607.523360514402, 963.4171326347599, 972.4165500699523, 976.3799987008159, 986.6793292180071, 999.93000489965, 3767.171222331083, 3803.4865293185067, 3824.1969186470596, 3833.597472265372, 3847.461355410245, 10243.38539687621, 10486.632967846088, 10607.734806629742, 10619.044286014296, 10622.097121744739, 10509.421981791074, 10517.789644207072, 10518.053375196116, 10543.31468454548, 10547.630832920811, 7608.733694320672, 7876.488028278143, 7888.368930485547, 7999.240072193249, 8011.959940200261, 5629.0, 5678.602497825113, 5692.373838877803, 5728.312602487728, 5871.7651293947765, 9031.142041506046, 9176.6788162414, 9200.401973871676, 9215.631374744935, 9283.535823208678, 9305.348625596143, 9337.0, 9339.346245762732, 9409.106134917172, 9426.198773104363, 7008.5094043416475, 7121.216666166614, 7129.82175445618, 7130.714771409085, 7131.393831524171, 7694.461387702807, 7776.611169441619, 7947.284744373034, 8012.559309238048, 8150.918490815253, 7303.525270857377, 7326.194118647051, 7402.148752893486, 7501.062367204099, 7677.193894641206, 7232.602206878672, 7287.417006639562, 7322.597257150908, 7371.4102871769055, 7373.29953654402, 6508.511861610304, 6519.771807986698, 6713.899291510729, 6890.655467226518, 6899.413549848319, 4656.324832899279, 4720.598749106364, 4798.448178459382, 4807.567318941312, 4846.006568653488, 4872.756362181947, 4972.552470277692, 5000.899982000413, 5021.874453138701, 5089.185730283285], "value": 4458.453106590031, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.5236407209547, 333.9833008349582, 339.0777086325196, 343.7971596757913, 344.77245018287937, 5120.820771273006, 5188.6886786792775, 5228.633995620308, 5273.446288139748, 5328.254044433777, 5017.297578339027, 5094.566961808241, 5107.7701503432345, 5120.206368012955, 5142.740028692966, 4093.5497095319492, 4116.650084742801, 4121.9587804121875, 4131.442255295527, 4134.545200027995, 3913.8825835224848, 4009.9599004010024, 4037.839755730685, 4136.875893723193, 4160.604742549453, 4116.361963895601, 4125.2780763366445, 4133.111381053073, 4146.274401979642, 4147.813348399314, 4081.999910022034, 4098.856540021115, 4116.897077573055, 4143.544210136883, 4153.937690934623, 3560.038789526839, 3651.8721844735305, 3657.2868290683327, 3662.34077865984, 3663.523741913561, 5043.831152604379, 5055.5702765265, 5056.974715126437, 5077.492250774893, 5082.720450375228, 4636.3045543168455, 4637.860864174047, 4649.48891610228, 4667.369905062807, 4694.483606803249, 5293.258943747878, 5406.432324605899, 5409.972950135263, 5426.701531415771, 5426.728663566806, 3918.804059797027, 3941.3002093565997, 3953.6639385652256, 3964.464797252363, 3975.1254723960683, 5615.213870058195, 5631.155326700987, 5644.745986430579, 5654.802081927113, 5656.490915817555, 4066.3087275163293, 4068.06434520062, 4080.0, 4099.139180772071, 4123.567025462343, 4042.6765858731233, 4092.1406504633765, 4113.91772164555, 4121.175764846983, 4160.9375859362135, 4678.461976872635, 4691.225947718588, 4692.577668009895, 4693.20215563355, 4693.718376897397, 5493.642913210629, 5501.807436739775, 5513.421090785409, 5515.393306736256, 5517.917231241535, 1346.4748747988292, 1390.7427125981726, 1391.5041330569677, 1391.6938273579797, 1396.1692792788274, 950.2682934140673, 970.733193182903, 976.3604838830578, 978.9070038346346, 981.5828272983953, 5107.917621966168, 5109.594861413067, 5116.334876466036, 5116.820911268088, 5126.231065340155, 5344.759485823147, 5390.380106287827, 5392.67879369557, 5401.405845357008, 5423.2136340230445, 4892.0, 5048.192289233705, 5081.221572449613, 5083.373320537393, 5114.41184263807, 2858.5283428234525, 2868.4693331733697, 2872.6840047594746, 2875.971240287612, 2878.409925965214, 5579.721013949286, 5590.2453168821685, 5596.237185286622, 5601.467860553241, 5608.186812912187, 5222.451642577551, 5493.176023596492, 5496.0, 5508.283923090053, 5510.1459273812625, 5436.972815135899, 5580.91628625571, 5583.860403489945, 5597.916031259534, 5602.859928501739, 5193.779461826392, 5313.867153321198, 5315.441878602691, 5359.464053594766, 5403.7838486460105, 5231.686098834082, 5259.21111833228, 5274.235235890697, 5278.8944221116135, 5326.644214145219, 5534.335879694462, 5535.501804837584, 5546.833594992157, 5569.610127291051, 5577.581681373832, 3840.4815349927403, 3948.861789837342, 3952.2293152834923, 3952.584978577208, 3964.5044369453817, 5489.666891571146, 5512.3660779010925, 5518.0, 5553.416891226363, 5563.388027317073, 5434.184872269191, 5436.184572314184, 5479.726013699379, 5516.4764892787525, 5527.640703354269, 5258.474152584711, 5442.809501667422, 5474.302966080528, 5477.316894055684, 5493.48929044516, 5436.293281873332, 5461.262729531462, 5468.234447177478, 5473.425290344616, 5479.917801233064, 5321.587487078139, 5403.8108666196495, 5421.783128674809, 5445.727713614224, 5450.454954504517, 5302.693328402157, 5353.304070470814, 5377.946220537901, 5391.899657696762, 5406.135018397038], "value": 4142.570153590073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5413614756795, 723.612867116093, 759.2748924776839, 770.6339488742848, 810.7608255564606, 14387.42450301988, 15973.121478318688, 15989.520314390587, 16012.919935400321, 16022.839771602296, 14592.41630334788, 14664.706705865876, 14680.706385872276, 14786.0, 14814.629634259149, 643.6588608037747, 658.282472105405, 756.6670664907423, 762.2111114995967, 766.3524321947945, 758.7723682895137, 763.9847203055936, 765.1506827421557, 765.2385876053335, 766.9578173200472, 759.305235709328, 763.2443880558263, 770.6493545436813, 783.3537331701341, 786.0528063683248, 680.5916450129932, 699.0458024796117, 788.7476007677545, 811.0186674124317, 812.8211793405442, 595.8599729063667, 601.0263373335181, 601.3625556909647, 601.7863658401292, 601.8224623736008, 14596.781048284285, 14722.852771472362, 14751.631209219748, 14761.926190369088, 14773.261336933218, 13257.46970121194, 13376.665583360495, 13450.86549134506, 13452.86547134526, 13634.386452609657, 12229.633111006684, 12474.625761227178, 12507.124501284914, 12812.80780788289, 13229.933850330686, 4173.332266837322, 4192.0777428965575, 4255.659547236213, 4285.678574106923, 4393.033532622818, 79455.60272198603, 80996.19003809945, 81027.0, 82462.0, 82743.58628206821, 10831.458427078614, 10865.185111116698, 10877.83683244752, 10905.127589792797, 10945.890541094486, 20047.899760501397, 20064.59224893022, 20122.59754804925, 20161.798382016284, 20176.29382971589, 7854.72508462201, 7928.801779955547, 7971.641276142587, 8094.51432914027, 8104.756857294291, 4259.361095835649, 4309.07354918694, 4315.719478233905, 4409.4488188976375, 4431.578999994996, 3376.5104059911178, 3880.0, 4003.5195776507007, 4024.376221685585, 4071.246819338432, 649.8505343770959, 662.1160750398273, 666.7666316789085, 672.1161672400777, 675.0144788608588, 673.6227712481026, 712.9750458734023, 725.0393228971528, 727.5852763924618, 731.7914394397677, 9423.623055077856, 9550.761230969281, 9710.854337184948, 9751.268654850772, 9758.75603109928, 689.1282527602586, 700.7022015643331, 715.8675645005691, 721.6355740351089, 744.765398899345, 4226.788660566959, 4547.931781023287, 4638.118757436144, 4661.207594708908, 4726.220173671374, 80205.19794801978, 82007.12975045964, 86264.56867715747, 87158.56420717982, 88357.55821220853, 62016.68991655103, 66808.33191668119, 68838.31161688319, 70464.64767676129, 73579.63210184022, 62155.378446214956, 62539.374606253354, 63196.0, 64279.35720642827, 64422.67788661027, 9849.45827979468, 10261.127804136731, 10476.68569942903, 10549.578016879239, 10732.839007415052, 44629.330560042275, 45150.77424612856, 45650.54349456596, 45830.770846145555, 45849.0, 53001.0, 53389.73305133605, 54037.72981135226, 54794.726026369615, 57718.7114064427, 13025.674358141123, 13195.0, 13195.868041319463, 13258.469661213443, 13958.720825583228, 14282.0, 14399.496017639332, 14778.48275310359, 14849.703005939604, 15975.680486389974, 14153.363098660378, 14280.42878284857, 14532.695566118502, 14744.189069600845, 15214.16322102295, 13737.587872363445, 13837.377318020915, 14247.572572822832, 14584.270786460847, 14713.264336782904, 12586.748265034465, 13550.254735989221, 14019.50931717385, 14648.560543183721, 14679.48621798232, 10860.67417977462, 10944.0, 11455.656330310105, 11583.0, 11661.883381166079, 9012.41419307743, 9767.120959113714, 10011.24915631316, 10831.891681083089, 11359.432028398713], "value": 7218.20194098313, "unit": "score"}], "name": "dromaeo_css", "value": 7020.430255732243, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 110.0, 113.0, 113.0, 113.0, 111.0, 112.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 124.0, 168.0, 126.0, 125.0, 124.0, 122.0, 143.0, 124.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 112.0, 79.0, 77.0, 76.0, 76.0, 92.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 83.0, 82.0, 83.0, 104.0, 85.0, 86.0, 110.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 52.0, 51.0, 52.0, 53.0, 52.0, 53.0, 52.0, 53.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 63.0, 64.0, 62.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 80.0, 80.0, 81.0, 81.0, 80.0, 79.0, 80.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 140.0, 144.0, 129.0, 138.0, 131.0, 130.0, 178.0, 157.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 174.0, 166.0, 167.0, 165.0, 166.0, 167.0, 167.0, 164.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 71.0, 65.0, 65.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1510.5000000000002, "alertThreshold": 2.0}]} 07:11:39 INFO - Return code: 0 07:11:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:11:39 INFO - # TBPL SUCCESS # 07:11:39 INFO - Running post-action listener: _resource_record_post_action 07:11:39 INFO - [mozharness: 2016-12-01 15:11:39.388963Z] Finished run-tests step (success) 07:11:39 INFO - Running post-run listener: _resource_record_post_run 07:11:39 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 394514432; Read time: 0; Write time: 372792 07:11:39 INFO - TinderboxPrint: CPU usage
13.2% 07:11:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:11:39 INFO - TinderboxPrint: I/O write bytes / time
394,514,432 / 372,792 07:11:39 INFO - TinderboxPrint: CPU idle
8,307.7 (86.8%) 07:11:39 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 07:11:39 INFO - TinderboxPrint: Swap in / out
0 / 0 07:11:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103235584; Read time: 0; Write time: 76120 07:11:39 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 290361344; Read time: 0; Write time: 296648 07:11:40 INFO - Running post-run listener: _upload_blobber_files 07:11:40 INFO - Blob upload gear active. 07:11:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:11:40 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'] 07:11:40 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 07:11:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:41 INFO - (blobuploader) - INFO - Done attempting. 07:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:42 INFO - (blobuploader) - INFO - Done attempting. 07:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:45 INFO - (blobuploader) - INFO - Done attempting. 07:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:45 INFO - Return code: 0 07:11:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b5f06e515698fd015ddf6658395bb66aea7deb0abc16f61de3d16e721b23c0d9c2ff348ad707113d4a11cc9d96e1d6235d22ad9cee8a969412883b22dfa3a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f4f5d64e19325e5e97faa8fed8209dd983d631bbbc838cb649a0a719f8e530769f500410040c96c115df4e1db1e9a80a2d9a42a887a6973bcd22a50ab3a6bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ba000916541f3946235e6adf2c4878a0c947186c39adccc8894ac5ffeabf1a47d876c6ad9698286d3b7eb7c2c33e5152ccf439e3f4f0c0a044e7a2bf83e6b6b"} 07:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:45 INFO - Contents: 07:11:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1b5f06e515698fd015ddf6658395bb66aea7deb0abc16f61de3d16e721b23c0d9c2ff348ad707113d4a11cc9d96e1d6235d22ad9cee8a969412883b22dfa3a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f4f5d64e19325e5e97faa8fed8209dd983d631bbbc838cb649a0a719f8e530769f500410040c96c115df4e1db1e9a80a2d9a42a887a6973bcd22a50ab3a6bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ba000916541f3946235e6adf2c4878a0c947186c39adccc8894ac5ffeabf1a47d876c6ad9698286d3b7eb7c2c33e5152ccf439e3f4f0c0a044e7a2bf83e6b6b"} 07:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:45 INFO - Copying logs to upload dir... 07:11:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.907427 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-01 07:11:45.393137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 07:11:45.396909) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467 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/1b5f06e515698fd015ddf6658395bb66aea7deb0abc16f61de3d16e721b23c0d9c2ff348ad707113d4a11cc9d96e1d6235d22ad9cee8a969412883b22dfa3a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f4f5d64e19325e5e97faa8fed8209dd983d631bbbc838cb649a0a719f8e530769f500410040c96c115df4e1db1e9a80a2d9a42a887a6973bcd22a50ab3a6bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ba000916541f3946235e6adf2c4878a0c947186c39adccc8894ac5ffeabf1a47d876c6ad9698286d3b7eb7c2c33e5152ccf439e3f4f0c0a044e7a2bf83e6b6b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011928 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480592041/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/1b5f06e515698fd015ddf6658395bb66aea7deb0abc16f61de3d16e721b23c0d9c2ff348ad707113d4a11cc9d96e1d6235d22ad9cee8a969412883b22dfa3a55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f4f5d64e19325e5e97faa8fed8209dd983d631bbbc838cb649a0a719f8e530769f500410040c96c115df4e1db1e9a80a2d9a42a887a6973bcd22a50ab3a6bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ba000916541f3946235e6adf2c4878a0c947186c39adccc8894ac5ffeabf1a47d876c6ad9698286d3b7eb7c2c33e5152ccf439e3f4f0c0a044e7a2bf83e6b6b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 07:11:45.426725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 07:11:45.427098) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480603864.211009-2117295467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005009 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 07:11:45.509498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 07:11:45.509842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 07:11:45.510188) ========= ========= Total master_lag: 0.17 =========