builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1483991353.91 results: success (0) buildid: 20170109112414 builduid: 3741ccb18f184117b775c11ddb1f6c1e revision: dd6d4ca2066803fae7dc99fb872d7191a6421478 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:13.913069) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:13.913578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:13.913887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:13.929824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:13.930212) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 11:49:13-- 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% 46.6M=0s 2017-01-09 11:49:14 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137048 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.097646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.097960) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083338 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.193563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.193912) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dd6d4ca2066803fae7dc99fb872d7191a6421478 --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 dd6d4ca2066803fae7dc99fb872d7191a6421478 --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=e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 11:49:14,249 truncating revision to first 12 chars 2017-01-09 11:49:14,249 Setting DEBUG logging. 2017-01-09 11:49:14,249 attempt 1/10 2017-01-09 11:49:14,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dd6d4ca20668?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 11:49:14,564 unpacking tar archive at: mozilla-inbound-dd6d4ca20668/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.853645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.854031) ========= script_repo_revision: dd6d4ca2066803fae7dc99fb872d7191a6421478 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.854481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.854747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:14.865663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-01-09 11:49:14.866065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:15 INFO - MultiFileLogger online at 20170109 11:49:15 in /builds/slave/test 11:49:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:49:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:15 INFO - {'append_to_log': False, 11:49:15 INFO - 'base_work_dir': '/builds/slave/test', 11:49:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:49:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:15 INFO - 'branch': 'Mozilla-Inbound', 11:49:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:15 INFO - 'config_files': ('talos/linux_config.py',), 11:49:15 INFO - 'default_actions': ('clobber', 11:49:15 INFO - 'read-buildbot-config', 11:49:15 INFO - 'download-and-extract', 11:49:15 INFO - 'populate-webroot', 11:49:15 INFO - 'create-virtualenv', 11:49:15 INFO - 'install', 11:49:15 INFO - 'run-tests'), 11:49:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:15 INFO - 'download_minidump_stackwalk': True, 11:49:15 INFO - 'download_symbols': 'ondemand', 11:49:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:15 INFO - 'installer_path': 'installer.exe', 11:49:15 INFO - 'log_level': 'info', 11:49:15 INFO - 'log_name': 'talos', 11:49:15 INFO - 'log_to_console': True, 11:49:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:15 INFO - 'opt_config_files': (), 11:49:15 INFO - 'pip_index': False, 11:49:15 INFO - 'sps_profile': False, 11:49:15 INFO - 'sps_profile_interval': 0, 11:49:15 INFO - 'suite': 'dromaeojs-e10s', 11:49:15 INFO - 'system_bits': '32', 11:49:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:15 INFO - 'title': 'talos-linux64-ix-067', 11:49:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:15 INFO - 'use_talos_json': True, 11:49:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:15 INFO - 'work_dir': 'build'} 11:49:15 INFO - [mozharness: 2017-01-09 19:49:15.122993Z] Running clobber step. 11:49:15 INFO - Running pre-action listener: _resource_record_pre_action 11:49:15 INFO - Running main action method: clobber 11:49:15 INFO - rmtree: /builds/slave/test/build 11:49:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:19 INFO - Running post-action listener: _resource_record_post_action 11:49:19 INFO - [mozharness: 2017-01-09 19:49:19.536101Z] Finished clobber step (success) 11:49:19 INFO - [mozharness: 2017-01-09 19:49:19.536198Z] Running read-buildbot-config step. 11:49:19 INFO - Running pre-action listener: _resource_record_pre_action 11:49:19 INFO - Running main action method: read_buildbot_config 11:49:19 INFO - Using buildbot properties: 11:49:19 INFO - { 11:49:19 INFO - "project": "", 11:49:19 INFO - "product": "firefox", 11:49:19 INFO - "script_repo_revision": "production", 11:49:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:49:19 INFO - "repository": "", 11:49:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:49:19 INFO - "buildid": "20170109112414", 11:49:19 INFO - "stage_platform": "linux64-pgo", 11:49:19 INFO - "basedir": "/builds/slave/test", 11:49:19 INFO - "buildnumber": 2233, 11:49:19 INFO - "platform": "ubuntu64_hw", 11:49:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:49:19 INFO - "slavebuilddir": "test", 11:49:19 INFO - "branch": "mozilla-inbound", 11:49:19 INFO - "revision": "dd6d4ca2066803fae7dc99fb872d7191a6421478", 11:49:19 INFO - "slavename": "talos-linux64-ix-067", 11:49:19 INFO - "builduid": "3741ccb18f184117b775c11ddb1f6c1e", 11:49:19 INFO - "repo_path": "integration/mozilla-inbound" 11:49:19 INFO - } 11:49:19 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:49:19 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:49:19 INFO - Running post-action listener: _resource_record_post_action 11:49:19 INFO - [mozharness: 2017-01-09 19:49:19.538538Z] Finished read-buildbot-config step (success) 11:49:19 INFO - [mozharness: 2017-01-09 19:49:19.538626Z] Running download-and-extract step. 11:49:19 INFO - Running pre-action listener: _resource_record_pre_action 11:49:19 INFO - Running main action method: download_and_extract 11:49:19 INFO - mkdir: /builds/slave/test/build/tests 11:49: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')]} 11:49:19 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:49:19 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:49:19 INFO - Downloaded 1361 bytes. 11:49:19 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:49:19 INFO - Using the following test package requirements: 11:49:19 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:19 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:49:19 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:49:19 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'jsshell-linux-x86_64.zip'], 11:49:19 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:49:19 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:19 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:49:19 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:49:19 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:49:19 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:49:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:49:19 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/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:49:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:19 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:49:19 INFO - Expected file size: 21842125 11:49:19 INFO - Obtained file size: 21842125 11:49:23 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:49:23 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/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:49:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:23 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:49:24 INFO - Expected file size: 21842125 11:49:24 INFO - Obtained file size: 21842125 11:49:28 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/1483983610/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:49:28 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:49:29 INFO - Expected file size: 14403537 11:49:29 INFO - Obtained file size: 14403537 11:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:29 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:29 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:49:29 INFO - Downloaded 61456530 bytes. 11:49:29 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:29 INFO - mkdir: /builds/slave/test/properties 11:49:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:29 INFO - Contents: 11:49:29 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:30 INFO - Running post-action listener: _resource_record_post_action 11:49:30 INFO - Running post-action listener: set_extra_try_arguments 11:49:30 INFO - [mozharness: 2017-01-09 19:49:30.290736Z] Finished download-and-extract step (success) 11:49:30 INFO - [mozharness: 2017-01-09 19:49:30.291041Z] Running populate-webroot step. 11:49:30 INFO - Running pre-action listener: _resource_record_pre_action 11:49:30 INFO - Running main action method: populate_webroot 11:49:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:30 INFO - '--tppagecycles', 11:49:30 INFO - '7'], 11:49:30 INFO - 'tests': ['tsvgm']}}, 11:49:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['damp', 'tps']}, 11:49:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'tests': ['damp', 'tps']}, 11:49:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['dromaeo_dom']}, 11:49:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['basic_compositor_video']}, 11:49:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tsvgx', 11:49:30 INFO - 'tsvgr_opacity', 11:49:30 INFO - 'tart', 11:49:30 INFO - 'tscrollx', 11:49:30 INFO - 'cart', 11:49:30 INFO - 'tsvg_static']}, 11:49:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:30 INFO - 'tsvgr_opacity', 11:49:30 INFO - 'tart', 11:49:30 INFO - 'tscrollx', 11:49:30 INFO - 'cart', 11:49:30 INFO - 'tsvg_static']}, 11:49:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tp5o']}, 11:49:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:49:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s', 11:49:30 INFO - '--xperf_path', 11:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:30 INFO - 'tests': ['tp5n']}, 11:49:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:49:30 INFO - 'talos_options': ['--xperf_path', 11:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:30 INFO - 'tests': ['tp5n']}}, 11:49:30 INFO - 'talos.zip': {'path': '', 11:49:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:30 INFO - Running post-action listener: _resource_record_post_action 11:49:30 INFO - [mozharness: 2017-01-09 19:49:30.309082Z] Finished populate-webroot step (success) 11:49:30 INFO - [mozharness: 2017-01-09 19:49:30.309194Z] Running create-virtualenv step. 11:49:30 INFO - Running pre-action listener: _resource_record_pre_action 11:49:30 INFO - Running main action method: create_virtualenv 11:49:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:49:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:30 INFO - Using real prefix '/usr' 11:49:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:33 INFO - Installing pip.................done. 11:49:33 INFO - Return code: 0 11:49:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:49:33 INFO - Reading from file tmpfile_stdout 11:49:33 INFO - Output received: 11:49:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:49:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:49:33 INFO - Using env: {'DISPLAY': ':0', 11:49:33 INFO - 'HOME': '/home/cltbld', 11:49:33 INFO - 'LANG': 'en_US.UTF-8', 11:49:33 INFO - 'LANGUAGE': 'en_US:en', 11:49:33 INFO - 'LOGNAME': 'cltbld', 11:49:33 INFO - 'MAIL': '/var/mail/cltbld', 11:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:33 INFO - 'MOZ_NO_REMOTE': '1', 11:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:33 INFO - 'NO_EM_RESTART': '1', 11:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:33 INFO - 'PWD': '/builds/slave/test', 11:49:33 INFO - 'SHELL': '/bin/bash', 11:49:33 INFO - 'SHLVL': '1', 11:49:33 INFO - 'TERM': 'linux', 11:49:33 INFO - 'TMOUT': '86400', 11:49:33 INFO - 'USER': 'cltbld', 11:49:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:33 INFO - '_': '/tools/buildbot/bin/python'} 11:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:49:34 INFO - Cleaning up... 11:49:34 INFO - Return code: 0 11:49:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:49:34 INFO - Using env: {'DISPLAY': ':0', 11:49:34 INFO - 'HOME': '/home/cltbld', 11:49:34 INFO - 'LANG': 'en_US.UTF-8', 11:49:34 INFO - 'LANGUAGE': 'en_US:en', 11:49:34 INFO - 'LOGNAME': 'cltbld', 11:49:34 INFO - 'MAIL': '/var/mail/cltbld', 11:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:34 INFO - 'MOZ_NO_REMOTE': '1', 11:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:34 INFO - 'NO_EM_RESTART': '1', 11:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:34 INFO - 'PWD': '/builds/slave/test', 11:49:34 INFO - 'SHELL': '/bin/bash', 11:49:34 INFO - 'SHLVL': '1', 11:49:34 INFO - 'TERM': 'linux', 11:49:34 INFO - 'TMOUT': '86400', 11:49:34 INFO - 'USER': 'cltbld', 11:49:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:34 INFO - '_': '/tools/buildbot/bin/python'} 11:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:34 INFO - Downloading/unpacking psutil>=3.1.1 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:36 INFO - Installing collected packages: psutil 11:49:36 INFO - Running setup.py install for psutil 11:49:36 INFO - building 'psutil._psutil_linux' extension 11:49:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:49:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:49:37 INFO - building 'psutil._psutil_posix' extension 11:49:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:49:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:49:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:37 INFO - Successfully installed psutil 11:49:37 INFO - Cleaning up... 11:49:37 INFO - Return code: 0 11:49:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:49:37 INFO - Using env: {'DISPLAY': ':0', 11:49:37 INFO - 'HOME': '/home/cltbld', 11:49:37 INFO - 'LANG': 'en_US.UTF-8', 11:49:37 INFO - 'LANGUAGE': 'en_US:en', 11:49:37 INFO - 'LOGNAME': 'cltbld', 11:49:37 INFO - 'MAIL': '/var/mail/cltbld', 11:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:37 INFO - 'MOZ_NO_REMOTE': '1', 11:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:37 INFO - 'NO_EM_RESTART': '1', 11:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:37 INFO - 'PWD': '/builds/slave/test', 11:49:37 INFO - 'SHELL': '/bin/bash', 11:49:37 INFO - 'SHLVL': '1', 11:49:37 INFO - 'TERM': 'linux', 11:49:37 INFO - 'TMOUT': '86400', 11:49:37 INFO - 'USER': 'cltbld', 11:49:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:37 INFO - '_': '/tools/buildbot/bin/python'} 11:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:49:40 INFO - Installing collected packages: mozsystemmonitor 11:49:40 INFO - Running setup.py install for mozsystemmonitor 11:49:40 INFO - Successfully installed mozsystemmonitor 11:49:40 INFO - Cleaning up... 11:49:40 INFO - Return code: 0 11:49:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:49:40 INFO - Using env: {'DISPLAY': ':0', 11:49:40 INFO - 'HOME': '/home/cltbld', 11:49:40 INFO - 'LANG': 'en_US.UTF-8', 11:49:40 INFO - 'LANGUAGE': 'en_US:en', 11:49:40 INFO - 'LOGNAME': 'cltbld', 11:49:40 INFO - 'MAIL': '/var/mail/cltbld', 11:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:40 INFO - 'MOZ_NO_REMOTE': '1', 11:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:40 INFO - 'NO_EM_RESTART': '1', 11:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:40 INFO - 'PWD': '/builds/slave/test', 11:49:40 INFO - 'SHELL': '/bin/bash', 11:49:40 INFO - 'SHLVL': '1', 11:49:40 INFO - 'TERM': 'linux', 11:49:40 INFO - 'TMOUT': '86400', 11:49:40 INFO - 'USER': 'cltbld', 11:49:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:40 INFO - '_': '/tools/buildbot/bin/python'} 11:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:42 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:42 INFO - warning: no files found matching '*.txt' 11:49:42 INFO - no previously-included directories found matching 'build' 11:49:42 INFO - no previously-included directories found matching 'dist' 11:49:42 INFO - no previously-included directories found matching '.git*' 11:49:42 INFO - Installing collected packages: jsonschema, functools32 11:49:42 INFO - Running setup.py install for functools32 11:49:42 INFO - warning: no files found matching '*.txt' 11:49:42 INFO - no previously-included directories found matching 'build' 11:49:42 INFO - no previously-included directories found matching 'dist' 11:49:42 INFO - no previously-included directories found matching '.git*' 11:49:43 INFO - Successfully installed jsonschema functools32 11:49:43 INFO - Cleaning up... 11:49:43 INFO - Return code: 0 11:49:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:49:43 INFO - Using env: {'DISPLAY': ':0', 11:49:43 INFO - 'HOME': '/home/cltbld', 11:49:43 INFO - 'LANG': 'en_US.UTF-8', 11:49:43 INFO - 'LANGUAGE': 'en_US:en', 11:49:43 INFO - 'LOGNAME': 'cltbld', 11:49:43 INFO - 'MAIL': '/var/mail/cltbld', 11:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:43 INFO - 'MOZ_NO_REMOTE': '1', 11:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:43 INFO - 'NO_EM_RESTART': '1', 11:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:43 INFO - 'PWD': '/builds/slave/test', 11:49:43 INFO - 'SHELL': '/bin/bash', 11:49:43 INFO - 'SHLVL': '1', 11:49:43 INFO - 'TERM': 'linux', 11:49:43 INFO - 'TMOUT': '86400', 11:49:43 INFO - 'USER': 'cltbld', 11:49:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:43 INFO - '_': '/tools/buildbot/bin/python'} 11:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:49:43 INFO - Cleaning up... 11:49:43 INFO - Return code: 0 11:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:49:43 INFO - Using env: {'DISPLAY': ':0', 11:49:43 INFO - 'HOME': '/home/cltbld', 11:49:43 INFO - 'LANG': 'en_US.UTF-8', 11:49:43 INFO - 'LANGUAGE': 'en_US:en', 11:49:43 INFO - 'LOGNAME': 'cltbld', 11:49:43 INFO - 'MAIL': '/var/mail/cltbld', 11:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:43 INFO - 'MOZ_NO_REMOTE': '1', 11:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:43 INFO - 'NO_EM_RESTART': '1', 11:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:43 INFO - 'PWD': '/builds/slave/test', 11:49:43 INFO - 'SHELL': '/bin/bash', 11:49:43 INFO - 'SHLVL': '1', 11:49:43 INFO - 'TERM': 'linux', 11:49:43 INFO - 'TMOUT': '86400', 11:49:43 INFO - 'USER': 'cltbld', 11:49:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:43 INFO - '_': '/tools/buildbot/bin/python'} 11:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:46 INFO - Downloading docopt-0.6.1.tar.gz 11:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:46 INFO - Running setup.py install for blobuploader 11:49:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:46 INFO - Running setup.py install for requests 11:49:46 INFO - Running setup.py install for docopt 11:49:47 INFO - Successfully installed blobuploader requests docopt 11:49:47 INFO - Cleaning up... 11:49:47 INFO - Return code: 0 11:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:47 INFO - Using env: {'DISPLAY': ':0', 11:49:47 INFO - 'HOME': '/home/cltbld', 11:49:47 INFO - 'LANG': 'en_US.UTF-8', 11:49:47 INFO - 'LANGUAGE': 'en_US:en', 11:49:47 INFO - 'LOGNAME': 'cltbld', 11:49:47 INFO - 'MAIL': '/var/mail/cltbld', 11:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:47 INFO - 'MOZ_NO_REMOTE': '1', 11:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:47 INFO - 'NO_EM_RESTART': '1', 11:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:47 INFO - 'PWD': '/builds/slave/test', 11:49:47 INFO - 'SHELL': '/bin/bash', 11:49:47 INFO - 'SHLVL': '1', 11:49:47 INFO - 'TERM': 'linux', 11:49:47 INFO - 'TMOUT': '86400', 11:49:47 INFO - 'USER': 'cltbld', 11:49:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:47 INFO - '_': '/tools/buildbot/bin/python'} 11:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:47 INFO - Running setup.py (path:/tmp/pip-c9iw2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:47 INFO - Running setup.py (path:/tmp/pip-guUpHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:47 INFO - Running setup.py (path:/tmp/pip-OIOTS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:47 INFO - Running setup.py (path:/tmp/pip-dlTFfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:47 INFO - Running setup.py (path:/tmp/pip-DWbCWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:47 INFO - Running setup.py (path:/tmp/pip-Nch7RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:47 INFO - Running setup.py (path:/tmp/pip-qzpR3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:47 INFO - Running setup.py (path:/tmp/pip-0kV2jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:47 INFO - Running setup.py (path:/tmp/pip-0aLgXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:47 INFO - Running setup.py (path:/tmp/pip-Hla1rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:48 INFO - Running setup.py (path:/tmp/pip-IB0FJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:48 INFO - Running setup.py (path:/tmp/pip-NvMBxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:48 INFO - Running setup.py (path:/tmp/pip-cy_eCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:48 INFO - Running setup.py (path:/tmp/pip-23tNLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:48 INFO - Running setup.py (path:/tmp/pip-I4dcoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:48 INFO - Running setup.py (path:/tmp/pip-xs2q14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:48 INFO - Running setup.py (path:/tmp/pip-MvJ10z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:48 INFO - Running setup.py install for manifestparser 11:49:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozcrash 11:49:48 INFO - Running setup.py install for mozdebug 11:49:48 INFO - Running setup.py install for mozdevice 11:49:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozfile 11:49:49 INFO - Running setup.py install for mozhttpd 11:49:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozinfo 11:49:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozInstall 11:49:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozleak 11:49:49 INFO - Running setup.py install for mozlog 11:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for moznetwork 11:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozprocess 11:49:49 INFO - Running setup.py install for mozprofile 11:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozrunner 11:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:50 INFO - Running setup.py install for mozscreenshot 11:49:50 INFO - Running setup.py install for moztest 11:49:50 INFO - Running setup.py install for mozversion 11:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:50 INFO - Cleaning up... 11:49:50 INFO - Return code: 0 11:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:50 INFO - Using env: {'DISPLAY': ':0', 11:49:50 INFO - 'HOME': '/home/cltbld', 11:49:50 INFO - 'LANG': 'en_US.UTF-8', 11:49:50 INFO - 'LANGUAGE': 'en_US:en', 11:49:50 INFO - 'LOGNAME': 'cltbld', 11:49:50 INFO - 'MAIL': '/var/mail/cltbld', 11:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:50 INFO - 'MOZ_NO_REMOTE': '1', 11:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:50 INFO - 'NO_EM_RESTART': '1', 11:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:50 INFO - 'PWD': '/builds/slave/test', 11:49:50 INFO - 'SHELL': '/bin/bash', 11:49:50 INFO - 'SHLVL': '1', 11:49:50 INFO - 'TERM': 'linux', 11:49:50 INFO - 'TMOUT': '86400', 11:49:50 INFO - 'USER': 'cltbld', 11:49:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:50 INFO - '_': '/tools/buildbot/bin/python'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:50 INFO - Running setup.py (path:/tmp/pip-g5Ypx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:50 INFO - Running setup.py (path:/tmp/pip-itbue7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:50 INFO - Running setup.py (path:/tmp/pip-4o6wny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:50 INFO - Running setup.py (path:/tmp/pip-uVqXAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:50 INFO - Running setup.py (path:/tmp/pip-DBS95i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Running setup.py (path:/tmp/pip-e9oKeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:50 INFO - Running setup.py (path:/tmp/pip-LfqwGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:51 INFO - Running setup.py (path:/tmp/pip-6pyAux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:51 INFO - Running setup.py (path:/tmp/pip-rVxuyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:51 INFO - Running setup.py (path:/tmp/pip-qsFrZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:51 INFO - Running setup.py (path:/tmp/pip-UPn3Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:51 INFO - Running setup.py (path:/tmp/pip-BFw8hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:51 INFO - Running setup.py (path:/tmp/pip-TXVVea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:51 INFO - Running setup.py (path:/tmp/pip-_wfivf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:51 INFO - Running setup.py (path:/tmp/pip-FrxM8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:51 INFO - Running setup.py (path:/tmp/pip-iXDtk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:51 INFO - Running setup.py (path:/tmp/pip-7CbjBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:53 INFO - Downloading blessings-1.6.tar.gz 11:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:53 INFO - Installing collected packages: blessings 11:49:53 INFO - Running setup.py install for blessings 11:49:54 INFO - Successfully installed blessings 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:54 INFO - Reading from file tmpfile_stdout 11:49:54 INFO - Current package versions: 11:49:54 INFO - argparse == 1.2.1 11:49:54 INFO - blessings == 1.6 11:49:54 INFO - blobuploader == 1.2.4 11:49:54 INFO - docopt == 0.6.1 11:49:54 INFO - functools32 == 3.2.3-2 11:49:54 INFO - jsonschema == 2.5.1 11:49:54 INFO - manifestparser == 1.1 11:49:54 INFO - mozInstall == 1.12 11:49:54 INFO - mozcrash == 1.0 11:49:54 INFO - mozdebug == 0.1 11:49:54 INFO - mozdevice == 0.49 11:49:54 INFO - mozfile == 1.2 11:49:54 INFO - mozhttpd == 0.7 11:49:54 INFO - mozinfo == 0.9 11:49:54 INFO - mozleak == 0.1 11:49:54 INFO - mozlog == 3.4 11:49:54 INFO - moznetwork == 0.27 11:49:54 INFO - mozprocess == 0.24 11:49:54 INFO - mozprofile == 0.28 11:49:54 INFO - mozrunner == 6.13 11:49:54 INFO - mozscreenshot == 0.1 11:49:54 INFO - mozsystemmonitor == 0.3 11:49:54 INFO - moztest == 0.8 11:49:54 INFO - mozversion == 1.4 11:49:54 INFO - psutil == 3.1.1 11:49:54 INFO - requests == 1.2.3 11:49:54 INFO - wsgiref == 0.1.2 11:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:54 INFO - Using env: {'DISPLAY': ':0', 11:49:54 INFO - 'HOME': '/home/cltbld', 11:49:54 INFO - 'LANG': 'en_US.UTF-8', 11:49:54 INFO - 'LANGUAGE': 'en_US:en', 11:49:54 INFO - 'LOGNAME': 'cltbld', 11:49:54 INFO - 'MAIL': '/var/mail/cltbld', 11:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:54 INFO - 'MOZ_NO_REMOTE': '1', 11:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:54 INFO - 'NO_EM_RESTART': '1', 11:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:54 INFO - 'PWD': '/builds/slave/test', 11:49:54 INFO - 'SHELL': '/bin/bash', 11:49:54 INFO - 'SHLVL': '1', 11:49:54 INFO - 'TERM': 'linux', 11:49:54 INFO - 'TMOUT': '86400', 11:49:54 INFO - 'USER': 'cltbld', 11:49:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:54 INFO - '_': '/tools/buildbot/bin/python'} 11:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2528480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:49:54 INFO - Using env: {'DISPLAY': ':0', 11:49:54 INFO - 'HOME': '/home/cltbld', 11:49:54 INFO - 'LANG': 'en_US.UTF-8', 11:49:54 INFO - 'LANGUAGE': 'en_US:en', 11:49:54 INFO - 'LOGNAME': 'cltbld', 11:49:54 INFO - 'MAIL': '/var/mail/cltbld', 11:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:54 INFO - 'MOZ_NO_REMOTE': '1', 11:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:54 INFO - 'NO_EM_RESTART': '1', 11:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:54 INFO - 'PWD': '/builds/slave/test', 11:49:54 INFO - 'SHELL': '/bin/bash', 11:49:54 INFO - 'SHLVL': '1', 11:49:54 INFO - 'TERM': 'linux', 11:49:54 INFO - 'TMOUT': '86400', 11:49:54 INFO - 'USER': 'cltbld', 11:49:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:54 INFO - '_': '/tools/buildbot/bin/python'} 11:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Running post-action listener: _resource_record_post_action 11:49:54 INFO - Running post-action listener: _start_resource_monitoring 11:49:54 INFO - Starting resource monitoring. 11:49:54 INFO - [mozharness: 2017-01-09 19:49:54.836737Z] Finished create-virtualenv step (success) 11:49:54 INFO - [mozharness: 2017-01-09 19:49:54.837740Z] Running install step. 11:49:54 INFO - Running pre-action listener: _resource_record_pre_action 11:49:54 INFO - Running main action method: install 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:55 INFO - Reading from file tmpfile_stdout 11:49:55 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:55 INFO - Reading from file tmpfile_stdout 11:49:55 INFO - Output received: 11:49:55 INFO - Usage: mozinstall [options] installer 11:49:55 INFO - Options: 11:49:55 INFO - -h, --help show this help message and exit 11:49:55 INFO - -d DEST, --destination=DEST 11:49:55 INFO - Directory to install application into. [default: 11:49:55 INFO - "/builds/slave/test"] 11:49:55 INFO - --app=APP Application being installed. [default: firefox] 11:49:55 INFO - mkdir: /builds/slave/test/build/application 11:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:50:12 INFO - Reading from file tmpfile_stdout 11:50:12 INFO - Output received: 11:50:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:12 INFO - Running post-action listener: _resource_record_post_action 11:50:12 INFO - [mozharness: 2017-01-09 19:50:12.507158Z] Finished install step (success) 11:50:12 INFO - [mozharness: 2017-01-09 19:50:12.507499Z] Running run-tests step. 11:50:12 INFO - Running pre-action listener: _resource_record_pre_action 11:50:12 INFO - Running main action method: run_tests 11:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:12 INFO - Python 2.7.3 11:50:12 INFO - Return code: 0 11:50:12 INFO - grabbing minidump binary from tooltool 11:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:12 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 0x2525820>, '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 0x2526520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25269b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:50:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:50:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:50:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:12 INFO - Return code: 0 11:50:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:12 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:50:12 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:50:12 INFO - Using env: {'DISPLAY': ':0', 11:50:12 INFO - 'HOME': '/home/cltbld', 11:50:12 INFO - 'LANG': 'en_US.UTF-8', 11:50:12 INFO - 'LANGUAGE': 'en_US:en', 11:50:12 INFO - 'LOGNAME': 'cltbld', 11:50:12 INFO - 'MAIL': '/var/mail/cltbld', 11:50:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:12 INFO - 'MOZ_NO_REMOTE': '1', 11:50:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:12 INFO - 'NO_EM_RESTART': '1', 11:50:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:12 INFO - 'PWD': '/builds/slave/test', 11:50:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:12 INFO - 'SHELL': '/bin/bash', 11:50:12 INFO - 'SHLVL': '1', 11:50:12 INFO - 'TERM': 'linux', 11:50:12 INFO - 'TMOUT': '86400', 11:50:12 INFO - 'USER': 'cltbld', 11:50:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039', 11:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:12 INFO - '_': '/tools/buildbot/bin/python'} 11:50:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:50:12 INFO - mozversion application_buildid: 20170109094010 11:50:12 INFO - mozversion application_changeset: dd6d4ca2066803fae7dc99fb872d7191a6421478 11:50:12 INFO - mozversion application_display_name: Nightly 11:50:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:12 INFO - mozversion application_name: Firefox 11:50:12 INFO - mozversion application_remotingname: firefox 11:50:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:50:12 INFO - mozversion application_vendor: Mozilla 11:50:12 INFO - mozversion application_version: 53.0a1 11:50:12 INFO - mozversion platform_buildid: 20170109094010 11:50:12 INFO - mozversion platform_changeset: dd6d4ca2066803fae7dc99fb872d7191a6421478 11:50:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:50:12 INFO - mozversion platform_version: 53.0a1 11:50:12 INFO - using testdate: 1483991412 11:50:12 INFO - actual date: 1483991412 11:50:12 INFO - starting webserver on 'localhost:46142' 11:50:12 INFO - SUITE-START | Running 2 tests 11:50:12 INFO - TEST-START | dromaeo_css 11:50:12 INFO - operating with platform_type : linux_ 11:50:12 INFO - Initialising browser for dromaeo_css test... 11:50:12 INFO - TEST-INFO | started process 3296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4q8p3L/profile http://localhost:46142/getInfo.html) 11:50:13 INFO - PROCESS | 3296 | 1483991413637 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 11:50:18 INFO - PROCESS | 3296 | __metrics Screen width/height:1600/1200 11:50:18 INFO - PROCESS | 3296 | colorDepth:24 11:50:18 INFO - PROCESS | 3296 | Browser inner width/height: 1024/697 11:50:18 INFO - PROCESS | 3296 | __metrics 11:50:18 ERROR - PROCESS | 3296 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 11:50:19 INFO - TEST-INFO | 3296: exit 0 11:50:19 INFO - Browser initialized. 11:50:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:19 INFO - TEST-INFO | started process 3418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4q8p3L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:31 INFO - PROCESS | 3418 | RSS: Main: 155090944 11:50:31 INFO - PROCESS | 3418 | 11:53:31 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:46142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46142/tests/dromaeo/cssquery-ext.html) 11:53:33 INFO - PROCESS | 3418 | RSS: Main: 165629952 11:53:33 INFO - PROCESS | 3418 | 11:55:20 INFO - PROCESS | 3418 | ************************* 11:55:20 INFO - PROCESS | 3418 | A coding exception was thrown and uncaught in a Task. 11:55:20 INFO - PROCESS | 3418 | 11:55:20 INFO - PROCESS | 3418 | Full message: ReferenceError: fetch is not defined 11:55:20 INFO - PROCESS | 3418 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:55:20 INFO - PROCESS | 3418 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:55:20 INFO - PROCESS | 3418 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:55:20 INFO - PROCESS | 3418 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:55:20 INFO - PROCESS | 3418 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:55:20 INFO - PROCESS | 3418 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:55:20 INFO - PROCESS | 3418 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:55:20 INFO - PROCESS | 3418 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:55:20 INFO - PROCESS | 3418 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:55:20 INFO - PROCESS | 3418 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:55:20 INFO - PROCESS | 3418 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:55:20 INFO - PROCESS | 3418 | 11:55:20 INFO - PROCESS | 3418 | ************************* 11:56:35 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:46142/tests/dromaeo/cssquery-ext.html (next: http://localhost:46142/tests/dromaeo/cssquery-jquery.html) 11:56:36 INFO - PROCESS | 3418 | RSS: Main: 161292288 11:56:36 INFO - PROCESS | 3418 | 11:59:38 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:46142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46142/tests/dromaeo/cssquery-mootools.html) 11:59:38 INFO - PROCESS | 3418 | RSS: Main: 165535744 11:59:38 INFO - PROCESS | 3418 | 12:02:40 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:46142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46142/tests/dromaeo/cssquery-prototype.html) 12:02:41 INFO - PROCESS | 3418 | RSS: Main: 161533952 12:02:41 INFO - PROCESS | 3418 | 12:05:44 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:46142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46142/tests/dromaeo/cssquery-yui.html) 12:05:44 INFO - PROCESS | 3418 | RSS: Main: 165244928 12:05:44 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:46142/tests/dromaeo/cssquery-yui.html (next: http://localhost:46142/tests/dromaeo/cssquery-dojo.html) 12:08:47 INFO - PROCESS | 3418 | RSS: Main: 164675584 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | __start_tp_report 12:08:47 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 12:08:47 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 12:08:47 INFO - PROCESS | 3418 | |i|pagename|runs| 12:08:47 INFO - PROCESS | 3418 | |0;dojo.html;3189.059227527879;3212.9518057229147;3213.0200288911888;3228.3059142284405;3233.5473033775274;5382.300300960869;5411.269478620385;5435.293411856463;5457.918131228034;5480.232767412561;5386.057439948013;5458.372287186975;5459.645123067008;5501.229827824108;5620.859478513029;4880.121578115946;4899.142650036247;4932.136876046678;5021.422536408323;5034.521720436553;4948.57937075349;5034.949650503485;5037.1940489521685;5037.974810125963;5111.974440127794;5030.849074527733;5049.040682270357;5058.064258112224;5087.186050231945;5087.745612719368;4906.950930490721;4918.336024636664;4951.900961980777;5062.721550314731;5100.948990510122;4916.410030796327;4932.284818701304;4954.7274899880495;4960.751962401865;4974;5400.594955378362;5423.457654234585;5451.781928722847;5455.618106732531;5473.616846820724;5761.9135712964335;5773.509251713609;5786.189933409326;5788.768449262025;5820.243368362128;5928.49607783339;5936.198613187207;5943.613665111754;5953.732082056318;6012.6392416455155;5534.391216966131;5557.3331200255825;5558.082916318843;5563.332400111932;5566.109422492423;5897.262842144732;5911.083782013795;6017.759289628366;6053.213082299273;6071.726772295169;5817.272840894888;5865.237519122486;5870.970645146833;5916.171735956969;5934.554908381889;5937.168796368512;5978.820635380858;5983.192269043623;5988.28140623128;5999.640021598718;5767.625104368202;5770.451807078321;5774.335951365562;5854.941450585525;5900.7049647518315;5868.23712917318;5870.236869207061;5870.972579798518;5880.26496687914;5913.231279933581;4471.329300604935;4511.120331535319;4536.251518499411;4545.909081818411;4579.7252164870215;4001.3997900315185;4009.0979529605606;4035.858744943913;4052.959470405317;4082.040720430696;5556.055470570012;5650.915236271459;5665.291838520185;5666.15007748841;5705.800296989585;5946.405359464019;5993.820185394445;6004.939950600526;6019.367966363468;6023.69881505923;5389.730513474389;5575.804846830341;5599.552035837205;5638.464345887134;5651.745671444713;4938.876528086755;5032.773525191302;5037.093323201786;5042.117629414838;5153.304303918998;6188.350223226586;6190.969045154746;6204.627722336674;6208.317085120633;6220.657863817533;5979.162917191509;5996.8800623988145;6022;6022.789202377896;6025.939740602538;5964.642121472552;6087;6100.962836317748;6161.507079433724;6204.5967012144065;5877.4122587740885;5890.558208134493;5907.675077870758;5915.171875937286;5917.082852157922;5901.173835662925;5935.762569497345;5996.37038110992;6001.639901605918;6015.518758499397;5745.080787074048;5814.796482123105;5832.12518122285;5868.94131058701;5904;5802.071668533014;5805.129230615273;5810.854728631818;5812.128180772749;5836.182934389274;5608.943910560843;5702.030654788613;5813.563982701399;5835.270591176103;5858.062709966385;5725.19847221381;5793.333766616893;5799.8550036249435;5828.679422631796;5845.970770146122;5641.633293835887;5653.519450846724;5655;5665.801696940587;5666.093425051972 12:08:47 INFO - PROCESS | 3418 | |1;ext.html;568.6786965364569;591.1162811596664;591.9940800591994;629.119233073697;635.5995722694702;43375;44124.33813492796;44130.77934610326;44531;44668;44773.328400074024;45888.54111458884;46028.53971460284;46044.539554604446;46078.769606151924;8688.174623410765;9010.819783604324;10219.642312519063;10515.106215971613;10547.683569492927;10324.432156231403;10469.947650261738;10500.369977801356;10525.684229473129;10535.47322633869;10479.947600261989;10552.103071238955;10556.524956376943;10606.893931060706;10638.414887181201;10502.212334074937;10552.261341706084;10558;10560.788784224349;10562.841557376645;10330.638427654996;10384.221183411275;10386.169106471463;10391.428471434068;10407.895921040768;39339.80330098331;39474.80262598697;39501.40747888784;39520.20959580821;39834.40248396277;4179.686523510719;4195.2658284800345;4249.660027197817;4264.957350426487;4331.328644060176;29485.557716634266;29902.70097299021;29913;29988.400231995456;30075.097747067623;4102.487189101363;4102.815373308208;4172.666186705056;4323.1785960667685;4346.8913277168;319331;319722;320722;321127;323581;54625.45374546283;54691.179632305546;54835.17747233795;55090.35918714209;55110.173347399825;58049.70975145097;58214.417855821746;58249.70875145597;58287.46269104428;58335;14987.850121498863;16145.919270403572;16654.916725416537;16655;16694.749578756328;11359.886401136047;11561.595344162914;11583.826242606368;11679.591214307628;11767.058635309155;17122.229499672543;17148.742768858476;17178.828211717973;17232.310707571556;17304.567385815455;6929.826754331182;6948.409385202213;7078.610676412847;7218.963905180441;7246.96376518114;970.8106919150698;977.9145148884733;978.295627148452;985.9654912078042;990.1237404896718;31140.66445016633;31173.8441307792;31316.843415782776;31406.685933140376;31542.684573154434;1131.7566723154562;1133.880942501042;1166.2419427372276;1167.6321958583019;1257.2330878164312;16529.752053719203;16635;16892.15539223034;16928.49214523566;16955.660886782443;327978;331251;332637;334798;335917;58656.120158196805;59218.703906480194;59229;59533;59777.70111149504;1457.5263039512201;1462.714770619719;1483.5771805035513;1503.2183264702294;1515.0682330366744;28879.278018049718;28916.39752422292;30986.225344366572;32066;32429.67570324361;51430;51851.48148518467;51980.22029669634;52182.739086304326;52284.47715522796;395920;396768;396905;399772;400867;25847.353816154748;26615.201543953714;26705.465890681688;26766.866165669046;28573.28566785847;43216.567834322515;43593.78203109091;43595.56404435915;43937.56062439334;45118.32322515099;36913.815430922674;37005.50327005872;37354;37365.252694946495;37396.43905341477;36817;37031;37057.629423706494;37081.10648381989;37766;36000.27999439944;36098.819505902306;37103.257934840614;37119.44320835244;37796.43305350367;30973;33431.16422089467;33456.832715836266;33467.66532334645;33487;25205.49589008173;25398.365040874127;25459.618105728798;25494;25811.354716131496 12:08:47 INFO - PROCESS | 3418 | |2;jquery.html;418.9763775761546;428.63994244834333;431.0774941624923;439.8174757475648;444.22039320991655;19172.42482725519;19449.41651750448;20754.27360042399;20875.060622271998;20880;20887.955602219903;21206.363809085753;21287.467813304676;21602.351929442142;22740.317790466313;5775.364709881899;5983.730732117066;6005.819825405245;6041.9697901510435;6042.667653279068;5734.225879506255;5832.737526811304;5865.32548756892;5887.381824908387;5900.114982752579;5832.241808564881;5871.207387002764;5879.118132280149;5915.9704201478935;5926.1110833374905;5656.858578535528;5847.79532716355;5878.470937615592;5888.322842873082;5891.705414729267;5133.435322114565;5241.50205730455;5291.603129765283;5297.814576489843;5319.5744340452675;24179.87910060456;24824.131155409654;24878.751212487823;25097.49805003908;25132.12037578676;3160.1783536280504;3193.505006723938;3213.5661685672367;3216.3567286542784;3225.2420681139915;10496.737581560446;10840.295380800222;14243.715125697532;14561.344739486749;15464.768028479582;1976.8517361197823;1993.8703984240979;1995.2517805822818;2001.0995052226556;2007.6787713965696;98348;99387;102544.48727756388;102955.48522257416;103840;11886.524539018515;12010.099242556844;12116.515339386502;12198.451069701885;12371.876281237252;16669.583260418345;16705.749413758804;16752.41366552165;16839.32642694303;16931.661366772594;8043.959780201179;8308.958455207685;8387.62255698495;8591;8655.754092215418;7693.961530192425;7749.612519374009;7864.4888082274465;8000.439969202216;8013.398995075393;4972.179590367621;5024.62315326352;5028.698278103326;5133.820316288987;5138.948610513847;2079.396974877299;2127.5106725453234;2145.9678104828126;2152.257471172474;2160.1359456217638;937.9671711490065;952.3714348529937;960.1262850805733;972.6838777397375;975.770693886936;18783.812161878206;19593.608127837364;20680.58638827215;21941.561168776854;21971.450713732283;1072.099436473366;1099.4887377369562;1119.255694962857;1124.656979621207;1133.4332833583208;10550.894491055145;11191.552337906556;11315.434228288552;11326.263792853439;11530.76938461226;581168;591506;600952;611765;613190;93123;95800;109458.45270773754;109487;112630.43684781523;454.1054123377008;474.44016061048296;474.85991632468506;476.0811633547287;476.9713817170981;11012.39431831257;11166.720831979266;11905.761884762083;12021.459034343301;12065.758684826078;35785.821070894475;46160.14581408731;46511.76744116258;46568.30147547857;47089;67057;68053.97919031119;68742;68760.3123968754;68762.31237687559;8576.957115214384;8829.558522073743;8960.731178064669;9105.362624616213;9244;11972.221805582609;14032.158070515801;14192.077514961495;14266.500672476413;14300.213488258245;11666.650000499998;11862.347570883685;11947.880521194676;11983.520659173884;12167.939160304142;11634.360110193682;11891.345975971404;11916.702082447662;12148.574799881962;12281.754364912831;12188.75622487563;12254;12297.32364719949;12440.253584784941;12591.433385497492;8682.565871706516;8698.13018698125;8824.779380515538;9016;9345.953270233877;8790.736277911672;11890.821637675268;12232.327222002876;12427.813582796447;12494.687632809253 12:08:47 INFO - PROCESS | 3418 | |3;mootools.html;1446.4358900028983;1477.4828809916528;1479.9999999999993;1492.8507149285074;1493.5743313155747;7539.547627142361;7858.567778772165;8088.352931765459;8409.41134120611;8463.830723385528;8078.596070196496;8270.338372930166;8288.419810613259;8462.746117616465;8484.745457636265;2177.7822217778216;2221.133757834446;2222.8332875034357;2229.4314949687805;2232.6762619420174;2256.0411824974403;2293.9885300573474;2299.908003679851;2300.6894069300683;2301.137073597401;2221.5001624634488;2240.0591751464344;2243.7644047375034;2254.5152792149684;2257.0407576779803;2189.824814014883;2191.561687662458;2193.8683678979232;2210.7789221077924;2223.1107556977177;2207.2054060538194;2216.501287210365;2219.323106452531;2230.9626023898963;2247.9775202247934;7898.052233731932;8230.341572674231;8314.958425207835;8368.83262334756;8412.537310447922;5013.924791128136;5089.974550127263;5132.974335128338;5150.484951504857;5156.819511317086;3066.8926587569326;3159.7788154829173;3340.5657264555693;3351.7151042161445;3353.2622822978906;1258.653870185697;1289.748499042687;1311.511434521815;1330.527662679754;1340.229368113329;10810.837837432446;10877.456127193609;10920.235583509157;10948.069414099731;11037.392943388111;4221.303484924953;4339.218940590724;4416.933745993812;4477.171723231213;4531.750753708578;9114.726558203265;9124.863127053099;9140.177384035469;9146.405483643543;9155.404898681565;5064.696118232918;5089.160288552347;5098.133317336062;5100.974495127501;5127.64106512548;4241.066965267636;4635.142498637762;4744.4069491313585;4752.144613969519;4765.380500534978;3721.2371463849845;3783.319002579507;3870.2453021661067;3886.378179491268;3906.7265291429894;1300.9674758131123;1328.3955800110925;1330.414617568267;1334.652990222549;1343.825302710661;953.2755106119399;966.7534778631403;977.6431602465049;980.9754756131011;990.321629683669;5202.8959420812125;5227.163653815447;5418.91871621926;5441.5374693151525;5655.236543066716;572.8338781753245;578.3811321885543;586.9325027621793;598.3059650805133;598.9640621562633;3734.663880250736;3772.075841418815;3773.811309434517;3781.810909454516;3899.9610003900166;9404.153626173676;9413.952930235306;9792.314537982415;10047.296689231684;10063.39619622825;9868.358556693793;9963.701088967342;9965.55155018026;9975.600975961026;9979.351342162736;7565.167831538526;7676.57778822159;7686.154523002577;7688.308052275322;7754.92245077542;5359.544438722753;5386.622936394415;5515.420880807457;5711.771529138788;5724.79963201286;8589.957050214709;8594.613242404232;8688.956555217184;8717.869231961398;8730.519821409629;8753.606087726195;8753.737387878375;8795.560221989002;8856.734297971072;8891.110888911317;7112.146542414944;7207.5675459472595;7299.817504562428;7330.450216233698;7471.701131954661;8078.919210807817;8095.23095305945;8153.918460815553;8155.673773049249;8161.061477930114;7281.781546553612;7284.198738138906;7348.265173482609;7510.511816732113;7533.209013053551;7128.964355178191;7147.428205743632;7156.713731450684;7353.191148973501;7386.298301661333;6032;6135.6932153393045;6138.754449821957;6142.662153581596;6165.0444181152;4796;4915;5062.56968157696;5093.490650934877;5152.845414637567;4906.92639610399;4913.803447862046;4961.107000739901;4975.203967365204;5041.369828771403 12:08:47 INFO - PROCESS | 3418 | |4;prototype.html;391.751237963893;406.68888300450163;409.66407545812444;411.2884709452648;413.9919296512993;5039.370078740158;5290.6825590464505;5452.20942963271;5473.2063850741615;5526.917096243555;5369.087255166622;5374.6237763356585;5376.8118115865955;5383.703896285702;5391.353037635479;4239.08859595187;4240.893977650568;4241.257779888522;4251.936220956688;4256.680748943826;4025;4212.915741685165;4243.448351714273;4249.25638013348;4252.744835309876;4222.619964203221;4247.638950689196;4249.957500424987;4253.680973926967;4258.850940217093;4240.639545638609;4241.151769646083;4243.575642435747;4258.936115958263;4272.359146128075;3782.111203867089;3783.2244389900006;3790.6588407043223;3794.924101517954;3802.714796390254;5094.388673359221;5262.236975638511;5268.341457317835;5275.815346462856;5302.310699609026;4816.783244753994;4826.083044221622;4827.951720482821;4836.903261934777;4842.2736589511505;5489.3412790465;5676.205331253628;5702.344230413514;5710.828675139753;5719.914201286984;4095.795210239476;4103.712740108193;4115.670746340285;4115.8971025724295;4129.97935010326;5881.735426883198;5920.467157955804;5932.3474417814;5958.676116314641;5967.4629283364275;4198.202341555095;4200.369944508348;4215.473065866767;4218.957810421856;4270.7864606769535;4522.321651752263;4526.352084030879;4527.320901864747;4527.388802511685;4529.32060190974;5019.623528235397;5026.271190677405;5031.84904452867;5050.116229659869;5102.5252752415045;5618.6628802272;5696.9490983246;5730.656160630376;5762.049261871828;5837.241158649348;1520.6198450387403;1523.9009464385001;1527.3279756906925;1529.5717199184246;1530.4796369234514;1074.5755426606447;1099.4777480696605;1105.5080489182396;1106.1372129738816;1125.442905761637;5280.419153893069;5314.395945986439;5320.707361095099;5343.370272066979;5370.221317908881;5664.603477756517;5688.829335119953;5690.9146362804595;5701.629394089371;5730.971345143247;5187.610929180327;5219.555093638256;5323.813666521653;5324.600654950894;5362.65142765719;3044.588980487606;3057.5107982723102;3058.632964044329;3061.3571150058738;3067.92330191747;5618.747156377973;5922.555808314308;5931.258592675916;5946.84036612865;5954.642721436728;5744.569157313218;5794.739236734357;5811.215485909433;5831.650100993954;5844.736986835603;5847.035239185572;5867.530597552186;5874.971879921082;5883.3234178069215;5911.438413350725;5512.283403157564;5687.582777319705;5758.740856661544;5798.362180160095;5856.385079566755;5786.1899334094105;5809.128630705428;5809.2738407699035;5846.1815345852465;5854.414558544111;5757.5681823864215;6058;6103.206583144341;6105.84735381619;6107.297660769068;4090.365993271048;4092.766714295673;4184.686148538811;4249.213895429355;4252.255855225385;5844.912326315024;5889.823305300848;5897.70511474416;5903.7048147593305;5905.40945905406;5598.664080155204;5729.054705973635;5734.043509978102;5766.693322670965;5769.59612827098;5674.205611214516;5684.772609095755;5710.314762228559;5732.57005724564;5734.455226753452;5673.851012687997;5711.914321285267;5730.541556675539;5744.511716504144;5770.307563092456;5575.637583557056;5728.195618380197;5733.254676891977;5769;5789.942100579109;5613.073842815889;5613.550915926798;5616.157576363578;5618.69097199658;5624.803131890364 12:08:47 INFO - PROCESS | 3418 | |5;yui.html;765.219476134343;794.6146119132223;811.1766556944702;856.3063918226237;869.439211708448;13835.100718453306;14758.33587488563;14781.039232449883;14804.55586332409;14853.554393368217;14009.579712608638;14223.928880355585;14311.856881431182;14355.856441435582;14363.066400683949;633.2464367402775;646.2116218213772;710.570105086423;737.0528870401522;739.7152096442854;741.3698356397047;749.0748925077552;750.7860259825951;751.346328694037;753.8115471132216;796.4385108498494;798.2815466080544;800.1878093734864;801.623237078575;804.0632662947688;795.7374066558021;796.9123396426388;797.1510341486298;798;798.0742338886863;576.8413686236277;581.569638467531;581.6277582347301;581.764385423904;584.4856526256909;14875.107493550313;15007.324670389859;15023.248837558078;15069.171195584238;15111.244437778067;14751;15119.092854428769;15616.141112238822;15664.216789160497;15856.60358491047;12055.913209346627;12139;12238.632841014694;12264.693382665415;12348.320842353667;3782.867599634;3850.711196660234;3897.3569361055393;4019.839206431739;4022.2960981828064;77008.61495692542;77199.61400192963;77912;78154.6092269535;78515.6074219631;11635.360055196876;11728.882711172779;11742.941285293518;11819.231749936398;11833.88166118345;23935.640965385533;24221.51556968851;24274.757252427604;24479.14322998722;24635.876820615784;7715.884261736079;7773.727919522789;7782.688692452239;7843.490173138728;7876.842463150705;4212.599803018708;4229.725067870579;4258.68059895509;4328.783560821947;4358.542353052947;3580.3913334733156;3678.33789917812;3678.5953545110015;3681.889543313705;3682.3003629310347;579.2180556249031;581.4185814185814;583.3612194646855;598.9966805600601;604.1360853978853;804.4368941740805;813.5037627047496;825.1830687619214;836.4567373196443;859.6948083430417;9560.28297877662;9696.824349980963;9722.708318750449;10191.643292484727;10562.841557376645;754.4040208235542;774.7094839435211;783.2872086401347;794.9324307433933;798.6086817459519;4477.619402350837;4591.357209990604;4959.851204463872;4966.081274964144;5006.74966251686;78436.21563784403;79479.20520794718;82815;83480;84347;51085.48914510882;52243.73878130661;55653.44346556483;71795.2820471799;73660.63169684117;47178.348757793996;50917.74541127271;57040.859182816945;58201;58205.417945820845;9673.226141908772;10162.726435370136;10213.642522511676;10331.948340258552;10373.325733827278;39455.408168878064;39618.60381396149;39799;40302.28210997772;40718;49092;49226;49966.50033499764;50090.2486462696;51953;12943.5469758558;12964.675883102998;12966.611001669966;13014.349282536024;13197.934010329887;13041.282729449591;13153.868461315264;13293.601191964257;13521.59435216945;13598.11612245201;13036.934815325863;13147.802782958071;13349.799753003907;13700.314984250947;14009.719805603627;13078.215307081606;13487.460501580219;13566.525171618947;13709.866299900961;14004.509842155883;12473.501059957864;12692.301923394301;13022.413991370222;13388.464461421434;13517.662058448617;9935.403875767477;10226.181905447695;10581.841272380767;10834.486397165194;11233.775324493628;8601.784955376166;9740.733704618355;10132.594696212363;10235.7441063974;10245.692629221136 12:08:47 INFO - PROCESS | 3418 | __end_tp_report 12:08:47 INFO - PROCESS | 3418 | __start_cc_report 12:08:47 INFO - PROCESS | 3418 | _x_x_mozilla_cycle_collect,309 12:08:47 INFO - PROCESS | 3418 | __end_cc_report 12:08:47 INFO - PROCESS | 3418 | __startTimestamp1483992527550__endTimestamp 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | ------- Summary: start ------- 12:08:47 INFO - PROCESS | 3418 | Number of tests: 6 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | [#0] dojo.html Cycles:165 Average:5493.22 Median:5725.20 stddev:634.09 (11.1%) stddev-sans-first:609.72 12:08:47 INFO - PROCESS | 3418 | Values: 3189.1 3213.0 3213.0 3228.3 3233.5 5382.3 5411.3 5435.3 5457.9 5480.2 5386.1 5458.4 5459.6 5501.2 5620.9 4880.1 4899.1 4932.1 5021.4 5034.5 4948.6 5034.9 5037.2 5038.0 5112.0 5030.8 5049.0 5058.1 5087.2 5087.7 4907.0 4918.3 4951.9 5062.7 5100.9 4916.4 4932.3 4954.7 4960.8 4974.0 5400.6 5423.5 5451.8 5455.6 5473.6 5761.9 5773.5 5786.2 5788.8 5820.2 5928.5 5936.2 5943.6 5953.7 6012.6 5534.4 5557.3 5558.1 5563.3 5566.1 5897.3 5911.1 6017.8 6053.2 6071.7 5817.3 5865.2 5871.0 5916.2 5934.6 5937.2 5978.8 5983.2 5988.3 5999.6 5767.6 5770.5 5774.3 5854.9 5900.7 5868.2 5870.2 5871.0 5880.3 5913.2 4471.3 4511.1 4536.3 4545.9 4579.7 4001.4 4009.1 4035.9 4053.0 4082.0 5556.1 5650.9 5665.3 5666.2 5705.8 5946.4 5993.8 6004.9 6019.4 6023.7 5389.7 5575.8 5599.6 5638.5 5651.7 4938.9 5032.8 5037.1 5042.1 5153.3 6188.4 6191.0 6204.6 6208.3 6220.7 5979.2 5996.9 6022.0 6022.8 6025.9 5964.6 6087.0 6101.0 6161.5 6204.6 5877.4 5890.6 5907.7 5915.2 5917.1 5901.2 5935.8 5996.4 6001.6 6015.5 5745.1 5814.8 5832.1 5868.9 5904.0 5802.1 5805.1 5810.9 5812.1 5836.2 5608.9 5702.0 5813.6 5835.3 5858.1 5725.2 5793.3 5799.9 5828.7 5846.0 5641.6 5653.5 5655.0 5665.8 5666.1 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | [#1] ext.html Cycles:180 Average:51968.01 Median:184142.50 stddev:92440.89 (50.2%) stddev-sans-first:92619.66 12:08:47 INFO - PROCESS | 3418 | Values: 568.7 591.1 592.0 629.1 635.6 43375.0 44124.3 44130.8 44531.0 44668.0 44773.3 45888.5 46028.5 46044.5 46078.8 8688.2 9010.8 10219.6 10515.1 10547.7 10324.4 10469.9 10500.4 10525.7 10535.5 10479.9 10552.1 10556.5 10606.9 10638.4 10502.2 10552.3 10558.0 10560.8 10562.8 10330.6 10384.2 10386.2 10391.4 10407.9 39339.8 39474.8 39501.4 39520.2 39834.4 4179.7 4195.3 4249.7 4265.0 4331.3 29485.6 29902.7 29913.0 29988.4 30075.1 4102.5 4102.8 4172.7 4323.2 4346.9 319331.0 319722.0 320722.0 321127.0 323581.0 54625.5 54691.2 54835.2 55090.4 55110.2 58049.7 58214.4 58249.7 58287.5 58335.0 14987.9 16145.9 16654.9 16655.0 16694.7 11359.9 11561.6 11583.8 11679.6 11767.1 17122.2 17148.7 17178.8 17232.3 17304.6 6929.8 6948.4 7078.6 7219.0 7247.0 970.8 977.9 978.3 986.0 990.1 31140.7 31173.8 31316.8 31406.7 31542.7 1131.8 1133.9 1166.2 1167.6 1257.2 16529.8 16635.0 16892.2 16928.5 16955.7 327978.0 331251.0 332637.0 334798.0 335917.0 58656.1 59218.7 59229.0 59533.0 59777.7 1457.5 1462.7 1483.6 1503.2 1515.1 28879.3 28916.4 30986.2 32066.0 32429.7 51430.0 51851.5 51980.2 52182.7 52284.5 395920.0 396768.0 396905.0 399772.0 400867.0 25847.4 26615.2 26705.5 26766.9 28573.3 43216.6 43593.8 43595.6 43937.6 45118.3 36913.8 37005.5 37354.0 37365.3 37396.4 36817.0 37031.0 37057.6 37081.1 37766.0 36000.3 36098.8 37103.3 37119.4 37796.4 30973.0 33431.2 33456.8 33467.7 33487.0 25205.5 25398.4 25459.6 25494.0 25811.4 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | [#2] jquery.html Cycles:180 Average:33605.45 Median:3176.84 stddev:99024.14 (3117.1%) stddev-sans-first:99270.58 12:08:47 INFO - PROCESS | 3418 | Values: 419.0 428.6 431.1 439.8 444.2 19172.4 19449.4 20754.3 20875.1 20880.0 20888.0 21206.4 21287.5 21602.4 22740.3 5775.4 5983.7 6005.8 6042.0 6042.7 5734.2 5832.7 5865.3 5887.4 5900.1 5832.2 5871.2 5879.1 5916.0 5926.1 5656.9 5847.8 5878.5 5888.3 5891.7 5133.4 5241.5 5291.6 5297.8 5319.6 24179.9 24824.1 24878.8 25097.5 25132.1 3160.2 3193.5 3213.6 3216.4 3225.2 10496.7 10840.3 14243.7 14561.3 15464.8 1976.9 1993.9 1995.3 2001.1 2007.7 98348.0 99387.0 102544.5 102955.5 103840.0 11886.5 12010.1 12116.5 12198.5 12371.9 16669.6 16705.7 16752.4 16839.3 16931.7 8044.0 8309.0 8387.6 8591.0 8655.8 7694.0 7749.6 7864.5 8000.4 8013.4 4972.2 5024.6 5028.7 5133.8 5138.9 2079.4 2127.5 2146.0 2152.3 2160.1 938.0 952.4 960.1 972.7 975.8 18783.8 19593.6 20680.6 21941.6 21971.5 1072.1 1099.5 1119.3 1124.7 1133.4 10550.9 11191.6 11315.4 11326.3 11530.8 581168.0 591506.0 600952.0 611765.0 613190.0 93123.0 95800.0 109458.5 109487.0 112630.4 454.1 474.4 474.9 476.1 477.0 11012.4 11166.7 11905.8 12021.5 12065.8 35785.8 46160.1 46511.8 46568.3 47089.0 67057.0 68054.0 68742.0 68760.3 68762.3 8577.0 8829.6 8960.7 9105.4 9244.0 11972.2 14032.2 14192.1 14266.5 14300.2 11666.7 11862.3 11947.9 11983.5 12167.9 11634.4 11891.3 11916.7 12148.6 12281.8 12188.8 12254.0 12297.3 12440.3 12591.4 8682.6 8698.1 8824.8 9016.0 9346.0 8790.7 11890.8 12232.3 12427.8 12494.7 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | [#3] mootools.html Cycles:180 Average:5376.30 Median:5154.83 stddev:2932.43 (56.9%) stddev-sans-first:2925.78 12:08:47 INFO - PROCESS | 3418 | Values: 1446.4 1477.5 1480.0 1492.9 1493.6 7539.5 7858.6 8088.4 8409.4 8463.8 8078.6 8270.3 8288.4 8462.7 8484.7 2177.8 2221.1 2222.8 2229.4 2232.7 2256.0 2294.0 2299.9 2300.7 2301.1 2221.5 2240.1 2243.8 2254.5 2257.0 2189.8 2191.6 2193.9 2210.8 2223.1 2207.2 2216.5 2219.3 2231.0 2248.0 7898.1 8230.3 8315.0 8368.8 8412.5 5013.9 5090.0 5133.0 5150.5 5156.8 3066.9 3159.8 3340.6 3351.7 3353.3 1258.7 1289.7 1311.5 1330.5 1340.2 10810.8 10877.5 10920.2 10948.1 11037.4 4221.3 4339.2 4416.9 4477.2 4531.8 9114.7 9124.9 9140.2 9146.4 9155.4 5064.7 5089.2 5098.1 5101.0 5127.6 4241.1 4635.1 4744.4 4752.1 4765.4 3721.2 3783.3 3870.2 3886.4 3906.7 1301.0 1328.4 1330.4 1334.7 1343.8 953.3 966.8 977.6 981.0 990.3 5202.9 5227.2 5418.9 5441.5 5655.2 572.8 578.4 586.9 598.3 599.0 3734.7 3772.1 3773.8 3781.8 3900.0 9404.2 9414.0 9792.3 10047.3 10063.4 9868.4 9963.7 9965.6 9975.6 9979.4 7565.2 7676.6 7686.2 7688.3 7754.9 5359.5 5386.6 5515.4 5711.8 5724.8 8590.0 8594.6 8689.0 8717.9 8730.5 8753.6 8753.7 8795.6 8856.7 8891.1 7112.1 7207.6 7299.8 7330.5 7471.7 8078.9 8095.2 8153.9 8155.7 8161.1 7281.8 7284.2 7348.3 7510.5 7533.2 7129.0 7147.4 7156.7 7353.2 7386.3 6032.0 6135.7 6138.8 6142.7 6165.0 4796.0 4915.0 5062.6 5093.5 5152.8 4906.9 4913.8 4961.1 4975.2 5041.4 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | [#4] prototype.html Cycles:180 Average:4801.14 Median:5365.87 stddev:1372.90 (25.6%) stddev-sans-first:1336.26 12:08:47 INFO - PROCESS | 3418 | Values: 391.8 406.7 409.7 411.3 414.0 5039.4 5290.7 5452.2 5473.2 5526.9 5369.1 5374.6 5376.8 5383.7 5391.4 4239.1 4240.9 4241.3 4251.9 4256.7 4025.0 4212.9 4243.4 4249.3 4252.7 4222.6 4247.6 4250.0 4253.7 4258.9 4240.6 4241.2 4243.6 4258.9 4272.4 3782.1 3783.2 3790.7 3794.9 3802.7 5094.4 5262.2 5268.3 5275.8 5302.3 4816.8 4826.1 4828.0 4836.9 4842.3 5489.3 5676.2 5702.3 5710.8 5719.9 4095.8 4103.7 4115.7 4115.9 4130.0 5881.7 5920.5 5932.3 5958.7 5967.5 4198.2 4200.4 4215.5 4219.0 4270.8 4522.3 4526.4 4527.3 4527.4 4529.3 5019.6 5026.3 5031.8 5050.1 5102.5 5618.7 5696.9 5730.7 5762.0 5837.2 1520.6 1523.9 1527.3 1529.6 1530.5 1074.6 1099.5 1105.5 1106.1 1125.4 5280.4 5314.4 5320.7 5343.4 5370.2 5664.6 5688.8 5690.9 5701.6 5731.0 5187.6 5219.6 5323.8 5324.6 5362.7 3044.6 3057.5 3058.6 3061.4 3067.9 5618.7 5922.6 5931.3 5946.8 5954.6 5744.6 5794.7 5811.2 5831.7 5844.7 5847.0 5867.5 5875.0 5883.3 5911.4 5512.3 5687.6 5758.7 5798.4 5856.4 5786.2 5809.1 5809.3 5846.2 5854.4 5757.6 6058.0 6103.2 6105.8 6107.3 4090.4 4092.8 4184.7 4249.2 4252.3 5844.9 5889.8 5897.7 5903.7 5905.4 5598.7 5729.1 5734.0 5766.7 5769.6 5674.2 5684.8 5710.3 5732.6 5734.5 5673.9 5711.9 5730.5 5744.5 5770.3 5575.6 5728.2 5733.3 5769.0 5789.9 5613.1 5613.6 5616.2 5618.7 5624.8 12:08:47 INFO - PROCESS | 3418 | 12:08:47 INFO - PROCESS | 3418 | [#5] yui.html Cycles:180 Average:16949.36 Median:4293.73 stddev:21436.78 (499.3%) stddev-sans-first:21462.47 12:08:47 INFO - PROCESS | 3418 | Values: 765.2 794.6 811.2 856.3 869.4 13835.1 14758.3 14781.0 14804.6 14853.6 14009.6 14223.9 14311.9 14355.9 14363.1 633.2 646.2 710.6 737.1 739.7 741.4 749.1 750.8 751.3 753.8 796.4 798.3 800.2 801.6 804.1 795.7 796.9 797.2 798.0 798.1 576.8 581.6 581.6 581.8 584.5 14875.1 15007.3 15023.2 15069.2 15111.2 14751.0 15119.1 15616.1 15664.2 15856.6 12055.9 12139.0 12238.6 12264.7 12348.3 3782.9 3850.7 3897.4 4019.8 4022.3 77008.6 77199.6 77912.0 78154.6 78515.6 11635.4 11728.9 11742.9 11819.2 11833.9 23935.6 24221.5 24274.8 24479.1 24635.9 7715.9 7773.7 7782.7 7843.5 7876.8 4212.6 4229.7 4258.7 4328.8 4358.5 3580.4 3678.3 3678.6 3681.9 3682.3 579.2 581.4 583.4 599.0 604.1 804.4 813.5 825.2 836.5 859.7 9560.3 9696.8 9722.7 10191.6 10562.8 754.4 774.7 783.3 794.9 798.6 4477.6 4591.4 4959.9 4966.1 5006.7 78436.2 79479.2 82815.0 83480.0 84347.0 51085.5 52243.7 55653.4 71795.3 73660.6 47178.3 50917.7 57040.9 58201.0 58205.4 9673.2 10162.7 10213.6 10331.9 10373.3 39455.4 39618.6 39799.0 40302.3 40718.0 49092.0 49226.0 49966.5 50090.2 51953.0 12943.5 12964.7 12966.6 13014.3 13197.9 13041.3 13153.9 13293.6 13521.6 13598.1 13036.9 13147.8 13349.8 13700.3 14009.7 13078.2 13487.5 13566.5 13709.9 14004.5 12473.5 12692.3 13022.4 13388.5 13517.7 9935.4 10226.2 10581.8 10834.5 11233.8 8601.8 9740.7 10132.6 10235.7 10245.7 12:08:47 INFO - PROCESS | 3418 | -------- Summary: end -------- 12:08:47 INFO - PROCESS | 3418 | 12:08:48 INFO - TEST-INFO | 3418: exit 0 12:08:48 INFO - TEST-OK | dromaeo_css | took 1115431ms 12:08:48 INFO - TEST-START | kraken 12:08:48 INFO - operating with platform_type : linux_ 12:08:48 INFO - Initialising browser for kraken test... 12:08:48 INFO - TEST-INFO | started process 3779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXuepay/profile http://localhost:46142/getInfo.html) 12:08:48 INFO - PROCESS | 3779 | 1483992528785 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 12:08:52 INFO - PROCESS | 3779 | __metrics Screen width/height:1600/1200 12:08:52 INFO - PROCESS | 3779 | colorDepth:24 12:08:52 INFO - PROCESS | 3779 | Browser inner width/height: 1024/697 12:08:52 INFO - PROCESS | 3779 | __metrics 12:08:52 ERROR - PROCESS | 3779 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 12:08:53 INFO - TEST-INFO | 3779: exit 0 12:08:53 INFO - Browser initialized. 12:08:53 INFO - Running cycle 1/1 for kraken test... 12:08:53 INFO - TEST-INFO | started process 3904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXuepay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:05 INFO - PROCESS | 3904 | RSS: Main: 155258880 12:09:05 INFO - PROCESS | 3904 | 12:09:08 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46142/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:08 INFO - PROCESS | 3904 | RSS: Main: 160956416 12:09:08 INFO - PROCESS | 3904 | 12:09:11 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46142/tests/kraken/driver.html?testName=audio-dft) 12:09:12 INFO - PROCESS | 3904 | RSS: Main: 160133120 12:09:12 INFO - PROCESS | 3904 | 12:09:15 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46142/tests/kraken/driver.html?testName=audio-fft) 12:09:15 INFO - PROCESS | 3904 | RSS: Main: 157265920 12:09:15 INFO - PROCESS | 3904 | 12:09:17 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46142/tests/kraken/driver.html?testName=audio-oscillator) 12:09:18 INFO - PROCESS | 3904 | RSS: Main: 157818880 12:09:18 INFO - PROCESS | 3904 | 12:09:20 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:21 INFO - PROCESS | 3904 | RSS: Main: 157769728 12:09:21 INFO - PROCESS | 3904 | 12:09:24 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46142/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:24 INFO - PROCESS | 3904 | RSS: Main: 162410496 12:09:24 INFO - PROCESS | 3904 | 12:09:28 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46142/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:28 INFO - PROCESS | 3904 | RSS: Main: 160079872 12:09:28 INFO - PROCESS | 3904 | 12:09:31 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46142/tests/kraken/driver.html?testName=json-parse-financial) 12:09:32 INFO - PROCESS | 3904 | RSS: Main: 160542720 12:09:32 INFO - PROCESS | 3904 | 12:09:33 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:34 INFO - PROCESS | 3904 | RSS: Main: 160559104 12:09:34 INFO - PROCESS | 3904 | 12:09:36 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:37 INFO - PROCESS | 3904 | RSS: Main: 160808960 12:09:37 INFO - PROCESS | 3904 | 12:09:39 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:39 INFO - PROCESS | 3904 | RSS: Main: 161136640 12:09:39 INFO - PROCESS | 3904 | 12:09:42 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:43 INFO - PROCESS | 3904 | RSS: Main: 161050624 12:09:43 INFO - PROCESS | 3904 | 12:09:46 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:46 INFO - PROCESS | 3904 | RSS: Main: 161013760 12:09:46 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:46142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46142/tests/kraken/driver.html?testName=ai-astar) 12:09:48 INFO - PROCESS | 3904 | RSS: Main: 162410496 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | __start_tp_report 12:09:48 INFO - PROCESS | 3904 | _x_x_mozilla_page_load 12:09:48 INFO - PROCESS | 3904 | _x_x_mozilla_page_load_details 12:09:48 INFO - PROCESS | 3904 | |i|pagename|runs| 12:09:48 INFO - PROCESS | 3904 | |0;ai-astar;103;113;112;111;111;113;111;111;113;111 12:09:48 INFO - PROCESS | 3904 | |1;audio-beat-detection;143;118;119;172;120;118;118;117;145;129 12:09:48 INFO - PROCESS | 3904 | |2;audio-dft;163;168;162;161;162;165;168;163;163;163 12:09:48 INFO - PROCESS | 3904 | |3;audio-fft;76;76;80;98;77;74;76;76;94;75 12:09:48 INFO - PROCESS | 3904 | |4;audio-oscillator;84;83;101;83;84;84;99;82;83;98 12:09:48 INFO - PROCESS | 3904 | |5;imaging-gaussian-blur;118;118;118;120;119;118;117;118;117;121 12:09:48 INFO - PROCESS | 3904 | |6;imaging-darkroom;148;148;147;151;148;147;148;149;148;148 12:09:48 INFO - PROCESS | 3904 | |7;imaging-desaturate;96;96;96;96;96;96;95;97;96;96 12:09:48 INFO - PROCESS | 3904 | |8;json-parse-financial;57;58;59;59;57;61;57;58;58;58 12:09:48 INFO - PROCESS | 3904 | |9;json-stringify-tinderbox;68;68;71;67;67;67;67;68;68;68 12:09:48 INFO - PROCESS | 3904 | |10;stanford-crypto-aes;80;83;84;82;80;89;84;81;80;85 12:09:48 INFO - PROCESS | 3904 | |11;stanford-crypto-ccm;128;126;126;132;126;129;125;128;169;134 12:09:48 INFO - PROCESS | 3904 | |12;stanford-crypto-pbkdf2;173;173;176;171;172;168;175;168;167;172 12:09:48 INFO - PROCESS | 3904 | |13;stanford-crypto-sha256-iterative;64;68;63;63;63;63;63;63;62;64 12:09:48 INFO - PROCESS | 3904 | __end_tp_report 12:09:48 INFO - PROCESS | 3904 | __start_cc_report 12:09:48 INFO - PROCESS | 3904 | _x_x_mozilla_cycle_collect,758 12:09:48 INFO - PROCESS | 3904 | __end_cc_report 12:09:48 INFO - PROCESS | 3904 | __startTimestamp1483992588699__endTimestamp 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | ------- Summary: start ------- 12:09:48 INFO - PROCESS | 3904 | Number of tests: 14 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.92 (2.6%) stddev-sans-first:0.97 12:09:48 INFO - PROCESS | 3904 | Values: 103.0 113.0 112.0 111.0 111.0 113.0 111.0 111.0 113.0 111.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:124.50 stddev:18.20 (14.6%) stddev-sans-first:18.68 12:09:48 INFO - PROCESS | 3904 | Values: 143.0 118.0 119.0 172.0 120.0 118.0 118.0 117.0 145.0 129.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.44 (1.5%) stddev-sans-first:2.57 12:09:48 INFO - PROCESS | 3904 | Values: 163.0 168.0 162.0 161.0 162.0 165.0 168.0 163.0 163.0 163.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.50 stddev:8.52 (11.1%) stddev-sans-first:8.90 12:09:48 INFO - PROCESS | 3904 | Values: 76.0 76.0 80.0 98.0 77.0 74.0 76.0 76.0 94.0 75.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:84.00 stddev:7.81 (9.3%) stddev-sans-first:8.14 12:09:48 INFO - PROCESS | 3904 | Values: 84.0 83.0 101.0 83.0 84.0 84.0 99.0 82.0 83.0 98.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 12:09:48 INFO - PROCESS | 3904 | Values: 118.0 118.0 118.0 120.0 119.0 118.0 117.0 118.0 117.0 121.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 12:09:48 INFO - PROCESS | 3904 | Values: 148.0 148.0 147.0 151.0 148.0 147.0 148.0 149.0 148.0 148.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 12:09:48 INFO - PROCESS | 3904 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:1.23 (2.1%) stddev-sans-first:1.22 12:09:48 INFO - PROCESS | 3904 | Values: 57.0 58.0 59.0 59.0 57.0 61.0 57.0 58.0 58.0 58.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 12:09:48 INFO - PROCESS | 3904 | Values: 68.0 68.0 71.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:2.86 (3.4%) stddev-sans-first:2.85 12:09:48 INFO - PROCESS | 3904 | Values: 80.0 83.0 84.0 82.0 80.0 89.0 84.0 81.0 80.0 85.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:128.50 stddev:13.21 (10.3%) stddev-sans-first:13.92 12:09:48 INFO - PROCESS | 3904 | Values: 128.0 126.0 126.0 132.0 126.0 129.0 125.0 128.0 169.0 134.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.50 stddev:3.03 (1.8%) stddev-sans-first:3.16 12:09:48 INFO - PROCESS | 3904 | Values: 173.0 173.0 176.0 171.0 172.0 168.0 175.0 168.0 167.0 172.0 12:09:48 INFO - PROCESS | 3904 | 12:09:48 INFO - PROCESS | 3904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.74 12:09:48 INFO - PROCESS | 3904 | Values: 64.0 68.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 64.0 12:09:48 INFO - PROCESS | 3904 | -------- Summary: end -------- 12:09:48 INFO - PROCESS | 3904 | 12:09:49 INFO - TEST-INFO | 3904: exit 0 12:09:49 INFO - TEST-OK | kraken | took 61444ms 12:09:49 INFO - SUITE-END | took 1176s 12:09:49 INFO - Completed test suite (00:19:36) 12:09:49 INFO - javascript benchmark 12:09:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7198.564266758262, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3189.059227527879, 3212.9518057229147, 3213.0200288911888, 3228.3059142284405, 3233.5473033775274, 5382.300300960869, 5411.269478620385, 5435.293411856463, 5457.918131228034, 5480.232767412561, 5386.057439948013, 5458.372287186975, 5459.645123067008, 5501.229827824108, 5620.859478513029, 4880.121578115946, 4899.142650036247, 4932.136876046678, 5021.422536408323, 5034.521720436553, 4948.57937075349, 5034.949650503485, 5037.1940489521685, 5037.974810125963, 5111.974440127794, 5030.849074527733, 5049.040682270357, 5058.064258112224, 5087.186050231945, 5087.745612719368, 4906.950930490721, 4918.336024636664, 4951.900961980777, 5062.721550314731, 5100.948990510122, 4916.410030796327, 4932.284818701304, 4954.7274899880495, 4960.751962401865, 4974.0, 5400.594955378362, 5423.457654234585, 5451.781928722847, 5455.618106732531, 5473.616846820724, 5761.9135712964335, 5773.509251713609, 5786.189933409326, 5788.768449262025, 5820.243368362128, 5928.49607783339, 5936.198613187207, 5943.613665111754, 5953.732082056318, 6012.6392416455155, 5534.391216966131, 5557.3331200255825, 5558.082916318843, 5563.332400111932, 5566.109422492423, 5897.262842144732, 5911.083782013795, 6017.759289628366, 6053.213082299273, 6071.726772295169, 5817.272840894888, 5865.237519122486, 5870.970645146833, 5916.171735956969, 5934.554908381889, 5937.168796368512, 5978.820635380858, 5983.192269043623, 5988.28140623128, 5999.640021598718, 5767.625104368202, 5770.451807078321, 5774.335951365562, 5854.941450585525, 5900.7049647518315, 5868.23712917318, 5870.236869207061, 5870.972579798518, 5880.26496687914, 5913.231279933581, 4471.329300604935, 4511.120331535319, 4536.251518499411, 4545.909081818411, 4579.7252164870215, 4001.3997900315185, 4009.0979529605606, 4035.858744943913, 4052.959470405317, 4082.040720430696, 5556.055470570012, 5650.915236271459, 5665.291838520185, 5666.15007748841, 5705.800296989585, 5946.405359464019, 5993.820185394445, 6004.939950600526, 6019.367966363468, 6023.69881505923, 5389.730513474389, 5575.804846830341, 5599.552035837205, 5638.464345887134, 5651.745671444713, 4938.876528086755, 5032.773525191302, 5037.093323201786, 5042.117629414838, 5153.304303918998, 6188.350223226586, 6190.969045154746, 6204.627722336674, 6208.317085120633, 6220.657863817533, 5979.162917191509, 5996.8800623988145, 6022.0, 6022.789202377896, 6025.939740602538, 5964.642121472552, 6087.0, 6100.962836317748, 6161.507079433724, 6204.5967012144065, 5877.4122587740885, 5890.558208134493, 5907.675077870758, 5915.171875937286, 5917.082852157922, 5901.173835662925, 5935.762569497345, 5996.37038110992, 6001.639901605918, 6015.518758499397, 5745.080787074048, 5814.796482123105, 5832.12518122285, 5868.94131058701, 5904.0, 5802.071668533014, 5805.129230615273, 5810.854728631818, 5812.128180772749, 5836.182934389274, 5608.943910560843, 5702.030654788613, 5813.563982701399, 5835.270591176103, 5858.062709966385, 5725.19847221381, 5793.333766616893, 5799.8550036249435, 5828.679422631796, 5845.970770146122, 5641.633293835887, 5653.519450846724, 5655.0, 5665.801696940587, 5666.093425051972], "value": 5450.040622969469, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.6786965364569, 591.1162811596664, 591.9940800591994, 629.119233073697, 635.5995722694702, 43375.0, 44124.33813492796, 44130.77934610326, 44531.0, 44668.0, 44773.328400074024, 45888.54111458884, 46028.53971460284, 46044.539554604446, 46078.769606151924, 8688.174623410765, 9010.819783604324, 10219.642312519063, 10515.106215971613, 10547.683569492927, 10324.432156231403, 10469.947650261738, 10500.369977801356, 10525.684229473129, 10535.47322633869, 10479.947600261989, 10552.103071238955, 10556.524956376943, 10606.893931060706, 10638.414887181201, 10502.212334074937, 10552.261341706084, 10558.0, 10560.788784224349, 10562.841557376645, 10330.638427654996, 10384.221183411275, 10386.169106471463, 10391.428471434068, 10407.895921040768, 39339.80330098331, 39474.80262598697, 39501.40747888784, 39520.20959580821, 39834.40248396277, 4179.686523510719, 4195.2658284800345, 4249.660027197817, 4264.957350426487, 4331.328644060176, 29485.557716634266, 29902.70097299021, 29913.0, 29988.400231995456, 30075.097747067623, 4102.487189101363, 4102.815373308208, 4172.666186705056, 4323.1785960667685, 4346.8913277168, 319331.0, 319722.0, 320722.0, 321127.0, 323581.0, 54625.45374546283, 54691.179632305546, 54835.17747233795, 55090.35918714209, 55110.173347399825, 58049.70975145097, 58214.417855821746, 58249.70875145597, 58287.46269104428, 58335.0, 14987.850121498863, 16145.919270403572, 16654.916725416537, 16655.0, 16694.749578756328, 11359.886401136047, 11561.595344162914, 11583.826242606368, 11679.591214307628, 11767.058635309155, 17122.229499672543, 17148.742768858476, 17178.828211717973, 17232.310707571556, 17304.567385815455, 6929.826754331182, 6948.409385202213, 7078.610676412847, 7218.963905180441, 7246.96376518114, 970.8106919150698, 977.9145148884733, 978.295627148452, 985.9654912078042, 990.1237404896718, 31140.66445016633, 31173.8441307792, 31316.843415782776, 31406.685933140376, 31542.684573154434, 1131.7566723154562, 1133.880942501042, 1166.2419427372276, 1167.6321958583019, 1257.2330878164312, 16529.752053719203, 16635.0, 16892.15539223034, 16928.49214523566, 16955.660886782443, 327978.0, 331251.0, 332637.0, 334798.0, 335917.0, 58656.120158196805, 59218.703906480194, 59229.0, 59533.0, 59777.70111149504, 1457.5263039512201, 1462.714770619719, 1483.5771805035513, 1503.2183264702294, 1515.0682330366744, 28879.278018049718, 28916.39752422292, 30986.225344366572, 32066.0, 32429.67570324361, 51430.0, 51851.48148518467, 51980.22029669634, 52182.739086304326, 52284.47715522796, 395920.0, 396768.0, 396905.0, 399772.0, 400867.0, 25847.353816154748, 26615.201543953714, 26705.465890681688, 26766.866165669046, 28573.28566785847, 43216.567834322515, 43593.78203109091, 43595.56404435915, 43937.56062439334, 45118.32322515099, 36913.815430922674, 37005.50327005872, 37354.0, 37365.252694946495, 37396.43905341477, 36817.0, 37031.0, 37057.629423706494, 37081.10648381989, 37766.0, 36000.27999439944, 36098.819505902306, 37103.257934840614, 37119.44320835244, 37796.43305350367, 30973.0, 33431.16422089467, 33456.832715836266, 33467.66532334645, 33487.0, 25205.49589008173, 25398.365040874127, 25459.618105728798, 25494.0, 25811.354716131496], "value": 19711.359293353966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.9763775761546, 428.63994244834333, 431.0774941624923, 439.8174757475648, 444.22039320991655, 19172.42482725519, 19449.41651750448, 20754.27360042399, 20875.060622271998, 20880.0, 20887.955602219903, 21206.363809085753, 21287.467813304676, 21602.351929442142, 22740.317790466313, 5775.364709881899, 5983.730732117066, 6005.819825405245, 6041.9697901510435, 6042.667653279068, 5734.225879506255, 5832.737526811304, 5865.32548756892, 5887.381824908387, 5900.114982752579, 5832.241808564881, 5871.207387002764, 5879.118132280149, 5915.9704201478935, 5926.1110833374905, 5656.858578535528, 5847.79532716355, 5878.470937615592, 5888.322842873082, 5891.705414729267, 5133.435322114565, 5241.50205730455, 5291.603129765283, 5297.814576489843, 5319.5744340452675, 24179.87910060456, 24824.131155409654, 24878.751212487823, 25097.49805003908, 25132.12037578676, 3160.1783536280504, 3193.505006723938, 3213.5661685672367, 3216.3567286542784, 3225.2420681139915, 10496.737581560446, 10840.295380800222, 14243.715125697532, 14561.344739486749, 15464.768028479582, 1976.8517361197823, 1993.8703984240979, 1995.2517805822818, 2001.0995052226556, 2007.6787713965696, 98348.0, 99387.0, 102544.48727756388, 102955.48522257416, 103840.0, 11886.524539018515, 12010.099242556844, 12116.515339386502, 12198.451069701885, 12371.876281237252, 16669.583260418345, 16705.749413758804, 16752.41366552165, 16839.32642694303, 16931.661366772594, 8043.959780201179, 8308.958455207685, 8387.62255698495, 8591.0, 8655.754092215418, 7693.961530192425, 7749.612519374009, 7864.4888082274465, 8000.439969202216, 8013.398995075393, 4972.179590367621, 5024.62315326352, 5028.698278103326, 5133.820316288987, 5138.948610513847, 2079.396974877299, 2127.5106725453234, 2145.9678104828126, 2152.257471172474, 2160.1359456217638, 937.9671711490065, 952.3714348529937, 960.1262850805733, 972.6838777397375, 975.770693886936, 18783.812161878206, 19593.608127837364, 20680.58638827215, 21941.561168776854, 21971.450713732283, 1072.099436473366, 1099.4887377369562, 1119.255694962857, 1124.656979621207, 1133.4332833583208, 10550.894491055145, 11191.552337906556, 11315.434228288552, 11326.263792853439, 11530.76938461226, 581168.0, 591506.0, 600952.0, 611765.0, 613190.0, 93123.0, 95800.0, 109458.45270773754, 109487.0, 112630.43684781523, 454.1054123377008, 474.44016061048296, 474.85991632468506, 476.0811633547287, 476.9713817170981, 11012.39431831257, 11166.720831979266, 11905.761884762083, 12021.459034343301, 12065.758684826078, 35785.821070894475, 46160.14581408731, 46511.76744116258, 46568.30147547857, 47089.0, 67057.0, 68053.97919031119, 68742.0, 68760.3123968754, 68762.31237687559, 8576.957115214384, 8829.558522073743, 8960.731178064669, 9105.362624616213, 9244.0, 11972.221805582609, 14032.158070515801, 14192.077514961495, 14266.500672476413, 14300.213488258245, 11666.650000499998, 11862.347570883685, 11947.880521194676, 11983.520659173884, 12167.939160304142, 11634.360110193682, 11891.345975971404, 11916.702082447662, 12148.574799881962, 12281.754364912831, 12188.75622487563, 12254.0, 12297.32364719949, 12440.253584784941, 12591.433385497492, 8682.565871706516, 8698.13018698125, 8824.779380515538, 9016.0, 9345.953270233877, 8790.736277911672, 11890.821637675268, 12232.327222002876, 12427.813582796447, 12494.687632809253], "value": 9573.287426980862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.4358900028983, 1477.4828809916528, 1479.9999999999993, 1492.8507149285074, 1493.5743313155747, 7539.547627142361, 7858.567778772165, 8088.352931765459, 8409.41134120611, 8463.830723385528, 8078.596070196496, 8270.338372930166, 8288.419810613259, 8462.746117616465, 8484.745457636265, 2177.7822217778216, 2221.133757834446, 2222.8332875034357, 2229.4314949687805, 2232.6762619420174, 2256.0411824974403, 2293.9885300573474, 2299.908003679851, 2300.6894069300683, 2301.137073597401, 2221.5001624634488, 2240.0591751464344, 2243.7644047375034, 2254.5152792149684, 2257.0407576779803, 2189.824814014883, 2191.561687662458, 2193.8683678979232, 2210.7789221077924, 2223.1107556977177, 2207.2054060538194, 2216.501287210365, 2219.323106452531, 2230.9626023898963, 2247.9775202247934, 7898.052233731932, 8230.341572674231, 8314.958425207835, 8368.83262334756, 8412.537310447922, 5013.924791128136, 5089.974550127263, 5132.974335128338, 5150.484951504857, 5156.819511317086, 3066.8926587569326, 3159.7788154829173, 3340.5657264555693, 3351.7151042161445, 3353.2622822978906, 1258.653870185697, 1289.748499042687, 1311.511434521815, 1330.527662679754, 1340.229368113329, 10810.837837432446, 10877.456127193609, 10920.235583509157, 10948.069414099731, 11037.392943388111, 4221.303484924953, 4339.218940590724, 4416.933745993812, 4477.171723231213, 4531.750753708578, 9114.726558203265, 9124.863127053099, 9140.177384035469, 9146.405483643543, 9155.404898681565, 5064.696118232918, 5089.160288552347, 5098.133317336062, 5100.974495127501, 5127.64106512548, 4241.066965267636, 4635.142498637762, 4744.4069491313585, 4752.144613969519, 4765.380500534978, 3721.2371463849845, 3783.319002579507, 3870.2453021661067, 3886.378179491268, 3906.7265291429894, 1300.9674758131123, 1328.3955800110925, 1330.414617568267, 1334.652990222549, 1343.825302710661, 953.2755106119399, 966.7534778631403, 977.6431602465049, 980.9754756131011, 990.321629683669, 5202.8959420812125, 5227.163653815447, 5418.91871621926, 5441.5374693151525, 5655.236543066716, 572.8338781753245, 578.3811321885543, 586.9325027621793, 598.3059650805133, 598.9640621562633, 3734.663880250736, 3772.075841418815, 3773.811309434517, 3781.810909454516, 3899.9610003900166, 9404.153626173676, 9413.952930235306, 9792.314537982415, 10047.296689231684, 10063.39619622825, 9868.358556693793, 9963.701088967342, 9965.55155018026, 9975.600975961026, 9979.351342162736, 7565.167831538526, 7676.57778822159, 7686.154523002577, 7688.308052275322, 7754.92245077542, 5359.544438722753, 5386.622936394415, 5515.420880807457, 5711.771529138788, 5724.79963201286, 8589.957050214709, 8594.613242404232, 8688.956555217184, 8717.869231961398, 8730.519821409629, 8753.606087726195, 8753.737387878375, 8795.560221989002, 8856.734297971072, 8891.110888911317, 7112.146542414944, 7207.5675459472595, 7299.817504562428, 7330.450216233698, 7471.701131954661, 8078.919210807817, 8095.23095305945, 8153.918460815553, 8155.673773049249, 8161.061477930114, 7281.781546553612, 7284.198738138906, 7348.265173482609, 7510.511816732113, 7533.209013053551, 7128.964355178191, 7147.428205743632, 7156.713731450684, 7353.191148973501, 7386.298301661333, 6032.0, 6135.6932153393045, 6138.754449821957, 6142.662153581596, 6165.0444181152, 4796.0, 4915.0, 5062.56968157696, 5093.490650934877, 5152.845414637567, 4906.92639610399, 4913.803447862046, 4961.107000739901, 4975.203967365204, 5041.369828771403], "value": 4344.72510153699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.751237963893, 406.68888300450163, 409.66407545812444, 411.2884709452648, 413.9919296512993, 5039.370078740158, 5290.6825590464505, 5452.20942963271, 5473.2063850741615, 5526.917096243555, 5369.087255166622, 5374.6237763356585, 5376.8118115865955, 5383.703896285702, 5391.353037635479, 4239.08859595187, 4240.893977650568, 4241.257779888522, 4251.936220956688, 4256.680748943826, 4025.0, 4212.915741685165, 4243.448351714273, 4249.25638013348, 4252.744835309876, 4222.619964203221, 4247.638950689196, 4249.957500424987, 4253.680973926967, 4258.850940217093, 4240.639545638609, 4241.151769646083, 4243.575642435747, 4258.936115958263, 4272.359146128075, 3782.111203867089, 3783.2244389900006, 3790.6588407043223, 3794.924101517954, 3802.714796390254, 5094.388673359221, 5262.236975638511, 5268.341457317835, 5275.815346462856, 5302.310699609026, 4816.783244753994, 4826.083044221622, 4827.951720482821, 4836.903261934777, 4842.2736589511505, 5489.3412790465, 5676.205331253628, 5702.344230413514, 5710.828675139753, 5719.914201286984, 4095.795210239476, 4103.712740108193, 4115.670746340285, 4115.8971025724295, 4129.97935010326, 5881.735426883198, 5920.467157955804, 5932.3474417814, 5958.676116314641, 5967.4629283364275, 4198.202341555095, 4200.369944508348, 4215.473065866767, 4218.957810421856, 4270.7864606769535, 4522.321651752263, 4526.352084030879, 4527.320901864747, 4527.388802511685, 4529.32060190974, 5019.623528235397, 5026.271190677405, 5031.84904452867, 5050.116229659869, 5102.5252752415045, 5618.6628802272, 5696.9490983246, 5730.656160630376, 5762.049261871828, 5837.241158649348, 1520.6198450387403, 1523.9009464385001, 1527.3279756906925, 1529.5717199184246, 1530.4796369234514, 1074.5755426606447, 1099.4777480696605, 1105.5080489182396, 1106.1372129738816, 1125.442905761637, 5280.419153893069, 5314.395945986439, 5320.707361095099, 5343.370272066979, 5370.221317908881, 5664.603477756517, 5688.829335119953, 5690.9146362804595, 5701.629394089371, 5730.971345143247, 5187.610929180327, 5219.555093638256, 5323.813666521653, 5324.600654950894, 5362.65142765719, 3044.588980487606, 3057.5107982723102, 3058.632964044329, 3061.3571150058738, 3067.92330191747, 5618.747156377973, 5922.555808314308, 5931.258592675916, 5946.84036612865, 5954.642721436728, 5744.569157313218, 5794.739236734357, 5811.215485909433, 5831.650100993954, 5844.736986835603, 5847.035239185572, 5867.530597552186, 5874.971879921082, 5883.3234178069215, 5911.438413350725, 5512.283403157564, 5687.582777319705, 5758.740856661544, 5798.362180160095, 5856.385079566755, 5786.1899334094105, 5809.128630705428, 5809.2738407699035, 5846.1815345852465, 5854.414558544111, 5757.5681823864215, 6058.0, 6103.206583144341, 6105.84735381619, 6107.297660769068, 4090.365993271048, 4092.766714295673, 4184.686148538811, 4249.213895429355, 4252.255855225385, 5844.912326315024, 5889.823305300848, 5897.70511474416, 5903.7048147593305, 5905.40945905406, 5598.664080155204, 5729.054705973635, 5734.043509978102, 5766.693322670965, 5769.59612827098, 5674.205611214516, 5684.772609095755, 5710.314762228559, 5732.57005724564, 5734.455226753452, 5673.851012687997, 5711.914321285267, 5730.541556675539, 5744.511716504144, 5770.307563092456, 5575.637583557056, 5728.195618380197, 5733.254676891977, 5769.0, 5789.942100579109, 5613.073842815889, 5613.550915926798, 5616.157576363578, 5618.69097199658, 5624.803131890364], "value": 4390.795141636089, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.219476134343, 794.6146119132223, 811.1766556944702, 856.3063918226237, 869.439211708448, 13835.100718453306, 14758.33587488563, 14781.039232449883, 14804.55586332409, 14853.554393368217, 14009.579712608638, 14223.928880355585, 14311.856881431182, 14355.856441435582, 14363.066400683949, 633.2464367402775, 646.2116218213772, 710.570105086423, 737.0528870401522, 739.7152096442854, 741.3698356397047, 749.0748925077552, 750.7860259825951, 751.346328694037, 753.8115471132216, 796.4385108498494, 798.2815466080544, 800.1878093734864, 801.623237078575, 804.0632662947688, 795.7374066558021, 796.9123396426388, 797.1510341486298, 798.0, 798.0742338886863, 576.8413686236277, 581.569638467531, 581.6277582347301, 581.764385423904, 584.4856526256909, 14875.107493550313, 15007.324670389859, 15023.248837558078, 15069.171195584238, 15111.244437778067, 14751.0, 15119.092854428769, 15616.141112238822, 15664.216789160497, 15856.60358491047, 12055.913209346627, 12139.0, 12238.632841014694, 12264.693382665415, 12348.320842353667, 3782.867599634, 3850.711196660234, 3897.3569361055393, 4019.839206431739, 4022.2960981828064, 77008.61495692542, 77199.61400192963, 77912.0, 78154.6092269535, 78515.6074219631, 11635.360055196876, 11728.882711172779, 11742.941285293518, 11819.231749936398, 11833.88166118345, 23935.640965385533, 24221.51556968851, 24274.757252427604, 24479.14322998722, 24635.876820615784, 7715.884261736079, 7773.727919522789, 7782.688692452239, 7843.490173138728, 7876.842463150705, 4212.599803018708, 4229.725067870579, 4258.68059895509, 4328.783560821947, 4358.542353052947, 3580.3913334733156, 3678.33789917812, 3678.5953545110015, 3681.889543313705, 3682.3003629310347, 579.2180556249031, 581.4185814185814, 583.3612194646855, 598.9966805600601, 604.1360853978853, 804.4368941740805, 813.5037627047496, 825.1830687619214, 836.4567373196443, 859.6948083430417, 9560.28297877662, 9696.824349980963, 9722.708318750449, 10191.643292484727, 10562.841557376645, 754.4040208235542, 774.7094839435211, 783.2872086401347, 794.9324307433933, 798.6086817459519, 4477.619402350837, 4591.357209990604, 4959.851204463872, 4966.081274964144, 5006.74966251686, 78436.21563784403, 79479.20520794718, 82815.0, 83480.0, 84347.0, 51085.48914510882, 52243.73878130661, 55653.44346556483, 71795.2820471799, 73660.63169684117, 47178.348757793996, 50917.74541127271, 57040.859182816945, 58201.0, 58205.417945820845, 9673.226141908772, 10162.726435370136, 10213.642522511676, 10331.948340258552, 10373.325733827278, 39455.408168878064, 39618.60381396149, 39799.0, 40302.28210997772, 40718.0, 49092.0, 49226.0, 49966.50033499764, 50090.2486462696, 51953.0, 12943.5469758558, 12964.675883102998, 12966.611001669966, 13014.349282536024, 13197.934010329887, 13041.282729449591, 13153.868461315264, 13293.601191964257, 13521.59435216945, 13598.11612245201, 13036.934815325863, 13147.802782958071, 13349.799753003907, 13700.314984250947, 14009.719805603627, 13078.215307081606, 13487.460501580219, 13566.525171618947, 13709.866299900961, 14004.509842155883, 12473.501059957864, 12692.301923394301, 13022.413991370222, 13388.464461421434, 13517.662058448617, 9935.403875767477, 10226.181905447695, 10581.841272380767, 10834.486397165194, 11233.775324493628, 8601.784955376166, 9740.733704618355, 10132.594696212363, 10235.7441063974, 10245.692629221136], "value": 7091.6489673895985, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 111.0, 111.0, 113.0, 111.0, 111.0, 113.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 119.0, 172.0, 120.0, 118.0, 118.0, 117.0, 145.0, 129.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 162.0, 161.0, 162.0, 165.0, 168.0, 163.0, 163.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 80.0, 98.0, 77.0, 74.0, 76.0, 76.0, 94.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 101.0, 83.0, 84.0, 84.0, 99.0, 82.0, 83.0, 98.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 120.0, 119.0, 118.0, 117.0, 118.0, 117.0, 121.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 151.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 59.0, 57.0, 61.0, 57.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 71.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 84.0, 82.0, 80.0, 89.0, 84.0, 81.0, 80.0, 85.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 126.0, 132.0, 126.0, 129.0, 125.0, 128.0, 169.0, 134.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 176.0, 171.0, 172.0, 168.0, 175.0, 168.0, 167.0, 172.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 64.0], "value": 63.6, "unit": "score"}]}]} 12:09:49 INFO - Return code: 0 12:09:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:09:50 ERROR - # TBPL SUCCESS # 12:09:50 INFO - Running post-action listener: _resource_record_post_action 12:09:50 INFO - [mozharness: 2017-01-09 20:09:50.005645Z] Finished run-tests step (success) 12:09:50 INFO - Running post-run listener: _resource_record_post_run 12:09:50 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 10174464; Write bytes: 432242688; Read time: 2536; Write time: 300284 12:09:50 INFO - TinderboxPrint: CPU usage
13.4% 12:09:50 INFO - TinderboxPrint: I/O read bytes / time
10,174,464 / 2,536 12:09:50 INFO - TinderboxPrint: I/O write bytes / time
432,242,688 / 300,284 12:09:50 INFO - TinderboxPrint: CPU idle
8,251.2 (86.5%) 12:09:50 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 12:09:50 INFO - TinderboxPrint: Swap in / out
0 / 0 12:09:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 100261888; Read time: 92; Write time: 70492 12:09:50 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8040448; Write bytes: 331980800; Read time: 2356; Write time: 229792 12:09:50 INFO - Running post-run listener: _upload_blobber_files 12:09:50 INFO - Blob upload gear active. 12:09:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:09:50 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 12:09:50 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'] 12:09:50 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 12:09:51 INFO - (blobuploader) - INFO - Open directory for files ... 12:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:52 INFO - (blobuploader) - INFO - Done attempting. 12:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:52 INFO - (blobuploader) - INFO - Done attempting. 12:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:56 INFO - (blobuploader) - INFO - Done attempting. 12:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:56 INFO - (blobuploader) - INFO - Done attempting. 12:09:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:09:56 INFO - Return code: 0 12:09:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:09:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:09:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d2420f64f66afbd1a2ba2849ad8c201dc759370ee7991d366dda5b1630ae1136266e7cab2b0f56729ce3fa8967cc1f442df09490233539e80d5fa64d5c9f59d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c38701ddcd212e189a89ef652d3ea6a36d64cbb216bd054718891afd9bb36131f9b75fea30dd522b318f04eb5bc613ef4eeb010034c725cf3a89d1440d706e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4378b2fc30609392e13ce0a05cfca1ce3b836b5f3c029549cafa51206a91c00dc28f189932284a5d0bcc4c6513b0a4c1aed26be402416c99b0d9e21137f3dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d454000cf74695dc54ba25186e69f8ff82af73dc9b40d14176696f8d53499dda50b966e97c71053385971afe0434fa047d978252ffa2f543f8966ff81e330a9"} 12:09:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:09:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:09:56 INFO - Contents: 12:09:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d2420f64f66afbd1a2ba2849ad8c201dc759370ee7991d366dda5b1630ae1136266e7cab2b0f56729ce3fa8967cc1f442df09490233539e80d5fa64d5c9f59d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c38701ddcd212e189a89ef652d3ea6a36d64cbb216bd054718891afd9bb36131f9b75fea30dd522b318f04eb5bc613ef4eeb010034c725cf3a89d1440d706e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4378b2fc30609392e13ce0a05cfca1ce3b836b5f3c029549cafa51206a91c00dc28f189932284a5d0bcc4c6513b0a4c1aed26be402416c99b0d9e21137f3dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d454000cf74695dc54ba25186e69f8ff82af73dc9b40d14176696f8d53499dda50b966e97c71053385971afe0434fa047d978252ffa2f543f8966ff81e330a9"} 12:09:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:09:56 INFO - Copying logs to upload dir... 12:09:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:09:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.152740 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-01-09 12:09:57.015921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:57.019443) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d2420f64f66afbd1a2ba2849ad8c201dc759370ee7991d366dda5b1630ae1136266e7cab2b0f56729ce3fa8967cc1f442df09490233539e80d5fa64d5c9f59d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c38701ddcd212e189a89ef652d3ea6a36d64cbb216bd054718891afd9bb36131f9b75fea30dd522b318f04eb5bc613ef4eeb010034c725cf3a89d1440d706e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4378b2fc30609392e13ce0a05cfca1ce3b836b5f3c029549cafa51206a91c00dc28f189932284a5d0bcc4c6513b0a4c1aed26be402416c99b0d9e21137f3dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d454000cf74695dc54ba25186e69f8ff82af73dc9b40d14176696f8d53499dda50b966e97c71053385971afe0434fa047d978252ffa2f543f8966ff81e330a9"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011710 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d2420f64f66afbd1a2ba2849ad8c201dc759370ee7991d366dda5b1630ae1136266e7cab2b0f56729ce3fa8967cc1f442df09490233539e80d5fa64d5c9f59d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c38701ddcd212e189a89ef652d3ea6a36d64cbb216bd054718891afd9bb36131f9b75fea30dd522b318f04eb5bc613ef4eeb010034c725cf3a89d1440d706e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4378b2fc30609392e13ce0a05cfca1ce3b836b5f3c029549cafa51206a91c00dc28f189932284a5d0bcc4c6513b0a4c1aed26be402416c99b0d9e21137f3dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d454000cf74695dc54ba25186e69f8ff82af73dc9b40d14176696f8d53499dda50b966e97c71053385971afe0434fa047d978252ffa2f543f8966ff81e330a9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:57.045083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:57.045412) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1483991352.704602-2146375039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:57.129137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 12:09:57.129467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 12:09:57.129773) ========= ========= Total master_lag: 0.15 =========