builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1483086603.86 results: success (0) buildid: 20161229222507 builduid: 6484d3bea3de4b67a13216858abeea72 revision: 78de5f94bc5fe365c1c540b40094835cc6f9c751 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:03.860201) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:03.860761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:03.861049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:03.881842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:03.882225) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 00:30:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-12-30 00:30:04 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.014208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.014650) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014520 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.064487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.065017) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 78de5f94bc5fe365c1c540b40094835cc6f9c751 --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 78de5f94bc5fe365c1c540b40094835cc6f9c751 --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=14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 00:30:04,267 truncating revision to first 12 chars 2016-12-30 00:30:04,267 Setting DEBUG logging. 2016-12-30 00:30:04,267 attempt 1/10 2016-12-30 00:30:04,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/78de5f94bc5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 00:30:04,587 unpacking tar archive at: mozilla-inbound-78de5f94bc5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.713924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.714422) ========= script_repo_revision: 78de5f94bc5fe365c1c540b40094835cc6f9c751 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.714932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.715258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 00:30:04.725818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-30 00:30:04.726232) ========= /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=14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:30:05 INFO - MultiFileLogger online at 20161230 00:30:05 in /builds/slave/test 00:30:05 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 00:30:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:30:05 INFO - {'append_to_log': False, 00:30:05 INFO - 'base_work_dir': '/builds/slave/test', 00:30:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:30:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:30:05 INFO - 'branch': 'Mozilla-Inbound', 00:30:05 INFO - 'buildbot_json_path': 'buildprops.json', 00:30:05 INFO - 'config_files': ('talos/linux_config.py',), 00:30:05 INFO - 'default_actions': ('clobber', 00:30:05 INFO - 'read-buildbot-config', 00:30:05 INFO - 'download-and-extract', 00:30:05 INFO - 'populate-webroot', 00:30:05 INFO - 'create-virtualenv', 00:30:05 INFO - 'install', 00:30:05 INFO - 'run-tests'), 00:30:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:30:05 INFO - 'download_minidump_stackwalk': True, 00:30:05 INFO - 'download_symbols': 'ondemand', 00:30:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:30:05 INFO - 'tooltool.py': '/tools/tooltool.py', 00:30:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:30:05 INFO - '/tools/misc-python/virtualenv.py')}, 00:30:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:30:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:30:05 INFO - 'installer_path': 'installer.exe', 00:30:05 INFO - 'log_level': 'info', 00:30:05 INFO - 'log_name': 'talos', 00:30:05 INFO - 'log_to_console': True, 00:30:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:30:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:30:05 INFO - 'opt_config_files': (), 00:30:05 INFO - 'pip_index': False, 00:30:05 INFO - 'sps_profile': False, 00:30:05 INFO - 'sps_profile_interval': 0, 00:30:05 INFO - 'suite': 'dromaeojs-e10s', 00:30:05 INFO - 'system_bits': '32', 00:30:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:30:05 INFO - 'title': 'talos-linux64-ix-036', 00:30:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:30:05 INFO - 'use_talos_json': True, 00:30:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:30:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:30:05 INFO - 'work_dir': 'build'} 00:30:05 INFO - [mozharness: 2016-12-30 08:30:05.028281Z] Running clobber step. 00:30:05 INFO - Running pre-action listener: _resource_record_pre_action 00:30:05 INFO - Running main action method: clobber 00:30:05 INFO - rmtree: /builds/slave/test/build 00:30:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:30:05 INFO - Running post-action listener: _resource_record_post_action 00:30:05 INFO - [mozharness: 2016-12-30 08:30:05.489621Z] Finished clobber step (success) 00:30:05 INFO - [mozharness: 2016-12-30 08:30:05.489721Z] Running read-buildbot-config step. 00:30:05 INFO - Running pre-action listener: _resource_record_pre_action 00:30:05 INFO - Running main action method: read_buildbot_config 00:30:05 INFO - Using buildbot properties: 00:30:05 INFO - { 00:30:05 INFO - "project": "", 00:30:05 INFO - "product": "firefox", 00:30:05 INFO - "script_repo_revision": "production", 00:30:05 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 00:30:05 INFO - "repository": "", 00:30:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 00:30:05 INFO - "buildid": "20161229222507", 00:30:05 INFO - "stage_platform": "linux64-pgo", 00:30:05 INFO - "basedir": "/builds/slave/test", 00:30:05 INFO - "buildnumber": 1861, 00:30:05 INFO - "platform": "ubuntu64_hw", 00:30:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:30:05 INFO - "slavebuilddir": "test", 00:30:05 INFO - "branch": "mozilla-inbound", 00:30:05 INFO - "revision": "78de5f94bc5fe365c1c540b40094835cc6f9c751", 00:30:05 INFO - "slavename": "talos-linux64-ix-036", 00:30:05 INFO - "builduid": "6484d3bea3de4b67a13216858abeea72", 00:30:05 INFO - "repo_path": "integration/mozilla-inbound" 00:30:05 INFO - } 00:30:05 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 00:30:05 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 00:30:05 INFO - Running post-action listener: _resource_record_post_action 00:30:05 INFO - [mozharness: 2016-12-30 08:30:05.492075Z] Finished read-buildbot-config step (success) 00:30:05 INFO - [mozharness: 2016-12-30 08:30:05.492165Z] Running download-and-extract step. 00:30:05 INFO - Running pre-action listener: _resource_record_pre_action 00:30:05 INFO - Running main action method: download_and_extract 00:30:05 INFO - mkdir: /builds/slave/test/build/tests 00:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:05 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:30:05 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/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 00:30:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/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 00:30:05 INFO - Downloaded 1361 bytes. 00:30:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:30:05 INFO - Using the following test package requirements: 00:30:05 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:30:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:30:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:30:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'jsshell-linux-x86_64.zip'], 00:30:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:30:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:30:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:30:05 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:30:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:30:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:30:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:30:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:30:05 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/1483065355/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:30:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:30:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:30:05 INFO - Expected file size: 21836658 00:30:05 INFO - Obtained file size: 21836658 00:30:09 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 00:30:09 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/1483065355/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:30:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:30:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:30:10 INFO - Expected file size: 21836658 00:30:10 INFO - Obtained file size: 21836658 00:30:14 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/1483065355/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 00:30:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:30:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:30:14 INFO - Expected file size: 14409776 00:30:14 INFO - Obtained file size: 14409776 00:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:30:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/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 00:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/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 00:30:15 INFO - Downloaded 61386553 bytes. 00:30:15 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:30:15 INFO - mkdir: /builds/slave/test/properties 00:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 00:30:15 INFO - Contents: 00:30:15 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:30:15 INFO - Running post-action listener: _resource_record_post_action 00:30:15 INFO - Running post-action listener: set_extra_try_arguments 00:30:15 INFO - [mozharness: 2016-12-30 08:30:15.973706Z] Finished download-and-extract step (success) 00:30:15 INFO - [mozharness: 2016-12-30 08:30:15.973934Z] Running populate-webroot step. 00:30:15 INFO - Running pre-action listener: _resource_record_pre_action 00:30:15 INFO - Running main action method: populate_webroot 00:30:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:30:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:30:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:30:15 INFO - '--tppagecycles', 00:30:15 INFO - '7'], 00:30:15 INFO - 'tests': ['tsvgm']}}, 00:30:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:30:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:30:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:30:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:30:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:30:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:30:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['damp', 'tps']}, 00:30:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'tests': ['damp', 'tps']}, 00:30:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['dromaeo_dom']}, 00:30:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:30:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['basic_compositor_video']}, 00:30:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:30:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['a11yr', 00:30:15 INFO - 'ts_paint', 00:30:15 INFO - 'tpaint', 00:30:15 INFO - 'sessionrestore', 00:30:15 INFO - 'sessionrestore_no_auto_restore', 00:30:15 INFO - 'tabpaint']}, 00:30:15 INFO - 'other-e10s': {'tests': ['a11yr', 00:30:15 INFO - 'ts_paint', 00:30:15 INFO - 'tpaint', 00:30:15 INFO - 'sessionrestore', 00:30:15 INFO - 'sessionrestore_no_auto_restore', 00:30:15 INFO - 'tabpaint']}, 00:30:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:30:15 INFO - 'ts_paint', 00:30:15 INFO - 'tpaint', 00:30:15 INFO - 'sessionrestore', 00:30:15 INFO - 'sessionrestore_no_auto_restore', 00:30:15 INFO - 'tabpaint']}, 00:30:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:30:15 INFO - 'ts_paint', 00:30:15 INFO - 'tpaint', 00:30:15 INFO - 'sessionrestore', 00:30:15 INFO - 'sessionrestore_no_auto_restore', 00:30:15 INFO - 'tabpaint']}, 00:30:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['a11yr', 00:30:15 INFO - 'ts_paint', 00:30:15 INFO - 'tpaint', 00:30:15 INFO - 'sessionrestore', 00:30:15 INFO - 'sessionrestore_no_auto_restore', 00:30:15 INFO - 'tabpaint']}, 00:30:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['a11yr', 00:30:15 INFO - 'ts_paint', 00:30:15 INFO - 'tpaint', 00:30:15 INFO - 'sessionrestore', 00:30:15 INFO - 'sessionrestore_no_auto_restore', 00:30:15 INFO - 'tabpaint']}, 00:30:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['tsvgx', 00:30:15 INFO - 'tsvgr_opacity', 00:30:15 INFO - 'tart', 00:30:15 INFO - 'tscrollx', 00:30:15 INFO - 'cart', 00:30:15 INFO - 'tsvg_static']}, 00:30:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:30:15 INFO - 'tsvgr_opacity', 00:30:15 INFO - 'tart', 00:30:15 INFO - 'tscrollx', 00:30:15 INFO - 'cart', 00:30:15 INFO - 'tsvg_static']}, 00:30:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'talos_options': ['--disable-e10s'], 00:30:15 INFO - 'tests': ['tp5o']}, 00:30:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:30:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'talos_options': ['--disable-e10s', 00:30:15 INFO - '--xperf_path', 00:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:30:15 INFO - 'tests': ['tp5n']}, 00:30:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:30:15 INFO - 'talos_options': ['--xperf_path', 00:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:30:15 INFO - 'tests': ['tp5n']}}, 00:30:15 INFO - 'talos.zip': {'path': '', 00:30:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:30:15 INFO - Running post-action listener: _resource_record_post_action 00:30:15 INFO - [mozharness: 2016-12-30 08:30:15.992028Z] Finished populate-webroot step (success) 00:30:15 INFO - [mozharness: 2016-12-30 08:30:15.992116Z] Running create-virtualenv step. 00:30:15 INFO - Running pre-action listener: _resource_record_pre_action 00:30:15 INFO - Running main action method: create_virtualenv 00:30:15 INFO - Creating virtualenv /builds/slave/test/build/venv 00:30:15 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 00:30:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:30:16 INFO - Using real prefix '/usr' 00:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 00:30:18 INFO - Installing pip.................done. 00:30:18 INFO - Return code: 0 00:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:30:18 INFO - Reading from file tmpfile_stdout 00:30:18 INFO - Output received: 00:30:18 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) 00:30:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:30:18 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')]} 00:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:18 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')]} 00:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:18 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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:18 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 00:30:18 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 00:30:18 INFO - Using env: {'DISPLAY': ':0', 00:30:18 INFO - 'HOME': '/home/cltbld', 00:30:18 INFO - 'LANG': 'en_US.UTF-8', 00:30:18 INFO - 'LANGUAGE': 'en_US:en', 00:30:18 INFO - 'LOGNAME': 'cltbld', 00:30:18 INFO - 'MAIL': '/var/mail/cltbld', 00:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:18 INFO - 'MOZ_NO_REMOTE': '1', 00:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:18 INFO - 'NO_EM_RESTART': '1', 00:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:18 INFO - 'PWD': '/builds/slave/test', 00:30:18 INFO - 'SHELL': '/bin/bash', 00:30:18 INFO - 'SHLVL': '1', 00:30:18 INFO - 'TERM': 'linux', 00:30:18 INFO - 'TMOUT': '86400', 00:30:18 INFO - 'USER': 'cltbld', 00:30:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:18 INFO - '_': '/tools/buildbot/bin/python'} 00:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:19 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 00:30:19 INFO - Cleaning up... 00:30:19 INFO - Return code: 0 00:30:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:30: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')]} 00:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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')]} 00:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:30:19 INFO - Using env: {'DISPLAY': ':0', 00:30:19 INFO - 'HOME': '/home/cltbld', 00:30:19 INFO - 'LANG': 'en_US.UTF-8', 00:30:19 INFO - 'LANGUAGE': 'en_US:en', 00:30:19 INFO - 'LOGNAME': 'cltbld', 00:30:19 INFO - 'MAIL': '/var/mail/cltbld', 00:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:19 INFO - 'MOZ_NO_REMOTE': '1', 00:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:19 INFO - 'NO_EM_RESTART': '1', 00:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:19 INFO - 'PWD': '/builds/slave/test', 00:30:19 INFO - 'SHELL': '/bin/bash', 00:30:19 INFO - 'SHLVL': '1', 00:30:19 INFO - 'TERM': 'linux', 00:30:19 INFO - 'TMOUT': '86400', 00:30:19 INFO - 'USER': 'cltbld', 00:30:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:19 INFO - '_': '/tools/buildbot/bin/python'} 00:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:19 INFO - Downloading/unpacking psutil>=3.1.1 00:30:19 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 00:30:19 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 00:30:19 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 00:30:19 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 00:30:19 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 00:30:19 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 00:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:30:21 INFO - Installing collected packages: psutil 00:30:21 INFO - Running setup.py install for psutil 00:30:21 INFO - building 'psutil._psutil_linux' extension 00:30:21 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 00:30:21 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 00:30:21 INFO - building 'psutil._psutil_posix' extension 00:30:21 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 00:30:21 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 00:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:30:21 INFO - Successfully installed psutil 00:30:21 INFO - Cleaning up... 00:30:21 INFO - Return code: 0 00:30:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:30:21 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')]} 00:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:21 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')]} 00:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:21 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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:21 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 00:30:21 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 00:30:21 INFO - Using env: {'DISPLAY': ':0', 00:30:21 INFO - 'HOME': '/home/cltbld', 00:30:21 INFO - 'LANG': 'en_US.UTF-8', 00:30:21 INFO - 'LANGUAGE': 'en_US:en', 00:30:21 INFO - 'LOGNAME': 'cltbld', 00:30:21 INFO - 'MAIL': '/var/mail/cltbld', 00:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:21 INFO - 'MOZ_NO_REMOTE': '1', 00:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:21 INFO - 'NO_EM_RESTART': '1', 00:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:21 INFO - 'PWD': '/builds/slave/test', 00:30:21 INFO - 'SHELL': '/bin/bash', 00:30:21 INFO - 'SHLVL': '1', 00:30:21 INFO - 'TERM': 'linux', 00:30:21 INFO - 'TMOUT': '86400', 00:30:21 INFO - 'USER': 'cltbld', 00:30:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:21 INFO - '_': '/tools/buildbot/bin/python'} 00:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:30:22 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 00:30:22 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 00:30:22 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 00:30:22 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 00:30:22 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 00:30:22 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 00:30:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:30:24 INFO - Installing collected packages: mozsystemmonitor 00:30:24 INFO - Running setup.py install for mozsystemmonitor 00:30:24 INFO - Successfully installed mozsystemmonitor 00:30:24 INFO - Cleaning up... 00:30:24 INFO - Return code: 0 00:30:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:30:24 INFO - Using env: {'DISPLAY': ':0', 00:30:24 INFO - 'HOME': '/home/cltbld', 00:30:24 INFO - 'LANG': 'en_US.UTF-8', 00:30:24 INFO - 'LANGUAGE': 'en_US:en', 00:30:24 INFO - 'LOGNAME': 'cltbld', 00:30:24 INFO - 'MAIL': '/var/mail/cltbld', 00:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:24 INFO - 'MOZ_NO_REMOTE': '1', 00:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:24 INFO - 'NO_EM_RESTART': '1', 00:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:24 INFO - 'PWD': '/builds/slave/test', 00:30:24 INFO - 'SHELL': '/bin/bash', 00:30:24 INFO - 'SHLVL': '1', 00:30:24 INFO - 'TERM': 'linux', 00:30:24 INFO - 'TMOUT': '86400', 00:30:24 INFO - 'USER': 'cltbld', 00:30:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:24 INFO - '_': '/tools/buildbot/bin/python'} 00:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:24 INFO - Downloading/unpacking jsonschema==2.5.1 00:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:30:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:30:26 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 00:30:26 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 00:30:26 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 00:30:26 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 00:30:26 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 00:30:26 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 00:30:26 INFO - Downloading functools32-3.2.3-2.tar.gz 00:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:30:26 INFO - warning: no files found matching '*.txt' 00:30:26 INFO - no previously-included directories found matching 'build' 00:30:26 INFO - no previously-included directories found matching 'dist' 00:30:26 INFO - no previously-included directories found matching '.git*' 00:30:26 INFO - Installing collected packages: jsonschema, functools32 00:30:26 INFO - Running setup.py install for functools32 00:30:26 INFO - warning: no files found matching '*.txt' 00:30:26 INFO - no previously-included directories found matching 'build' 00:30:26 INFO - no previously-included directories found matching 'dist' 00:30:26 INFO - no previously-included directories found matching '.git*' 00:30:26 INFO - Successfully installed jsonschema functools32 00:30:26 INFO - Cleaning up... 00:30:27 INFO - Return code: 0 00:30:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:30:27 INFO - Using env: {'DISPLAY': ':0', 00:30:27 INFO - 'HOME': '/home/cltbld', 00:30:27 INFO - 'LANG': 'en_US.UTF-8', 00:30:27 INFO - 'LANGUAGE': 'en_US:en', 00:30:27 INFO - 'LOGNAME': 'cltbld', 00:30:27 INFO - 'MAIL': '/var/mail/cltbld', 00:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:27 INFO - 'MOZ_NO_REMOTE': '1', 00:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:27 INFO - 'NO_EM_RESTART': '1', 00:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:27 INFO - 'PWD': '/builds/slave/test', 00:30:27 INFO - 'SHELL': '/bin/bash', 00:30:27 INFO - 'SHLVL': '1', 00:30:27 INFO - 'TERM': 'linux', 00:30:27 INFO - 'TMOUT': '86400', 00:30:27 INFO - 'USER': 'cltbld', 00:30:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:27 INFO - '_': '/tools/buildbot/bin/python'} 00:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:30:27 INFO - Cleaning up... 00:30:27 INFO - Return code: 0 00:30:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:30:27 INFO - Using env: {'DISPLAY': ':0', 00:30:27 INFO - 'HOME': '/home/cltbld', 00:30:27 INFO - 'LANG': 'en_US.UTF-8', 00:30:27 INFO - 'LANGUAGE': 'en_US:en', 00:30:27 INFO - 'LOGNAME': 'cltbld', 00:30:27 INFO - 'MAIL': '/var/mail/cltbld', 00:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:27 INFO - 'MOZ_NO_REMOTE': '1', 00:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:27 INFO - 'NO_EM_RESTART': '1', 00:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:27 INFO - 'PWD': '/builds/slave/test', 00:30:27 INFO - 'SHELL': '/bin/bash', 00:30:27 INFO - 'SHLVL': '1', 00:30:27 INFO - 'TERM': 'linux', 00:30:27 INFO - 'TMOUT': '86400', 00:30:27 INFO - 'USER': 'cltbld', 00:30:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:27 INFO - '_': '/tools/buildbot/bin/python'} 00:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:27 INFO - Downloading/unpacking blobuploader==1.2.4 00:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:30:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:30:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:30 INFO - Downloading docopt-0.6.1.tar.gz 00:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:30:30 INFO - Installing collected packages: blobuploader, requests, docopt 00:30:30 INFO - Running setup.py install for blobuploader 00:30:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:30:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:30:30 INFO - Running setup.py install for requests 00:30:30 INFO - Running setup.py install for docopt 00:30:30 INFO - Successfully installed blobuploader requests docopt 00:30:30 INFO - Cleaning up... 00:30:30 INFO - Return code: 0 00:30:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:30 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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:30 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 00:30:30 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 00:30:30 INFO - Using env: {'DISPLAY': ':0', 00:30:30 INFO - 'HOME': '/home/cltbld', 00:30:30 INFO - 'LANG': 'en_US.UTF-8', 00:30:30 INFO - 'LANGUAGE': 'en_US:en', 00:30:30 INFO - 'LOGNAME': 'cltbld', 00:30:30 INFO - 'MAIL': '/var/mail/cltbld', 00:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:30 INFO - 'MOZ_NO_REMOTE': '1', 00:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:30 INFO - 'NO_EM_RESTART': '1', 00:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:30 INFO - 'PWD': '/builds/slave/test', 00:30:30 INFO - 'SHELL': '/bin/bash', 00:30:30 INFO - 'SHLVL': '1', 00:30:30 INFO - 'TERM': 'linux', 00:30:30 INFO - 'TMOUT': '86400', 00:30:30 INFO - 'USER': 'cltbld', 00:30:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:30 INFO - '_': '/tools/buildbot/bin/python'} 00:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:30:31 INFO - Running setup.py (path:/tmp/pip-hoVjlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:30:31 INFO - Running setup.py (path:/tmp/pip-B258xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:30:31 INFO - Running setup.py (path:/tmp/pip-bLg8_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:30:31 INFO - Running setup.py (path:/tmp/pip-9KmGIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:30:31 INFO - Running setup.py (path:/tmp/pip-sXZXTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:30:31 INFO - Running setup.py (path:/tmp/pip-9gTrp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:30:31 INFO - Running setup.py (path:/tmp/pip-t9w6gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:30:31 INFO - Running setup.py (path:/tmp/pip-Q3fLc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:30:31 INFO - Running setup.py (path:/tmp/pip-oR1nZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:30:31 INFO - Running setup.py (path:/tmp/pip-FJr3_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:30:31 INFO - Running setup.py (path:/tmp/pip-3J9UxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:30:31 INFO - Running setup.py (path:/tmp/pip-4RUkN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:30:31 INFO - Running setup.py (path:/tmp/pip-fT65uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:30:32 INFO - Running setup.py (path:/tmp/pip-rdwrfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:32 INFO - Running setup.py (path:/tmp/pip-txCj98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:30:32 INFO - Running setup.py (path:/tmp/pip-bBfEbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:30:32 INFO - Running setup.py (path:/tmp/pip-kUFU4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:30:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:30:32 INFO - Running setup.py install for manifestparser 00:30:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:30:32 INFO - Running setup.py install for mozcrash 00:30:32 INFO - Running setup.py install for mozdebug 00:30:32 INFO - Running setup.py install for mozdevice 00:30:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:30:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:30:32 INFO - Running setup.py install for mozfile 00:30:32 INFO - Running setup.py install for mozhttpd 00:30:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:30:32 INFO - Running setup.py install for mozinfo 00:30:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Running setup.py install for mozInstall 00:30:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Running setup.py install for mozleak 00:30:33 INFO - Running setup.py install for mozlog 00:30:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Running setup.py install for moznetwork 00:30:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Running setup.py install for mozprocess 00:30:33 INFO - Running setup.py install for mozprofile 00:30:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Running setup.py install for mozrunner 00:30:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:30:33 INFO - Running setup.py install for mozscreenshot 00:30:33 INFO - Running setup.py install for moztest 00:30:34 INFO - Running setup.py install for mozversion 00:30:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:30:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:30:34 INFO - Cleaning up... 00:30:34 INFO - Return code: 0 00:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:30: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')]} 00:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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')]} 00:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:34 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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:34 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 00:30:34 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 00:30:34 INFO - Using env: {'DISPLAY': ':0', 00:30:34 INFO - 'HOME': '/home/cltbld', 00:30:34 INFO - 'LANG': 'en_US.UTF-8', 00:30:34 INFO - 'LANGUAGE': 'en_US:en', 00:30:34 INFO - 'LOGNAME': 'cltbld', 00:30:34 INFO - 'MAIL': '/var/mail/cltbld', 00:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:34 INFO - 'MOZ_NO_REMOTE': '1', 00:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:34 INFO - 'NO_EM_RESTART': '1', 00:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:34 INFO - 'PWD': '/builds/slave/test', 00:30:34 INFO - 'SHELL': '/bin/bash', 00:30:34 INFO - 'SHLVL': '1', 00:30:34 INFO - 'TERM': 'linux', 00:30:34 INFO - 'TMOUT': '86400', 00:30:34 INFO - 'USER': 'cltbld', 00:30:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:34 INFO - '_': '/tools/buildbot/bin/python'} 00:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:30:34 INFO - Running setup.py (path:/tmp/pip-ftMVe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:30:34 INFO - Running setup.py (path:/tmp/pip-4XxUVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:30:34 INFO - Running setup.py (path:/tmp/pip-ZDJd2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:30:34 INFO - Running setup.py (path:/tmp/pip-22anhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:30:34 INFO - Running setup.py (path:/tmp/pip-NnupJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:30:34 INFO - Running setup.py (path:/tmp/pip-yZ_79Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:30:34 INFO - Running setup.py (path:/tmp/pip-PDoGl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:30:34 INFO - Running setup.py (path:/tmp/pip-xO5Za_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:30:34 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)) 00:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:30:34 INFO - Running setup.py (path:/tmp/pip-eS_zN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:30:35 INFO - Running setup.py (path:/tmp/pip-HWzIDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:30:35 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)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:30:35 INFO - Running setup.py (path:/tmp/pip-hOfyNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:30:35 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)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:30:35 INFO - Running setup.py (path:/tmp/pip-JW3j_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:30:35 INFO - Running setup.py (path:/tmp/pip-rkyDLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:30:35 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)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:30:35 INFO - Running setup.py (path:/tmp/pip-ozlNf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:30:35 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)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:35 INFO - Running setup.py (path:/tmp/pip-nroJ_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:35 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)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:30:35 INFO - Running setup.py (path:/tmp/pip-PFI7AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:30:35 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)) 00:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:30:35 INFO - Running setup.py (path:/tmp/pip-zysQsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:30:35 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)) 00:30:35 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)) 00:30:35 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)) 00:30:35 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)) 00:30:35 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)) 00:30:35 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)) 00:30:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:37 INFO - Downloading blessings-1.6.tar.gz 00:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:30:37 INFO - Installing collected packages: blessings 00:30:37 INFO - Running setup.py install for blessings 00:30:37 INFO - Successfully installed blessings 00:30:37 INFO - Cleaning up... 00:30:37 INFO - Return code: 0 00:30:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:30:38 INFO - Reading from file tmpfile_stdout 00:30:38 INFO - Current package versions: 00:30:38 INFO - argparse == 1.2.1 00:30:38 INFO - blessings == 1.6 00:30:38 INFO - blobuploader == 1.2.4 00:30:38 INFO - docopt == 0.6.1 00:30:38 INFO - functools32 == 3.2.3-2 00:30:38 INFO - jsonschema == 2.5.1 00:30:38 INFO - manifestparser == 1.1 00:30:38 INFO - mozInstall == 1.12 00:30:38 INFO - mozcrash == 1.0 00:30:38 INFO - mozdebug == 0.1 00:30:38 INFO - mozdevice == 0.49 00:30:38 INFO - mozfile == 1.2 00:30:38 INFO - mozhttpd == 0.7 00:30:38 INFO - mozinfo == 0.9 00:30:38 INFO - mozleak == 0.1 00:30:38 INFO - mozlog == 3.4 00:30:38 INFO - moznetwork == 0.27 00:30:38 INFO - mozprocess == 0.23 00:30:38 INFO - mozprofile == 0.28 00:30:38 INFO - mozrunner == 6.13 00:30:38 INFO - mozscreenshot == 0.1 00:30:38 INFO - mozsystemmonitor == 0.3 00:30:38 INFO - moztest == 0.8 00:30:38 INFO - mozversion == 1.4 00:30:38 INFO - psutil == 3.1.1 00:30:38 INFO - requests == 1.2.3 00:30:38 INFO - wsgiref == 0.1.2 00:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:30:38 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')]} 00:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:38 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')]} 00:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:38 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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:38 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 00:30:38 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 00:30:38 INFO - Using env: {'DISPLAY': ':0', 00:30:38 INFO - 'HOME': '/home/cltbld', 00:30:38 INFO - 'LANG': 'en_US.UTF-8', 00:30:38 INFO - 'LANGUAGE': 'en_US:en', 00:30:38 INFO - 'LOGNAME': 'cltbld', 00:30:38 INFO - 'MAIL': '/var/mail/cltbld', 00:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:38 INFO - 'MOZ_NO_REMOTE': '1', 00:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:38 INFO - 'NO_EM_RESTART': '1', 00:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:38 INFO - 'PWD': '/builds/slave/test', 00:30:38 INFO - 'SHELL': '/bin/bash', 00:30:38 INFO - 'SHLVL': '1', 00:30:38 INFO - 'TERM': 'linux', 00:30:38 INFO - 'TMOUT': '86400', 00:30:38 INFO - 'USER': 'cltbld', 00:30:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:38 INFO - '_': '/tools/buildbot/bin/python'} 00:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 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)) 00:30:38 INFO - Cleaning up... 00:30:38 INFO - Return code: 0 00:30:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:30:38 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')]} 00:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:38 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')]} 00:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:38 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 0x23ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', '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 00:30:38 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 00:30:38 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 00:30:38 INFO - Using env: {'DISPLAY': ':0', 00:30:38 INFO - 'HOME': '/home/cltbld', 00:30:38 INFO - 'LANG': 'en_US.UTF-8', 00:30:38 INFO - 'LANGUAGE': 'en_US:en', 00:30:38 INFO - 'LOGNAME': 'cltbld', 00:30:38 INFO - 'MAIL': '/var/mail/cltbld', 00:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:38 INFO - 'MOZ_NO_REMOTE': '1', 00:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:38 INFO - 'NO_EM_RESTART': '1', 00:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:38 INFO - 'PWD': '/builds/slave/test', 00:30:38 INFO - 'SHELL': '/bin/bash', 00:30:38 INFO - 'SHLVL': '1', 00:30:38 INFO - 'TERM': 'linux', 00:30:38 INFO - 'TMOUT': '86400', 00:30:38 INFO - 'USER': 'cltbld', 00:30:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:38 INFO - '_': '/tools/buildbot/bin/python'} 00:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:30:38 INFO - Cleaning up... 00:30:38 INFO - Return code: 0 00:30:38 INFO - Running post-action listener: _resource_record_post_action 00:30:38 INFO - Running post-action listener: _start_resource_monitoring 00:30:38 INFO - Starting resource monitoring. 00:30:38 INFO - [mozharness: 2016-12-30 08:30:38.605842Z] Finished create-virtualenv step (success) 00:30:38 INFO - [mozharness: 2016-12-30 08:30:38.606368Z] Running install step. 00:30:38 INFO - Running pre-action listener: _resource_record_pre_action 00:30:38 INFO - Running main action method: install 00:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:30:38 INFO - Reading from file tmpfile_stdout 00:30:38 INFO - Detecting whether we're running mozinstall >=1.0... 00:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:30:38 INFO - Reading from file tmpfile_stdout 00:30:38 INFO - Output received: 00:30:38 INFO - Usage: mozinstall [options] installer 00:30:38 INFO - Options: 00:30:38 INFO - -h, --help show this help message and exit 00:30:38 INFO - -d DEST, --destination=DEST 00:30:38 INFO - Directory to install application into. [default: 00:30:38 INFO - "/builds/slave/test"] 00:30:38 INFO - --app=APP Application being installed. [default: firefox] 00:30:38 INFO - mkdir: /builds/slave/test/build/application 00:30:38 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'] 00:30:38 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 00:30:56 INFO - Reading from file tmpfile_stdout 00:30:56 INFO - Output received: 00:30:56 INFO - /builds/slave/test/build/application/firefox/firefox 00:30:56 INFO - Running post-action listener: _resource_record_post_action 00:30:56 INFO - [mozharness: 2016-12-30 08:30:56.220362Z] Finished install step (success) 00:30:56 INFO - [mozharness: 2016-12-30 08:30:56.220638Z] Running run-tests step. 00:30:56 INFO - Running pre-action listener: _resource_record_pre_action 00:30:56 INFO - Running main action method: run_tests 00:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:30:56 INFO - Python 2.7.3 00:30:56 INFO - Return code: 0 00:30:56 INFO - grabbing minidump binary from tooltool 00:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273d820>, '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 0x273e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:30:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:30:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:30:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:30:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:30:56 INFO - Return code: 0 00:30:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:30:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:30:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:30:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:30:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 00:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 00:30:56 INFO - Using env: {'DISPLAY': ':0', 00:30:56 INFO - 'HOME': '/home/cltbld', 00:30:56 INFO - 'LANG': 'en_US.UTF-8', 00:30:56 INFO - 'LANGUAGE': 'en_US:en', 00:30:56 INFO - 'LOGNAME': 'cltbld', 00:30:56 INFO - 'MAIL': '/var/mail/cltbld', 00:30:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:30:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:56 INFO - 'MOZ_NO_REMOTE': '1', 00:30:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:56 INFO - 'NO_EM_RESTART': '1', 00:30:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:56 INFO - 'PWD': '/builds/slave/test', 00:30:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:30:56 INFO - 'SHELL': '/bin/bash', 00:30:56 INFO - 'SHLVL': '1', 00:30:56 INFO - 'TERM': 'linux', 00:30:56 INFO - 'TMOUT': '86400', 00:30:56 INFO - 'USER': 'cltbld', 00:30:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650', 00:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:56 INFO - '_': '/tools/buildbot/bin/python'} 00:30:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 00:30:56 INFO - mozversion application_buildid: 20161229183555 00:30:56 INFO - mozversion application_changeset: 78de5f94bc5fe365c1c540b40094835cc6f9c751 00:30:56 INFO - mozversion application_display_name: Nightly 00:30:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:30:56 INFO - mozversion application_name: Firefox 00:30:56 INFO - mozversion application_remotingname: firefox 00:30:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:30:56 INFO - mozversion application_vendor: Mozilla 00:30:56 INFO - mozversion application_version: 53.0a1 00:30:56 INFO - mozversion platform_buildid: 20161229183555 00:30:56 INFO - mozversion platform_changeset: 78de5f94bc5fe365c1c540b40094835cc6f9c751 00:30:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:30:56 INFO - mozversion platform_version: 53.0a1 00:30:56 INFO - using testdate: 1483086656 00:30:56 INFO - actual date: 1483086656 00:30:56 INFO - starting webserver on 'localhost:39511' 00:30:56 INFO - SUITE-START | Running 2 tests 00:30:56 INFO - TEST-START | dromaeo_css 00:30:56 INFO - operating with platform_type : linux_ 00:30:56 INFO - Initialising browser for dromaeo_css test... 00:30:56 INFO - TEST-INFO | started process 12019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvjcNFA/profile http://localhost:39511/getInfo.html) 00:30:56 INFO - PROCESS | 12019 | 1483086656966 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:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 00:31:00 INFO - PROCESS | 12019 | __metrics Screen width/height:1600/1200 00:31:00 INFO - PROCESS | 12019 | colorDepth:24 00:31:00 INFO - PROCESS | 12019 | Browser inner width/height: 1024/697 00:31:00 INFO - PROCESS | 12019 | __metrics 00:31:01 ERROR - PROCESS | 12019 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 00:31:02 INFO - TEST-INFO | 12019: exit 0 00:31:02 INFO - Browser initialized. 00:31:02 INFO - Running cycle 1/1 for dromaeo_css test... 00:31:02 INFO - TEST-INFO | started process 12141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvjcNFA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:31:14 INFO - PROCESS | 12141 | RSS: Main: 154796032 00:31:14 INFO - PROCESS | 12141 | 00:34:13 INFO - PROCESS | 12141 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39511/tests/dromaeo/cssquery-ext.html) 00:34:15 INFO - PROCESS | 12141 | RSS: Main: 165081088 00:34:15 INFO - PROCESS | 12141 | 00:36:02 INFO - PROCESS | 12141 | ************************* 00:36:02 INFO - PROCESS | 12141 | A coding exception was thrown and uncaught in a Task. 00:36:02 INFO - PROCESS | 12141 | 00:36:02 INFO - PROCESS | 12141 | Full message: ReferenceError: fetch is not defined 00:36:02 INFO - PROCESS | 12141 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 00:36:02 INFO - PROCESS | 12141 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 00:36:02 INFO - PROCESS | 12141 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 00:36:02 INFO - PROCESS | 12141 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 00:36:02 INFO - PROCESS | 12141 | TaskImpl@resource://gre/modules/Task.jsm:277:3 00:36:02 INFO - PROCESS | 12141 | asyncFunction@resource://gre/modules/Task.jsm:252:14 00:36:02 INFO - PROCESS | 12141 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 00:36:02 INFO - PROCESS | 12141 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 00:36:02 INFO - PROCESS | 12141 | TaskImpl@resource://gre/modules/Task.jsm:277:3 00:36:02 INFO - PROCESS | 12141 | asyncFunction@resource://gre/modules/Task.jsm:252:14 00:36:02 INFO - PROCESS | 12141 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 00:36:02 INFO - PROCESS | 12141 | 00:36:02 INFO - PROCESS | 12141 | ************************* 00:37:17 INFO - PROCESS | 12141 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-ext.html (next: http://localhost:39511/tests/dromaeo/cssquery-jquery.html) 00:37:18 INFO - PROCESS | 12141 | RSS: Main: 161660928 00:37:18 INFO - PROCESS | 12141 | 00:40:20 INFO - PROCESS | 12141 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39511/tests/dromaeo/cssquery-mootools.html) 00:40:20 INFO - PROCESS | 12141 | RSS: Main: 165212160 00:40:20 INFO - PROCESS | 12141 | 00:43:22 INFO - PROCESS | 12141 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39511/tests/dromaeo/cssquery-prototype.html) 00:43:23 INFO - PROCESS | 12141 | RSS: Main: 160387072 00:43:23 INFO - PROCESS | 12141 | 00:46:25 INFO - PROCESS | 12141 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39511/tests/dromaeo/cssquery-yui.html) 00:46:26 INFO - PROCESS | 12141 | RSS: Main: 164368384 00:46:26 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-yui.html (next: http://localhost:39511/tests/dromaeo/cssquery-dojo.html) 00:49:29 INFO - PROCESS | 12141 | RSS: Main: 163905536 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | __start_tp_report 00:49:29 INFO - PROCESS | 12141 | _x_x_mozilla_page_load 00:49:29 INFO - PROCESS | 12141 | _x_x_mozilla_page_load_details 00:49:29 INFO - PROCESS | 12141 | |i|pagename|runs| 00:49:29 INFO - PROCESS | 12141 | |0;dojo.html;3127.7810553261265;3128.7809853310278;3135.6707545707686;3147.638021627512;3178.1577881861313;5160.993606246783;5331.306930099082;5338.199270109486;5338.652987555806;5374.865628359284;5247.816326428576;5285.207218917164;5334.119870221419;5338.092524270874;5390.245365648802;4711.8586442406695;4744.881377965544;4771.642126840501;4856.660033797635;4862.416510018785;4802.83190088347;4855.611551075923;4887.6089912807065;4903.313536104948;4935.333729946465;4677.695949763254;4704.294355846616;4907.09790852336;4915.459299477055;4924.9507504925205;4783.4977327380475;4795.4964728703335;4820.927686084711;4856.4172299323955;4909.779059942275;4816;4837.7339246341435;4837.9516204837855;4842.346283251751;4851.951480485185;5201.323827902386;5250.05499010178;5270.130428479296;5288.391834938954;5354.089804733166;5550.417206193332;5575.609707320489;5593.776248950037;5597.44025597441;5748.396418376052;5681.914771278434;5700.059490184115;5703.0019746544185;5719.370869204384;5729.856753581152;5285.154375299972;5318.44156363584;5323.1216849219445;5325.041492531343;5354.571634269249;5623.746931388016;5665.745041473144;5765.221695071112;5770.567207459458;5806.419358064244;5555.472230138131;5557.972210138923;5563.833085007456;5581.10702287632;5603.047481928082;5629.521490673257;5641.830745077655;5683.204351390808;5686.744096515667;5688.857778555486;5591.10542313228;5592.916106258409;5621.184928185472;5622.91565626516;5623.578231632562;5648.858778530487;5679.801206957819;5692.943070569241;5694.288213973254;5725.713714314267;4314.374415709704;4322.330038843984;4324.589164029412;4327.545607711208;4364.061726728705;3775.565809931893;3797.582265950743;3807.143392736612;3859.073822282632;3875.8837234883;5390.973045134828;5399.649022813504;5410.83767486976;5449.5640348772795;5464.398916119224;5647.745851436695;5662.320521537359;5664.943350566524;5684.54523638108;5690.459406356389;5332.253484512172;5377.3816011159215;5387.730613469311;5405.621606487508;5434.565234781208;4695.600873925755;4725.503822098699;4727.2436410174205;4778.331033655291;4782.95217047832;5848.181254624271;5886.970565147147;5906.7637294508595;5932.3177834548715;5941.792037278675;5606.215129881902;5642.210090587239;5694.914576281442;5704.515116215168;5771.653700777967;5846.152307915413;5877.089051197071;5892.263467066617;5912.054071348563;5982.760689572368;5615.354234263112;5652.6043176978865;5656.886862262814;5657.066584013756;5671.0359238930305;5491.313585801775;5691;5735.340435849931;5747.683877386784;5756.136579513107;5408.242846001642;5535.280413546213;5552.69460179694;5596.048671725898;5666.829995100154;5560.805371811967;5562.249096371938;5564.860878477908;5596.748146333343;5605.831825045255;5419.105847535113;5421.9969305677;5571.164325351229;5592.580556458201;5628.380878103323;5628.493435590816;5638.83083507479;5702.743376547983;5718.1708652246025;5761.481466667852;5522.917156242579;5562.72186390687;5563.304586926634;5566.109422492382;5579.358373787067 00:49:29 INFO - PROCESS | 12141 | |1;ext.html;535.0743214239366;546.2980070609268;560.9130584759364;568.1165787200903;573.7418161827176;41557;43979.3403098953;44190.77904610476;47573.52426475734;47832;45559.77220113903;45986.31020534695;46098.76950615242;46127.30809037859;46135.76932115343;8929.241014513775;9086.04596517366;9102.362834601581;9103.998560158378;10289.279750417474;10196.490175491233;10447.529861156228;10502.527386267637;10556.788864222712;10573.365598064102;10518.474076296194;10533.315334503233;10608.628697995571;10615;10649.094826939681;10522;10592.52333644984;10594.682159535227;10603.045725884707;10627.840582391193;10272.126869216125;10273.9486302568;10277.023682750127;10356.378617282988;10368.740781480448;39118.80440597779;39482.407763883566;39509.20981580381;39594.40608390876;39638.801805990784;4021.8391264349393;4035.455213546163;4109.116539943926;4160.063985603215;4172.77049762263;29593.55609665857;29621;29720.70279297201;29993.400131997456;30236.546451803242;4171.20747058058;4224.767637779921;4324.200022995756;4427.889302767424;4467;337841;338915;339679.99999999756;339996;341553;52528.212076818876;52786;52809;52891.94216115656;52905;56310.029148979585;56493.71753141208;56624.150637740466;56758;56763.148552771745;15001.174935378658;15065.849341506664;15235.314410851539;15302.693946121239;15396.307166177548;10767.084797792118;11016.614418495474;11173.329600224013;11236.494357753922;11616.535338586531;16965.321387144624;17016;17079.573010674834;17085.060321682427;17211.56971075708;6642.501812364092;6683.866322673519;6732.596044237362;6738.629375384401;6754.797356079325;899.3389858454032;927;928.7863791328033;930.3348106104168;932.128459890005;30213.395732085675;30456.390872182874;30698.232544186572;31209.687903120677;31433.685663143075;1047.2250534604339;1098.1434481104752;1105.2208193223757;1123.8876112388696;1126.9098472122212;15708.607284817743;16597;16732.58168545796;16758.1620918956;16826.158692065594;489880;497985;498931;502220;503344;60099.699501503084;60446;60721.69639151776;60744.696276518334;61085.38914610886;1339.5579458778775;1390.1589538329367;1390.8400533938727;1392.067314899;1393.171063217384;29416.11751647454;29554.408911822073;30679.2330191747;30761.692383076777;31318;50912.23631645454;51645.48354516407;51697;51772.74113629408;51869.481305187976;299465;300251;302038;302394;304383;24764.38089047788;25415;26714.866425667748;26997;28375.148745537666;47694.5230547704;48216;48270.517294826604;48621;48744.26883596678;39543;40007.79996100001;40314.39528407135;40440.79779601083;41727.58272417237;38323;39334.213315734094;40394.79802600968;41652.79173604234;41718.58281417147;39723.80138099291;40259.79870100631;40271.79864100778;40969.38545921754;40990.79504602458;33416.832915835264;35437;35695.64304356923;35787.28425431425;35966.280674386886;26540.336491587866;27144.1856744298;27373.167756514504;27389.86305068462;27412.72587274102 00:49:29 INFO - PROCESS | 12141 | |2;jquery.html;386.102312124311;390.5567181249283;405.7200531633173;409.3164415426238;414.1447910065714;16993;17032.318707251725;17490.650186996252;18798.15408306626;18952.526186845334;12523.311217883012;12615;12629.810552841715;14961.700765984673;18867.811321886777;5143.794248230066;5336.839894803162;5341.332333458317;5349.090654588729;5356.625036247464;4658.138244424792;5724.685142317171;5787.652740835542;5790.507806836424;5812.564057695668;5717.485426311631;5742.4831765141125;5758.712064396785;5771.884562308751;5772.30732312121;5567.47109024642;5788.913166302488;5827.912581311262;5902.911456328158;5921.644701317935;5653.943460565424;5707.429257074301;5708.086706127041;5725.2843394575675;5859.861150680013;13055.738885222243;13233.139845909986;13362.131461455072;13366.665833354147;13388.129771564818;2700.66241719785;2777.7361150690654;2794.190238284001;2795.55271156616;2812.985935070332;9760.707178784647;10114.140298074672;10191.541380637815;10416.27086103973;10766.24636275461;1895.9146838392167;1962.8078671085837;1997.9200831966705;2005.5287007553213;2016.90923908423;74549;77556;77583.61208193922;78007;79563.60218198872;10900.454977251105;10986.670399888017;11136.944315278533;11227.607033753779;11578.247413918069;15308.234588270541;15322.770158447633;15347.769783453257;15354.232288385536;15394.23028848553;7399.741009064657;7684.961575192088;7740.148583655793;7760.495567788075;7772.7668169954995;7087.3267039631155;7087.362137407555;7200.711971521186;7352.5220860643885;7404.740834070782;4715.55202255792;4741.857744267678;4754.334393184957;4844.878878028007;4896.436909755424;1804.2512357371807;1858.27527264367;1878.783939846935;1892.3849748831685;1924.70167124096;869.9173578510031;893.2630579771715;902.8374892519279;904.3895370624801;926.5737760630186;17628;18042.097895105453;18166.455006349832;18341.90829045873;18574.25702971866;910.5401772105045;910.9863352049724;911.5943405184629;923.6490133749132;932.5616960028775;10130.696079117639;10192.796144077225;10207.795844083077;10318;10338.741531461774;432058;436187;436386;438520;439577;86470;90306.54846725725;90865.54567227254;90899.09100909038;91870.81291870894;1054.9367037977745;1091.8089334366455;1095.4084794211037;1098.077614803553;1104.6244276945715;16102.355905763638;16485.91757041207;16803.32786688519;16832.74750878713;17284.04937728437;38928.41607375948;40414;40614.59385406227;41150.79424602858;41624;54505.454945451624;55263.44736552583;55989.72005139948;57221.71389143028;57446;7519.774406767806;7527.177308509309;7689;7741.148473667779;7823.295903368724;10791.40647264408;12213.206141600767;12802.16785908913;13012.479500819862;13257.469701211843;10730.356178629307;10937;11035.172362073037;11062.22564420483;11115.166362523005;5823.18475413451;9464.716058518256;10776.030157285883;10910.290831095954;11023.503942322453;10862.782744345226;11257.21199516026;11681.591144309908;11716.94141529287;11908.583199587973;8169.223923727236;8240.1347858474;8289.544075075688;8300.87548686758;8676.305895528469;9785.559649815918;11195.72010699739;11324.716882078013;11610.535578576762;11659.358735269641 00:49:29 INFO - PROCESS | 12141 | |3;mootools.html;1370.5682709946366;1386.154445788069;1386.2444967492722;1397.510871195081;1397.8672026157512;7423.369013633847;7536.96231518843;8123.553204573746;8652.52411117389;8667.653293868245;8056.234657707509;8343.791405214874;8353.164683531659;8581.613827377767;8595.742127736163;2326.9069237230533;2353.599888019041;2353.752855950126;2369.1115831563166;2380.642903564462;2348.6007378745653;2373.098222675381;2402.8918698658604;2413.263954493879;2442.8412153210074;2318.6058370077126;2320.918767843126;2337.544178885118;2340.0639744102323;2351.706036745407;2261.434641339665;2312.456572705413;2314.132200424841;2319.0375993962484;2324.628059510487;2373.133806160756;2375.869327187004;2381.416552944522;2389.116027069978;2396.7842894139612;8625.439346442461;8673.13268673134;8764.342674299389;8776.385653004292;8787.824243515093;5205.27126202332;5346.27825243591;5386.703731294777;5388.137897936312;5393.05621516237;3376.797392156454;3451.2752322012407;3594.3170797548382;3598.6401359864067;3601.549806274216;1355.2952464718292;1382.7856682214274;1421.1544131241894;1476.3430273528284;1508.886833487482;11905.642830715093;11912.225705329125;12009.63971080869;12010.579629712918;12069.698257543543;4301.612854843079;4447.288433850568;4488.169688607618;4552.0668263006;4621.145088158634;9017.143371379709;9129.726108216764;9151.862722059175;9154.816903662022;9174.082591740773;4998.925016124761;5098.107831129538;5100.744962751847;5104.566111880532;5200.817971370984;4691.132140554008;4691.577758001797;4728.196206644879;4744.098621262018;4755.310479980383;3523;3579.982100089483;3659.2681463707363;3663.9267214655556;3703.3148867459067;1059.920505962056;1082.8484012238293;1141.680329507739;1148.0815347721789;1169.6140273709655;966.6375109334;973.6251543155936;976.6972238606055;977.4965892565334;980.9607615695293;5331.946680533222;5767.423257674283;5838.153467747153;5946.940530594638;6021.819345419644;953.413650604873;954.2509130332655;955.6894009446958;961.9038096190465;982.3712823792779;3810.9428358574087;3814.923701525954;3824.101336185994;3825.215830754689;3869.4582758413844;9908;10331.94834025825;10360.222983276284;10375;10428.478576071166;10387.220958428148;10397.740056498496;10412.062914337746;10422.062014418738;10444.63443779464;7643.1974642662835;7930.762077137811;7943;7982.9600851995365;8000.679972801139;5857.9121313179485;5972.641641501524;6026.367231440636;6057.909131363122;6064.787732429344;9396.76508087276;9397.483138427453;9433.858492122761;9451.763705907408;9599.856002159833;9534.475603841855;9551.761205969906;9602.807943841224;9647.083527064917;9681.225501959967;7411.850563336572;7541.132769731551;7555.622218889143;7588.089429268523;7599.65801538921;8165.959170204111;8196.42625016243;8247;8249.79375515617;8259.752207433787;7386.741464048732;7388.224236455309;7393.260673932564;7393.371563416955;7611.314981651678;7238;7293.197748247582;7318.377937875341;7329.083864516935;7399.18608953004;6666.366695163952;6792.422644075111;6796.150481189851;6799.558028728315;6800;4976.776045077908;4990.775415106402;5040.974795126001;5099.592032637306;5226.529612334908;5126.487351264844;5136.9743151284;5180.9740951295;5218.356217791384;5218.712970786643 00:49:29 INFO - PROCESS | 12141 | |4;prototype.html;376.0711043722006;382.7952045655574;389.94540764293;393.8582110440239;399.36700329977003;5242.737863106849;5354.839354819352;5426.375966763819;5518.2826232589805;5540.722963851811;5247.107991641421;5332.493413125747;5336.706481143536;5369.973150134254;5385.246065550826;4277.679174061942;4289.699721019538;4310;4333.891652708692;4348.195583817004;3989.7207195496326;4165.937510937339;4347.739135651856;4369.563043695637;4382.934255986147;4170.124273902469;4181.853635122771;4185.539590645027;4193.811278492475;4218.282891908383;4153.771542565158;4158.521769996429;4159.064210552631;4188.643965262926;4199.811008504625;3713.498677678506;3726.608706085849;3749.1751814600743;3751.8124093795473;3757.4176002719623;5119.692818430869;5160.354955630546;5202.4277329493725;5207.9479205207845;5251.4485978972425;4762.547557981986;4767.880802979918;4772.236442169271;4787.13831510328;4794.904101917942;5449.863753406157;5563.888722225533;5582.720863956786;5597.776088956437;5600.719964001783;4026.174634199982;4032.3951407288846;4037.1320166164123;4038.7576745395077;4053.723077230663;5864.9149907266865;5866.794662186803;5908.67502287374;5936.940630593682;5940.040066544484;4177.832886684499;4184.916301673949;4194.412782210493;4212.7472351659;4216.683748718797;4082.9591704083173;4180.163967206571;4213.747175169499;4224.387463817729;4244.151169766059;4788.856334309976;4793.281007848781;4807.975960120177;4817.397825271841;4832.178529649968;5636.718164091779;5686.289213848269;5690.4025077367105;5695.629784064023;5702.315722113373;1415.9504417345343;1505.4128889733013;1506.1791323728594;1507.0656193160312;1518.8784897208418;1060.7030031591166;1085.6851513061124;1097.1990446973755;1100.1693721240413;1108.6396921000708;5228.477152284817;5296.92054619181;5308.946910530845;5333.706646134422;5350.545203657655;5622.128570071645;5623.606347555714;5700.059490184156;5713.200151978726;5722.313322401338;5014.398272207359;5167.83723662173;5193.76628051731;5332.680039197583;5338.599605029638;2945.718612403611;2993.3863557970562;3014;3026.031669865622;3028.3337665713507;5851.531877449879;5880.441358070976;5896.941030589725;5915.349311575723;5919.763209471573;5620.409856965041;5989.880202395928;6001.969990150109;6031.849203769853;6032.879342413127;6103.84740381494;6112.51099912006;6115.174451448997;6131.724072416663;6165.718684086916;5589.882023595378;5791.681457519709;5835.124731290341;5857.648541087548;5959.910601340896;5817.447342502455;5821.592488525932;5837.445442682938;5845.561582881216;5851.0053290939795;5817.680027598353;6086.6348019119;6122.816315510542;6144.815655530341;6146.569740118149;4085.9182816342914;4142.958570414257;4145.316022856195;4171.833126674899;4172.457580514514;5766.336871259691;5921.496672782861;5934.703264836828;5948.583599148018;5990.940090599038;5762.279715035621;5774.566907481872;5778.479936805707;5815.82552523425;5832.212651292191;5780.8554786129;5809.709514524341;5813.534917206529;5819.185314056121;5836.474717275466;5611.307981695875;5753.424657534213;5757.251557297524;5763.567732420001;5770.740316685843;5813.15709222152;5821.155932389865;5825.155352473783;5842.561807864342;5871.412858714265;5370.650907690988;5614.438556144353;5698.800541981011;5707.571932105026;5710.37185909558 00:49:29 INFO - PROCESS | 12141 | |5;yui.html;746.0711414289211;751.3163021650299;766.2682138557676;770.1220608506304;794.2732399854132;14317.498887538939;15555;17212;18114.094295285217;18118.27526898926;16421.01473911566;16701.248443820026;16711.665766684688;16951.83048169518;16998.150092495387;805.6898094233718;824.8432797768405;830.5224495914842;830.5888585150359;830.8753686946976;777.6539439949225;819.5041999590252;820.6184124382161;833;837.4723923927917;870.9695160669378;871.0462044061742;871.4074429388014;873.9694110706126;874.4622057434664;862.348926560446;872.4067634008871;872.6422166911599;873.0701802580231;873.3668090634303;634.0236036503778;634.933332000138;635.4757325206723;638.2022471910112;639.3318981664172;15240.085594864233;15684.294206760724;16128.59678508035;16166.19169041555;16197.10915899625;14464.783028254584;14588;14786.556403307917;15101.546953591409;15114.470993515284;12439.653198753738;12443.564475243413;12542.68643283916;12627.189905413044;12643.17819341749;3779.9244015119543;3809.7904615246152;3810.542734871833;3820.522434695663;3843.2121415109837;76909.23090769132;78236.0028596713;78588;78705;80395.5980220101;11436.428178591037;11585.420728963518;11594.188406811441;11688.415579221175;11705.531778728926;21361.78638213598;21439.249626263005;21451.57096858054;21641;21661.56676866454;8052.59737013147;8154.714584989615;8171.182881711781;8267.462614930011;8404.873926891101;4349.739015659071;4394.626456751212;4481.215787237285;4549.6360291176625;4592.081583683277;3598.4062629666337;3649.361361761681;3663.358912190356;3703.5926048134684;3719.8698045568276;644.3620815392727;652.7584793626294;654.1267408010359;669.5380187670492;670.6244503078292;717.7954283029312;727.7962170592243;733.3729661139755;740.9962950185214;762.24537707669;9484.383515071499;9903;10008.49957502122;10382.3251488653;10404.375737455777;671.6205343980636;672.3612568060264;687.9621620810804;706.1067749297143;709.7870638808337;4876.780544875489;5034.597232221487;5099.158638824552;5131.281620573122;5137.588992880561;80096.59951700205;81136;81316.59341703371;82966;86483;69792.3020769796;70502;70638.64680676667;74256;75530.62234688901;64971.675141623986;65078.674606626664;65877.34122658712;66209;67445.66277168583;9511.66709165176;9711.951440242754;9731.659391921248;9745.366551174151;9792;43291.56708433001;43500.78249608732;43678.56321436872;44071.77964110159;44314;54825.1776223349;57387;57840.71079644575;57869.4213057864;58935.115973261294;11978.520859165536;12030.470969151787;12116.575919843115;12420.62738117858;12513.93743031279;13027.153235039692;13151.29923515775;13330.933345333211;13426.798598021232;13572;13001.609951701465;13002.284874332003;13044.608661740163;14081.577552673436;14087.436502540193;13279.203247805162;13815.378307975965;14065.693612154228;14333.856661433252;14513.854861451251;14295.285235737963;14685.41258349654;14721.33753981095;15201.83380859906;15477.767833482281;11636.709082272671;11674.883251167379;12005;12162.817557736818;12395.442205100611;11840.585579504675;11850.525978960744;11920.284782913053;12102.697432564257;12195.939020304842 00:49:29 INFO - PROCESS | 12141 | __end_tp_report 00:49:29 INFO - PROCESS | 12141 | __start_cc_report 00:49:29 INFO - PROCESS | 12141 | _x_x_mozilla_cycle_collect,329 00:49:29 INFO - PROCESS | 12141 | __end_cc_report 00:49:29 INFO - PROCESS | 12141 | __startTimestamp1483087769337__endTimestamp 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | ------- Summary: start ------- 00:49:29 INFO - PROCESS | 12141 | Number of tests: 6 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | [#0] dojo.html Cycles:165 Average:5279.31 Median:5552.69 stddev:601.46 (10.8%) stddev-sans-first:579.14 00:49:29 INFO - PROCESS | 12141 | Values: 3127.8 3128.8 3135.7 3147.6 3178.2 5161.0 5331.3 5338.2 5338.7 5374.9 5247.8 5285.2 5334.1 5338.1 5390.2 4711.9 4744.9 4771.6 4856.7 4862.4 4802.8 4855.6 4887.6 4903.3 4935.3 4677.7 4704.3 4907.1 4915.5 4925.0 4783.5 4795.5 4820.9 4856.4 4909.8 4816.0 4837.7 4838.0 4842.3 4852.0 5201.3 5250.1 5270.1 5288.4 5354.1 5550.4 5575.6 5593.8 5597.4 5748.4 5681.9 5700.1 5703.0 5719.4 5729.9 5285.2 5318.4 5323.1 5325.0 5354.6 5623.7 5665.7 5765.2 5770.6 5806.4 5555.5 5558.0 5563.8 5581.1 5603.0 5629.5 5641.8 5683.2 5686.7 5688.9 5591.1 5592.9 5621.2 5622.9 5623.6 5648.9 5679.8 5692.9 5694.3 5725.7 4314.4 4322.3 4324.6 4327.5 4364.1 3775.6 3797.6 3807.1 3859.1 3875.9 5391.0 5399.6 5410.8 5449.6 5464.4 5647.7 5662.3 5664.9 5684.5 5690.5 5332.3 5377.4 5387.7 5405.6 5434.6 4695.6 4725.5 4727.2 4778.3 4783.0 5848.2 5887.0 5906.8 5932.3 5941.8 5606.2 5642.2 5694.9 5704.5 5771.7 5846.2 5877.1 5892.3 5912.1 5982.8 5615.4 5652.6 5656.9 5657.1 5671.0 5491.3 5691.0 5735.3 5747.7 5756.1 5408.2 5535.3 5552.7 5596.0 5666.8 5560.8 5562.2 5564.9 5596.7 5605.8 5419.1 5422.0 5571.2 5592.6 5628.4 5628.5 5638.8 5702.7 5718.2 5761.5 5522.9 5562.7 5563.3 5566.1 5579.4 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | [#1] ext.html Cycles:180 Average:54761.92 Median:37144.64 stddev:102908.51 (277.0%) stddev-sans-first:103116.66 00:49:29 INFO - PROCESS | 12141 | Values: 535.1 546.3 560.9 568.1 573.7 41557.0 43979.3 44190.8 47573.5 47832.0 45559.8 45986.3 46098.8 46127.3 46135.8 8929.2 9086.0 9102.4 9104.0 10289.3 10196.5 10447.5 10502.5 10556.8 10573.4 10518.5 10533.3 10608.6 10615.0 10649.1 10522.0 10592.5 10594.7 10603.0 10627.8 10272.1 10273.9 10277.0 10356.4 10368.7 39118.8 39482.4 39509.2 39594.4 39638.8 4021.8 4035.5 4109.1 4160.1 4172.8 29593.6 29621.0 29720.7 29993.4 30236.5 4171.2 4224.8 4324.2 4427.9 4467.0 337841.0 338915.0 339680.0 339996.0 341553.0 52528.2 52786.0 52809.0 52891.9 52905.0 56310.0 56493.7 56624.2 56758.0 56763.1 15001.2 15065.8 15235.3 15302.7 15396.3 10767.1 11016.6 11173.3 11236.5 11616.5 16965.3 17016.0 17079.6 17085.1 17211.6 6642.5 6683.9 6732.6 6738.6 6754.8 899.3 927.0 928.8 930.3 932.1 30213.4 30456.4 30698.2 31209.7 31433.7 1047.2 1098.1 1105.2 1123.9 1126.9 15708.6 16597.0 16732.6 16758.2 16826.2 489880.0 497985.0 498931.0 502220.0 503344.0 60099.7 60446.0 60721.7 60744.7 61085.4 1339.6 1390.2 1390.8 1392.1 1393.2 29416.1 29554.4 30679.2 30761.7 31318.0 50912.2 51645.5 51697.0 51772.7 51869.5 299465.0 300251.0 302038.0 302394.0 304383.0 24764.4 25415.0 26714.9 26997.0 28375.1 47694.5 48216.0 48270.5 48621.0 48744.3 39543.0 40007.8 40314.4 40440.8 41727.6 38323.0 39334.2 40394.8 41652.8 41718.6 39723.8 40259.8 40271.8 40969.4 40990.8 33416.8 35437.0 35695.6 35787.3 35966.3 26540.3 27144.2 27373.2 27389.9 27412.7 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | [#2] jquery.html Cycles:180 Average:26593.58 Median:20510.16 stddev:72270.22 (352.4%) stddev-sans-first:72446.17 00:49:29 INFO - PROCESS | 12141 | Values: 386.1 390.6 405.7 409.3 414.1 16993.0 17032.3 17490.7 18798.2 18952.5 12523.3 12615.0 12629.8 14961.7 18867.8 5143.8 5336.8 5341.3 5349.1 5356.6 4658.1 5724.7 5787.7 5790.5 5812.6 5717.5 5742.5 5758.7 5771.9 5772.3 5567.5 5788.9 5827.9 5902.9 5921.6 5653.9 5707.4 5708.1 5725.3 5859.9 13055.7 13233.1 13362.1 13366.7 13388.1 2700.7 2777.7 2794.2 2795.6 2813.0 9760.7 10114.1 10191.5 10416.3 10766.2 1895.9 1962.8 1997.9 2005.5 2016.9 74549.0 77556.0 77583.6 78007.0 79563.6 10900.5 10986.7 11136.9 11227.6 11578.2 15308.2 15322.8 15347.8 15354.2 15394.2 7399.7 7685.0 7740.1 7760.5 7772.8 7087.3 7087.4 7200.7 7352.5 7404.7 4715.6 4741.9 4754.3 4844.9 4896.4 1804.3 1858.3 1878.8 1892.4 1924.7 869.9 893.3 902.8 904.4 926.6 17628.0 18042.1 18166.5 18341.9 18574.3 910.5 911.0 911.6 923.6 932.6 10130.7 10192.8 10207.8 10318.0 10338.7 432058.0 436187.0 436386.0 438520.0 439577.0 86470.0 90306.5 90865.5 90899.1 91870.8 1054.9 1091.8 1095.4 1098.1 1104.6 16102.4 16485.9 16803.3 16832.7 17284.0 38928.4 40414.0 40614.6 41150.8 41624.0 54505.5 55263.4 55989.7 57221.7 57446.0 7519.8 7527.2 7689.0 7741.1 7823.3 10791.4 12213.2 12802.2 13012.5 13257.5 10730.4 10937.0 11035.2 11062.2 11115.2 5823.2 9464.7 10776.0 10910.3 11023.5 10862.8 11257.2 11681.6 11716.9 11908.6 8169.2 8240.1 8289.5 8300.9 8676.3 9785.6 11195.7 11324.7 11610.5 11659.4 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | [#3] mootools.html Cycles:180 Average:5598.19 Median:5203.04 stddev:3090.99 (59.4%) stddev-sans-first:3083.33 00:49:29 INFO - PROCESS | 12141 | Values: 1370.6 1386.2 1386.2 1397.5 1397.9 7423.4 7537.0 8123.6 8652.5 8667.7 8056.2 8343.8 8353.2 8581.6 8595.7 2326.9 2353.6 2353.8 2369.1 2380.6 2348.6 2373.1 2402.9 2413.3 2442.8 2318.6 2320.9 2337.5 2340.1 2351.7 2261.4 2312.5 2314.1 2319.0 2324.6 2373.1 2375.9 2381.4 2389.1 2396.8 8625.4 8673.1 8764.3 8776.4 8787.8 5205.3 5346.3 5386.7 5388.1 5393.1 3376.8 3451.3 3594.3 3598.6 3601.5 1355.3 1382.8 1421.2 1476.3 1508.9 11905.6 11912.2 12009.6 12010.6 12069.7 4301.6 4447.3 4488.2 4552.1 4621.1 9017.1 9129.7 9151.9 9154.8 9174.1 4998.9 5098.1 5100.7 5104.6 5200.8 4691.1 4691.6 4728.2 4744.1 4755.3 3523.0 3580.0 3659.3 3663.9 3703.3 1059.9 1082.8 1141.7 1148.1 1169.6 966.6 973.6 976.7 977.5 981.0 5331.9 5767.4 5838.2 5946.9 6021.8 953.4 954.3 955.7 961.9 982.4 3810.9 3814.9 3824.1 3825.2 3869.5 9908.0 10331.9 10360.2 10375.0 10428.5 10387.2 10397.7 10412.1 10422.1 10444.6 7643.2 7930.8 7943.0 7983.0 8000.7 5857.9 5972.6 6026.4 6057.9 6064.8 9396.8 9397.5 9433.9 9451.8 9599.9 9534.5 9551.8 9602.8 9647.1 9681.2 7411.9 7541.1 7555.6 7588.1 7599.7 8166.0 8196.4 8247.0 8249.8 8259.8 7386.7 7388.2 7393.3 7393.4 7611.3 7238.0 7293.2 7318.4 7329.1 7399.2 6666.4 6792.4 6796.2 6799.6 6800.0 4976.8 4990.8 5041.0 5099.6 5226.5 5126.5 5137.0 5181.0 5218.4 5218.7 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | [#4] prototype.html Cycles:180 Average:4789.56 Median:5335.21 stddev:1399.30 (26.2%) stddev-sans-first:1363.45 00:49:29 INFO - PROCESS | 12141 | Values: 376.1 382.8 389.9 393.9 399.4 5242.7 5354.8 5426.4 5518.3 5540.7 5247.1 5332.5 5336.7 5370.0 5385.2 4277.7 4289.7 4310.0 4333.9 4348.2 3989.7 4165.9 4347.7 4369.6 4382.9 4170.1 4181.9 4185.5 4193.8 4218.3 4153.8 4158.5 4159.1 4188.6 4199.8 3713.5 3726.6 3749.2 3751.8 3757.4 5119.7 5160.4 5202.4 5207.9 5251.4 4762.5 4767.9 4772.2 4787.1 4794.9 5449.9 5563.9 5582.7 5597.8 5600.7 4026.2 4032.4 4037.1 4038.8 4053.7 5864.9 5866.8 5908.7 5936.9 5940.0 4177.8 4184.9 4194.4 4212.7 4216.7 4083.0 4180.2 4213.7 4224.4 4244.2 4788.9 4793.3 4808.0 4817.4 4832.2 5636.7 5686.3 5690.4 5695.6 5702.3 1416.0 1505.4 1506.2 1507.1 1518.9 1060.7 1085.7 1097.2 1100.2 1108.6 5228.5 5296.9 5308.9 5333.7 5350.5 5622.1 5623.6 5700.1 5713.2 5722.3 5014.4 5167.8 5193.8 5332.7 5338.6 2945.7 2993.4 3014.0 3026.0 3028.3 5851.5 5880.4 5896.9 5915.3 5919.8 5620.4 5989.9 6002.0 6031.8 6032.9 6103.8 6112.5 6115.2 6131.7 6165.7 5589.9 5791.7 5835.1 5857.6 5959.9 5817.4 5821.6 5837.4 5845.6 5851.0 5817.7 6086.6 6122.8 6144.8 6146.6 4085.9 4143.0 4145.3 4171.8 4172.5 5766.3 5921.5 5934.7 5948.6 5990.9 5762.3 5774.6 5778.5 5815.8 5832.2 5780.9 5809.7 5813.5 5819.2 5836.5 5611.3 5753.4 5757.3 5763.6 5770.7 5813.2 5821.2 5825.2 5842.6 5871.4 5370.7 5614.4 5698.8 5707.6 5710.4 00:49:29 INFO - PROCESS | 12141 | 00:49:29 INFO - PROCESS | 12141 | [#5] yui.html Cycles:180 Average:18154.29 Median:4515.43 stddev:23164.16 (513.0%) stddev-sans-first:23192.25 00:49:29 INFO - PROCESS | 12141 | Values: 746.1 751.3 766.3 770.1 794.3 14317.5 15555.0 17212.0 18114.1 18118.3 16421.0 16701.2 16711.7 16951.8 16998.2 805.7 824.8 830.5 830.6 830.9 777.7 819.5 820.6 833.0 837.5 871.0 871.0 871.4 874.0 874.5 862.3 872.4 872.6 873.1 873.4 634.0 634.9 635.5 638.2 639.3 15240.1 15684.3 16128.6 16166.2 16197.1 14464.8 14588.0 14786.6 15101.5 15114.5 12439.7 12443.6 12542.7 12627.2 12643.2 3779.9 3809.8 3810.5 3820.5 3843.2 76909.2 78236.0 78588.0 78705.0 80395.6 11436.4 11585.4 11594.2 11688.4 11705.5 21361.8 21439.2 21451.6 21641.0 21661.6 8052.6 8154.7 8171.2 8267.5 8404.9 4349.7 4394.6 4481.2 4549.6 4592.1 3598.4 3649.4 3663.4 3703.6 3719.9 644.4 652.8 654.1 669.5 670.6 717.8 727.8 733.4 741.0 762.2 9484.4 9903.0 10008.5 10382.3 10404.4 671.6 672.4 688.0 706.1 709.8 4876.8 5034.6 5099.2 5131.3 5137.6 80096.6 81136.0 81316.6 82966.0 86483.0 69792.3 70502.0 70638.6 74256.0 75530.6 64971.7 65078.7 65877.3 66209.0 67445.7 9511.7 9712.0 9731.7 9745.4 9792.0 43291.6 43500.8 43678.6 44071.8 44314.0 54825.2 57387.0 57840.7 57869.4 58935.1 11978.5 12030.5 12116.6 12420.6 12513.9 13027.2 13151.3 13330.9 13426.8 13572.0 13001.6 13002.3 13044.6 14081.6 14087.4 13279.2 13815.4 14065.7 14333.9 14513.9 14295.3 14685.4 14721.3 15201.8 15477.8 11636.7 11674.9 12005.0 12162.8 12395.4 11840.6 11850.5 11920.3 12102.7 12195.9 00:49:29 INFO - PROCESS | 12141 | -------- Summary: end -------- 00:49:29 INFO - PROCESS | 12141 | 00:49:30 INFO - TEST-INFO | 12141: exit 0 00:49:30 INFO - TEST-OK | dromaeo_css | took 1113585ms 00:49:30 INFO - TEST-START | kraken 00:49:30 INFO - operating with platform_type : linux_ 00:49:30 INFO - Initialising browser for kraken test... 00:49:30 INFO - TEST-INFO | started process 12490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0xuIsc/profile http://localhost:39511/getInfo.html) 00:49:30 INFO - PROCESS | 12490 | 1483087770546 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:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 00:49:34 INFO - PROCESS | 12490 | __metrics Screen width/height:1600/1200 00:49:34 INFO - PROCESS | 12490 | colorDepth:24 00:49:34 INFO - PROCESS | 12490 | Browser inner width/height: 1024/697 00:49:34 INFO - PROCESS | 12490 | __metrics 00:49:34 ERROR - PROCESS | 12490 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 00:49:35 INFO - TEST-INFO | 12490: exit 0 00:49:35 INFO - Browser initialized. 00:49:35 INFO - Running cycle 1/1 for kraken test... 00:49:35 INFO - TEST-INFO | started process 12615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0xuIsc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:49:47 INFO - PROCESS | 12615 | RSS: Main: 154734592 00:49:47 INFO - PROCESS | 12615 | 00:49:50 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-beat-detection) 00:49:51 INFO - PROCESS | 12615 | RSS: Main: 160657408 00:49:51 INFO - PROCESS | 12615 | 00:49:53 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-dft) 00:49:54 INFO - PROCESS | 12615 | RSS: Main: 158904320 00:49:54 INFO - PROCESS | 12615 | 00:49:57 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-fft) 00:49:58 INFO - PROCESS | 12615 | RSS: Main: 156180480 00:49:58 INFO - PROCESS | 12615 | 00:50:00 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-oscillator) 00:50:00 INFO - PROCESS | 12615 | RSS: Main: 157114368 00:50:00 INFO - PROCESS | 12615 | 00:50:02 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:50:03 INFO - PROCESS | 12615 | RSS: Main: 156569600 00:50:03 INFO - PROCESS | 12615 | 00:50:06 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39511/tests/kraken/driver.html?testName=imaging-darkroom) 00:50:07 INFO - PROCESS | 12615 | RSS: Main: 162037760 00:50:07 INFO - PROCESS | 12615 | 00:50:10 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39511/tests/kraken/driver.html?testName=imaging-desaturate) 00:50:11 INFO - PROCESS | 12615 | RSS: Main: 158777344 00:50:11 INFO - PROCESS | 12615 | 00:50:14 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39511/tests/kraken/driver.html?testName=json-parse-financial) 00:50:14 INFO - PROCESS | 12615 | RSS: Main: 159047680 00:50:14 INFO - PROCESS | 12615 | 00:50:16 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:50:17 INFO - PROCESS | 12615 | RSS: Main: 159477760 00:50:17 INFO - PROCESS | 12615 | 00:50:18 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:50:19 INFO - PROCESS | 12615 | RSS: Main: 159023104 00:50:19 INFO - PROCESS | 12615 | 00:50:21 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:50:22 INFO - PROCESS | 12615 | RSS: Main: 159326208 00:50:22 INFO - PROCESS | 12615 | 00:50:24 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:50:25 INFO - PROCESS | 12615 | RSS: Main: 159473664 00:50:25 INFO - PROCESS | 12615 | 00:50:28 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:50:29 INFO - PROCESS | 12615 | RSS: Main: 159694848 00:50:29 INFO - PROCESS | 12615 | 00:50:30 INFO - PROCESS | 12615 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39511/tests/kraken/driver.html?testName=ai-astar) 00:50:31 INFO - PROCESS | 12615 | RSS: Main: 162086912 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | __start_tp_report 00:50:31 INFO - PROCESS | 12615 | _x_x_mozilla_page_load 00:50:31 INFO - PROCESS | 12615 | _x_x_mozilla_page_load_details 00:50:31 INFO - PROCESS | 12615 | |i|pagename|runs| 00:50:31 INFO - PROCESS | 12615 | |0;ai-astar;105;113;113;113;115;112;114;115;113;114 00:50:31 INFO - PROCESS | 12615 | |1;audio-beat-detection;150;125;127;170;129;126;124;122;152;120 00:50:31 INFO - PROCESS | 12615 | |2;audio-dft;164;166;164;164;167;173;164;168;165;161 00:50:31 INFO - PROCESS | 12615 | |3;audio-fft;76;74;76;103;76;77;77;76;95;76 00:50:31 INFO - PROCESS | 12615 | |4;audio-oscillator;83;84;104;84;85;88;97;85;85;108 00:50:31 INFO - PROCESS | 12615 | |5;imaging-gaussian-blur;117;117;122;117;117;118;118;119;122;117 00:50:31 INFO - PROCESS | 12615 | |6;imaging-darkroom;148;148;148;147;148;147;150;148;148;147 00:50:31 INFO - PROCESS | 12615 | |7;imaging-desaturate;97;96;96;96;96;96;97;98;96;98 00:50:31 INFO - PROCESS | 12615 | |8;json-parse-financial;56;56;58;57;59;57;57;57;57;58 00:50:31 INFO - PROCESS | 12615 | |9;json-stringify-tinderbox;69;68;71;68;70;68;68;69;69;68 00:50:31 INFO - PROCESS | 12615 | |10;stanford-crypto-aes;80;81;81;94;92;81;81;83;82;86 00:50:31 INFO - PROCESS | 12615 | |11;stanford-crypto-ccm;130;126;135;134;136;134;128;146;174;127 00:50:31 INFO - PROCESS | 12615 | |12;stanford-crypto-pbkdf2;169;171;168;174;174;169;167;166;168;167 00:50:31 INFO - PROCESS | 12615 | |13;stanford-crypto-sha256-iterative;63;62;63;63;62;65;62;62;62;63 00:50:31 INFO - PROCESS | 12615 | __end_tp_report 00:50:31 INFO - PROCESS | 12615 | __start_cc_report 00:50:31 INFO - PROCESS | 12615 | _x_x_mozilla_cycle_collect,743 00:50:31 INFO - PROCESS | 12615 | __end_cc_report 00:50:31 INFO - PROCESS | 12615 | __startTimestamp1483087831115__endTimestamp 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | ------- Summary: start ------- 00:50:31 INFO - PROCESS | 12615 | Number of tests: 14 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:2.87 (2.5%) stddev-sans-first:1.01 00:50:31 INFO - PROCESS | 12615 | Values: 105.0 113.0 113.0 113.0 115.0 112.0 114.0 115.0 113.0 114.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:128.00 stddev:16.77 (13.1%) stddev-sans-first:16.83 00:50:31 INFO - PROCESS | 12615 | Values: 150.0 125.0 127.0 170.0 129.0 126.0 124.0 122.0 152.0 120.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:3.24 (2.0%) stddev-sans-first:3.38 00:50:31 INFO - PROCESS | 12615 | Values: 164.0 166.0 164.0 164.0 167.0 173.0 164.0 168.0 165.0 161.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:9.91 (13.0%) stddev-sans-first:10.37 00:50:31 INFO - PROCESS | 12615 | Values: 76.0 74.0 76.0 103.0 76.0 77.0 77.0 76.0 95.0 76.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:85.00 stddev:9.24 (10.9%) stddev-sans-first:9.41 00:50:31 INFO - PROCESS | 12615 | Values: 83.0 84.0 104.0 84.0 85.0 88.0 97.0 85.0 85.0 108.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:2.01 (1.7%) stddev-sans-first:2.07 00:50:31 INFO - PROCESS | 12615 | Values: 117.0 117.0 122.0 117.0 117.0 118.0 118.0 119.0 122.0 117.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 00:50:31 INFO - PROCESS | 12615 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 150.0 148.0 148.0 147.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 00:50:31 INFO - PROCESS | 12615 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 97.0 98.0 96.0 98.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:0.92 (1.6%) stddev-sans-first:0.87 00:50:31 INFO - PROCESS | 12615 | Values: 56.0 56.0 58.0 57.0 59.0 57.0 57.0 57.0 57.0 58.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 00:50:31 INFO - PROCESS | 12615 | Values: 69.0 68.0 71.0 68.0 70.0 68.0 68.0 69.0 69.0 68.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:82.50 stddev:5.00 (6.1%) stddev-sans-first:5.08 00:50:31 INFO - PROCESS | 12615 | Values: 80.0 81.0 81.0 94.0 92.0 81.0 81.0 83.0 82.0 86.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:134.50 stddev:14.24 (10.6%) stddev-sans-first:14.87 00:50:31 INFO - PROCESS | 12615 | Values: 130.0 126.0 135.0 134.0 136.0 134.0 128.0 146.0 174.0 127.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:2.83 (1.7%) stddev-sans-first:3.00 00:50:31 INFO - PROCESS | 12615 | Values: 169.0 171.0 168.0 174.0 174.0 169.0 167.0 166.0 168.0 167.0 00:50:31 INFO - PROCESS | 12615 | 00:50:31 INFO - PROCESS | 12615 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 00:50:31 INFO - PROCESS | 12615 | Values: 63.0 62.0 63.0 63.0 62.0 65.0 62.0 62.0 62.0 63.0 00:50:31 INFO - PROCESS | 12615 | -------- Summary: end -------- 00:50:31 INFO - PROCESS | 12615 | 00:50:32 INFO - TEST-INFO | 12615: exit 0 00:50:32 INFO - TEST-OK | kraken | took 62072ms 00:50:32 INFO - SUITE-END | took 1175s 00:50:32 INFO - Completed test suite (00:19:35) 00:50:32 INFO - javascript benchmark 00:50:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7144.101661097372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.7810553261265, 3128.7809853310278, 3135.6707545707686, 3147.638021627512, 3178.1577881861313, 5160.993606246783, 5331.306930099082, 5338.199270109486, 5338.652987555806, 5374.865628359284, 5247.816326428576, 5285.207218917164, 5334.119870221419, 5338.092524270874, 5390.245365648802, 4711.8586442406695, 4744.881377965544, 4771.642126840501, 4856.660033797635, 4862.416510018785, 4802.83190088347, 4855.611551075923, 4887.6089912807065, 4903.313536104948, 4935.333729946465, 4677.695949763254, 4704.294355846616, 4907.09790852336, 4915.459299477055, 4924.9507504925205, 4783.4977327380475, 4795.4964728703335, 4820.927686084711, 4856.4172299323955, 4909.779059942275, 4816.0, 4837.7339246341435, 4837.9516204837855, 4842.346283251751, 4851.951480485185, 5201.323827902386, 5250.05499010178, 5270.130428479296, 5288.391834938954, 5354.089804733166, 5550.417206193332, 5575.609707320489, 5593.776248950037, 5597.44025597441, 5748.396418376052, 5681.914771278434, 5700.059490184115, 5703.0019746544185, 5719.370869204384, 5729.856753581152, 5285.154375299972, 5318.44156363584, 5323.1216849219445, 5325.041492531343, 5354.571634269249, 5623.746931388016, 5665.745041473144, 5765.221695071112, 5770.567207459458, 5806.419358064244, 5555.472230138131, 5557.972210138923, 5563.833085007456, 5581.10702287632, 5603.047481928082, 5629.521490673257, 5641.830745077655, 5683.204351390808, 5686.744096515667, 5688.857778555486, 5591.10542313228, 5592.916106258409, 5621.184928185472, 5622.91565626516, 5623.578231632562, 5648.858778530487, 5679.801206957819, 5692.943070569241, 5694.288213973254, 5725.713714314267, 4314.374415709704, 4322.330038843984, 4324.589164029412, 4327.545607711208, 4364.061726728705, 3775.565809931893, 3797.582265950743, 3807.143392736612, 3859.073822282632, 3875.8837234883, 5390.973045134828, 5399.649022813504, 5410.83767486976, 5449.5640348772795, 5464.398916119224, 5647.745851436695, 5662.320521537359, 5664.943350566524, 5684.54523638108, 5690.459406356389, 5332.253484512172, 5377.3816011159215, 5387.730613469311, 5405.621606487508, 5434.565234781208, 4695.600873925755, 4725.503822098699, 4727.2436410174205, 4778.331033655291, 4782.95217047832, 5848.181254624271, 5886.970565147147, 5906.7637294508595, 5932.3177834548715, 5941.792037278675, 5606.215129881902, 5642.210090587239, 5694.914576281442, 5704.515116215168, 5771.653700777967, 5846.152307915413, 5877.089051197071, 5892.263467066617, 5912.054071348563, 5982.760689572368, 5615.354234263112, 5652.6043176978865, 5656.886862262814, 5657.066584013756, 5671.0359238930305, 5491.313585801775, 5691.0, 5735.340435849931, 5747.683877386784, 5756.136579513107, 5408.242846001642, 5535.280413546213, 5552.69460179694, 5596.048671725898, 5666.829995100154, 5560.805371811967, 5562.249096371938, 5564.860878477908, 5596.748146333343, 5605.831825045255, 5419.105847535113, 5421.9969305677, 5571.164325351229, 5592.580556458201, 5628.380878103323, 5628.493435590816, 5638.83083507479, 5702.743376547983, 5718.1708652246025, 5761.481466667852, 5522.917156242579, 5562.72186390687, 5563.304586926634, 5566.109422492382, 5579.358373787067], "value": 5238.953400323409, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.0743214239366, 546.2980070609268, 560.9130584759364, 568.1165787200903, 573.7418161827176, 41557.0, 43979.3403098953, 44190.77904610476, 47573.52426475734, 47832.0, 45559.77220113903, 45986.31020534695, 46098.76950615242, 46127.30809037859, 46135.76932115343, 8929.241014513775, 9086.04596517366, 9102.362834601581, 9103.998560158378, 10289.279750417474, 10196.490175491233, 10447.529861156228, 10502.527386267637, 10556.788864222712, 10573.365598064102, 10518.474076296194, 10533.315334503233, 10608.628697995571, 10615.0, 10649.094826939681, 10522.0, 10592.52333644984, 10594.682159535227, 10603.045725884707, 10627.840582391193, 10272.126869216125, 10273.9486302568, 10277.023682750127, 10356.378617282988, 10368.740781480448, 39118.80440597779, 39482.407763883566, 39509.20981580381, 39594.40608390876, 39638.801805990784, 4021.8391264349393, 4035.455213546163, 4109.116539943926, 4160.063985603215, 4172.77049762263, 29593.55609665857, 29621.0, 29720.70279297201, 29993.400131997456, 30236.546451803242, 4171.20747058058, 4224.767637779921, 4324.200022995756, 4427.889302767424, 4467.0, 337841.0, 338915.0, 339679.99999999756, 339996.0, 341553.0, 52528.212076818876, 52786.0, 52809.0, 52891.94216115656, 52905.0, 56310.029148979585, 56493.71753141208, 56624.150637740466, 56758.0, 56763.148552771745, 15001.174935378658, 15065.849341506664, 15235.314410851539, 15302.693946121239, 15396.307166177548, 10767.084797792118, 11016.614418495474, 11173.329600224013, 11236.494357753922, 11616.535338586531, 16965.321387144624, 17016.0, 17079.573010674834, 17085.060321682427, 17211.56971075708, 6642.501812364092, 6683.866322673519, 6732.596044237362, 6738.629375384401, 6754.797356079325, 899.3389858454032, 927.0, 928.7863791328033, 930.3348106104168, 932.128459890005, 30213.395732085675, 30456.390872182874, 30698.232544186572, 31209.687903120677, 31433.685663143075, 1047.2250534604339, 1098.1434481104752, 1105.2208193223757, 1123.8876112388696, 1126.9098472122212, 15708.607284817743, 16597.0, 16732.58168545796, 16758.1620918956, 16826.158692065594, 489880.0, 497985.0, 498931.0, 502220.0, 503344.0, 60099.699501503084, 60446.0, 60721.69639151776, 60744.696276518334, 61085.38914610886, 1339.5579458778775, 1390.1589538329367, 1390.8400533938727, 1392.067314899, 1393.171063217384, 29416.11751647454, 29554.408911822073, 30679.2330191747, 30761.692383076777, 31318.0, 50912.23631645454, 51645.48354516407, 51697.0, 51772.74113629408, 51869.481305187976, 299465.0, 300251.0, 302038.0, 302394.0, 304383.0, 24764.38089047788, 25415.0, 26714.866425667748, 26997.0, 28375.148745537666, 47694.5230547704, 48216.0, 48270.517294826604, 48621.0, 48744.26883596678, 39543.0, 40007.79996100001, 40314.39528407135, 40440.79779601083, 41727.58272417237, 38323.0, 39334.213315734094, 40394.79802600968, 41652.79173604234, 41718.58281417147, 39723.80138099291, 40259.79870100631, 40271.79864100778, 40969.38545921754, 40990.79504602458, 33416.832915835264, 35437.0, 35695.64304356923, 35787.28425431425, 35966.280674386886, 26540.336491587866, 27144.1856744298, 27373.167756514504, 27389.86305068462, 27412.72587274102], "value": 19753.78362650035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.102312124311, 390.5567181249283, 405.7200531633173, 409.3164415426238, 414.1447910065714, 16993.0, 17032.318707251725, 17490.650186996252, 18798.15408306626, 18952.526186845334, 12523.311217883012, 12615.0, 12629.810552841715, 14961.700765984673, 18867.811321886777, 5143.794248230066, 5336.839894803162, 5341.332333458317, 5349.090654588729, 5356.625036247464, 4658.138244424792, 5724.685142317171, 5787.652740835542, 5790.507806836424, 5812.564057695668, 5717.485426311631, 5742.4831765141125, 5758.712064396785, 5771.884562308751, 5772.30732312121, 5567.47109024642, 5788.913166302488, 5827.912581311262, 5902.911456328158, 5921.644701317935, 5653.943460565424, 5707.429257074301, 5708.086706127041, 5725.2843394575675, 5859.861150680013, 13055.738885222243, 13233.139845909986, 13362.131461455072, 13366.665833354147, 13388.129771564818, 2700.66241719785, 2777.7361150690654, 2794.190238284001, 2795.55271156616, 2812.985935070332, 9760.707178784647, 10114.140298074672, 10191.541380637815, 10416.27086103973, 10766.24636275461, 1895.9146838392167, 1962.8078671085837, 1997.9200831966705, 2005.5287007553213, 2016.90923908423, 74549.0, 77556.0, 77583.61208193922, 78007.0, 79563.60218198872, 10900.454977251105, 10986.670399888017, 11136.944315278533, 11227.607033753779, 11578.247413918069, 15308.234588270541, 15322.770158447633, 15347.769783453257, 15354.232288385536, 15394.23028848553, 7399.741009064657, 7684.961575192088, 7740.148583655793, 7760.495567788075, 7772.7668169954995, 7087.3267039631155, 7087.362137407555, 7200.711971521186, 7352.5220860643885, 7404.740834070782, 4715.55202255792, 4741.857744267678, 4754.334393184957, 4844.878878028007, 4896.436909755424, 1804.2512357371807, 1858.27527264367, 1878.783939846935, 1892.3849748831685, 1924.70167124096, 869.9173578510031, 893.2630579771715, 902.8374892519279, 904.3895370624801, 926.5737760630186, 17628.0, 18042.097895105453, 18166.455006349832, 18341.90829045873, 18574.25702971866, 910.5401772105045, 910.9863352049724, 911.5943405184629, 923.6490133749132, 932.5616960028775, 10130.696079117639, 10192.796144077225, 10207.795844083077, 10318.0, 10338.741531461774, 432058.0, 436187.0, 436386.0, 438520.0, 439577.0, 86470.0, 90306.54846725725, 90865.54567227254, 90899.09100909038, 91870.81291870894, 1054.9367037977745, 1091.8089334366455, 1095.4084794211037, 1098.077614803553, 1104.6244276945715, 16102.355905763638, 16485.91757041207, 16803.32786688519, 16832.74750878713, 17284.04937728437, 38928.41607375948, 40414.0, 40614.59385406227, 41150.79424602858, 41624.0, 54505.454945451624, 55263.44736552583, 55989.72005139948, 57221.71389143028, 57446.0, 7519.774406767806, 7527.177308509309, 7689.0, 7741.148473667779, 7823.295903368724, 10791.40647264408, 12213.206141600767, 12802.16785908913, 13012.479500819862, 13257.469701211843, 10730.356178629307, 10937.0, 11035.172362073037, 11062.22564420483, 11115.166362523005, 5823.18475413451, 9464.716058518256, 10776.030157285883, 10910.290831095954, 11023.503942322453, 10862.782744345226, 11257.21199516026, 11681.591144309908, 11716.94141529287, 11908.583199587973, 8169.223923727236, 8240.1347858474, 8289.544075075688, 8300.87548686758, 8676.305895528469, 9785.559649815918, 11195.72010699739, 11324.716882078013, 11610.535578576762, 11659.358735269641], "value": 8733.01715560884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.5682709946366, 1386.154445788069, 1386.2444967492722, 1397.510871195081, 1397.8672026157512, 7423.369013633847, 7536.96231518843, 8123.553204573746, 8652.52411117389, 8667.653293868245, 8056.234657707509, 8343.791405214874, 8353.164683531659, 8581.613827377767, 8595.742127736163, 2326.9069237230533, 2353.599888019041, 2353.752855950126, 2369.1115831563166, 2380.642903564462, 2348.6007378745653, 2373.098222675381, 2402.8918698658604, 2413.263954493879, 2442.8412153210074, 2318.6058370077126, 2320.918767843126, 2337.544178885118, 2340.0639744102323, 2351.706036745407, 2261.434641339665, 2312.456572705413, 2314.132200424841, 2319.0375993962484, 2324.628059510487, 2373.133806160756, 2375.869327187004, 2381.416552944522, 2389.116027069978, 2396.7842894139612, 8625.439346442461, 8673.13268673134, 8764.342674299389, 8776.385653004292, 8787.824243515093, 5205.27126202332, 5346.27825243591, 5386.703731294777, 5388.137897936312, 5393.05621516237, 3376.797392156454, 3451.2752322012407, 3594.3170797548382, 3598.6401359864067, 3601.549806274216, 1355.2952464718292, 1382.7856682214274, 1421.1544131241894, 1476.3430273528284, 1508.886833487482, 11905.642830715093, 11912.225705329125, 12009.63971080869, 12010.579629712918, 12069.698257543543, 4301.612854843079, 4447.288433850568, 4488.169688607618, 4552.0668263006, 4621.145088158634, 9017.143371379709, 9129.726108216764, 9151.862722059175, 9154.816903662022, 9174.082591740773, 4998.925016124761, 5098.107831129538, 5100.744962751847, 5104.566111880532, 5200.817971370984, 4691.132140554008, 4691.577758001797, 4728.196206644879, 4744.098621262018, 4755.310479980383, 3523.0, 3579.982100089483, 3659.2681463707363, 3663.9267214655556, 3703.3148867459067, 1059.920505962056, 1082.8484012238293, 1141.680329507739, 1148.0815347721789, 1169.6140273709655, 966.6375109334, 973.6251543155936, 976.6972238606055, 977.4965892565334, 980.9607615695293, 5331.946680533222, 5767.423257674283, 5838.153467747153, 5946.940530594638, 6021.819345419644, 953.413650604873, 954.2509130332655, 955.6894009446958, 961.9038096190465, 982.3712823792779, 3810.9428358574087, 3814.923701525954, 3824.101336185994, 3825.215830754689, 3869.4582758413844, 9908.0, 10331.94834025825, 10360.222983276284, 10375.0, 10428.478576071166, 10387.220958428148, 10397.740056498496, 10412.062914337746, 10422.062014418738, 10444.63443779464, 7643.1974642662835, 7930.762077137811, 7943.0, 7982.9600851995365, 8000.679972801139, 5857.9121313179485, 5972.641641501524, 6026.367231440636, 6057.909131363122, 6064.787732429344, 9396.76508087276, 9397.483138427453, 9433.858492122761, 9451.763705907408, 9599.856002159833, 9534.475603841855, 9551.761205969906, 9602.807943841224, 9647.083527064917, 9681.225501959967, 7411.850563336572, 7541.132769731551, 7555.622218889143, 7588.089429268523, 7599.65801538921, 8165.959170204111, 8196.42625016243, 8247.0, 8249.79375515617, 8259.752207433787, 7386.741464048732, 7388.224236455309, 7393.260673932564, 7393.371563416955, 7611.314981651678, 7238.0, 7293.197748247582, 7318.377937875341, 7329.083864516935, 7399.18608953004, 6666.366695163952, 6792.422644075111, 6796.150481189851, 6799.558028728315, 6800.0, 4976.776045077908, 4990.775415106402, 5040.974795126001, 5099.592032637306, 5226.529612334908, 5126.487351264844, 5136.9743151284, 5180.9740951295, 5218.356217791384, 5218.712970786643], "value": 4536.988145916376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.0711043722006, 382.7952045655574, 389.94540764293, 393.8582110440239, 399.36700329977003, 5242.737863106849, 5354.839354819352, 5426.375966763819, 5518.2826232589805, 5540.722963851811, 5247.107991641421, 5332.493413125747, 5336.706481143536, 5369.973150134254, 5385.246065550826, 4277.679174061942, 4289.699721019538, 4310.0, 4333.891652708692, 4348.195583817004, 3989.7207195496326, 4165.937510937339, 4347.739135651856, 4369.563043695637, 4382.934255986147, 4170.124273902469, 4181.853635122771, 4185.539590645027, 4193.811278492475, 4218.282891908383, 4153.771542565158, 4158.521769996429, 4159.064210552631, 4188.643965262926, 4199.811008504625, 3713.498677678506, 3726.608706085849, 3749.1751814600743, 3751.8124093795473, 3757.4176002719623, 5119.692818430869, 5160.354955630546, 5202.4277329493725, 5207.9479205207845, 5251.4485978972425, 4762.547557981986, 4767.880802979918, 4772.236442169271, 4787.13831510328, 4794.904101917942, 5449.863753406157, 5563.888722225533, 5582.720863956786, 5597.776088956437, 5600.719964001783, 4026.174634199982, 4032.3951407288846, 4037.1320166164123, 4038.7576745395077, 4053.723077230663, 5864.9149907266865, 5866.794662186803, 5908.67502287374, 5936.940630593682, 5940.040066544484, 4177.832886684499, 4184.916301673949, 4194.412782210493, 4212.7472351659, 4216.683748718797, 4082.9591704083173, 4180.163967206571, 4213.747175169499, 4224.387463817729, 4244.151169766059, 4788.856334309976, 4793.281007848781, 4807.975960120177, 4817.397825271841, 4832.178529649968, 5636.718164091779, 5686.289213848269, 5690.4025077367105, 5695.629784064023, 5702.315722113373, 1415.9504417345343, 1505.4128889733013, 1506.1791323728594, 1507.0656193160312, 1518.8784897208418, 1060.7030031591166, 1085.6851513061124, 1097.1990446973755, 1100.1693721240413, 1108.6396921000708, 5228.477152284817, 5296.92054619181, 5308.946910530845, 5333.706646134422, 5350.545203657655, 5622.128570071645, 5623.606347555714, 5700.059490184156, 5713.200151978726, 5722.313322401338, 5014.398272207359, 5167.83723662173, 5193.76628051731, 5332.680039197583, 5338.599605029638, 2945.718612403611, 2993.3863557970562, 3014.0, 3026.031669865622, 3028.3337665713507, 5851.531877449879, 5880.441358070976, 5896.941030589725, 5915.349311575723, 5919.763209471573, 5620.409856965041, 5989.880202395928, 6001.969990150109, 6031.849203769853, 6032.879342413127, 6103.84740381494, 6112.51099912006, 6115.174451448997, 6131.724072416663, 6165.718684086916, 5589.882023595378, 5791.681457519709, 5835.124731290341, 5857.648541087548, 5959.910601340896, 5817.447342502455, 5821.592488525932, 5837.445442682938, 5845.561582881216, 5851.0053290939795, 5817.680027598353, 6086.6348019119, 6122.816315510542, 6144.815655530341, 6146.569740118149, 4085.9182816342914, 4142.958570414257, 4145.316022856195, 4171.833126674899, 4172.457580514514, 5766.336871259691, 5921.496672782861, 5934.703264836828, 5948.583599148018, 5990.940090599038, 5762.279715035621, 5774.566907481872, 5778.479936805707, 5815.82552523425, 5832.212651292191, 5780.8554786129, 5809.709514524341, 5813.534917206529, 5819.185314056121, 5836.474717275466, 5611.307981695875, 5753.424657534213, 5757.251557297524, 5763.567732420001, 5770.740316685843, 5813.15709222152, 5821.155932389865, 5825.155352473783, 5842.561807864342, 5871.412858714265, 5370.650907690988, 5614.438556144353, 5698.800541981011, 5707.571932105026, 5710.37185909558], "value": 4366.702258328092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.0711414289211, 751.3163021650299, 766.2682138557676, 770.1220608506304, 794.2732399854132, 14317.498887538939, 15555.0, 17212.0, 18114.094295285217, 18118.27526898926, 16421.01473911566, 16701.248443820026, 16711.665766684688, 16951.83048169518, 16998.150092495387, 805.6898094233718, 824.8432797768405, 830.5224495914842, 830.5888585150359, 830.8753686946976, 777.6539439949225, 819.5041999590252, 820.6184124382161, 833.0, 837.4723923927917, 870.9695160669378, 871.0462044061742, 871.4074429388014, 873.9694110706126, 874.4622057434664, 862.348926560446, 872.4067634008871, 872.6422166911599, 873.0701802580231, 873.3668090634303, 634.0236036503778, 634.933332000138, 635.4757325206723, 638.2022471910112, 639.3318981664172, 15240.085594864233, 15684.294206760724, 16128.59678508035, 16166.19169041555, 16197.10915899625, 14464.783028254584, 14588.0, 14786.556403307917, 15101.546953591409, 15114.470993515284, 12439.653198753738, 12443.564475243413, 12542.68643283916, 12627.189905413044, 12643.17819341749, 3779.9244015119543, 3809.7904615246152, 3810.542734871833, 3820.522434695663, 3843.2121415109837, 76909.23090769132, 78236.0028596713, 78588.0, 78705.0, 80395.5980220101, 11436.428178591037, 11585.420728963518, 11594.188406811441, 11688.415579221175, 11705.531778728926, 21361.78638213598, 21439.249626263005, 21451.57096858054, 21641.0, 21661.56676866454, 8052.59737013147, 8154.714584989615, 8171.182881711781, 8267.462614930011, 8404.873926891101, 4349.739015659071, 4394.626456751212, 4481.215787237285, 4549.6360291176625, 4592.081583683277, 3598.4062629666337, 3649.361361761681, 3663.358912190356, 3703.5926048134684, 3719.8698045568276, 644.3620815392727, 652.7584793626294, 654.1267408010359, 669.5380187670492, 670.6244503078292, 717.7954283029312, 727.7962170592243, 733.3729661139755, 740.9962950185214, 762.24537707669, 9484.383515071499, 9903.0, 10008.49957502122, 10382.3251488653, 10404.375737455777, 671.6205343980636, 672.3612568060264, 687.9621620810804, 706.1067749297143, 709.7870638808337, 4876.780544875489, 5034.597232221487, 5099.158638824552, 5131.281620573122, 5137.588992880561, 80096.59951700205, 81136.0, 81316.59341703371, 82966.0, 86483.0, 69792.3020769796, 70502.0, 70638.64680676667, 74256.0, 75530.62234688901, 64971.675141623986, 65078.674606626664, 65877.34122658712, 66209.0, 67445.66277168583, 9511.66709165176, 9711.951440242754, 9731.659391921248, 9745.366551174151, 9792.0, 43291.56708433001, 43500.78249608732, 43678.56321436872, 44071.77964110159, 44314.0, 54825.1776223349, 57387.0, 57840.71079644575, 57869.4213057864, 58935.115973261294, 11978.520859165536, 12030.470969151787, 12116.575919843115, 12420.62738117858, 12513.93743031279, 13027.153235039692, 13151.29923515775, 13330.933345333211, 13426.798598021232, 13572.0, 13001.609951701465, 13002.284874332003, 13044.608661740163, 14081.577552673436, 14087.436502540193, 13279.203247805162, 13815.378307975965, 14065.693612154228, 14333.856661433252, 14513.854861451251, 14295.285235737963, 14685.41258349654, 14721.33753981095, 15201.83380859906, 15477.767833482281, 11636.709082272671, 11674.883251167379, 12005.0, 12162.817557736818, 12395.442205100611, 11840.585579504675, 11850.525978960744, 11920.284782913053, 12102.697432564257, 12195.939020304842], "value": 7424.408469701192, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 115.0, 112.0, 114.0, 115.0, 113.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 127.0, 170.0, 129.0, 126.0, 124.0, 122.0, 152.0, 120.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 164.0, 167.0, 173.0, 164.0, 168.0, 165.0, 161.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 103.0, 76.0, 77.0, 77.0, 76.0, 95.0, 76.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 104.0, 84.0, 85.0, 88.0, 97.0, 85.0, 85.0, 108.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 122.0, 117.0, 117.0, 118.0, 118.0, 119.0, 122.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 150.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 96.0, 98.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 57.0, 59.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 68.0, 70.0, 68.0, 68.0, 69.0, 69.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 94.0, 92.0, 81.0, 81.0, 83.0, 82.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 135.0, 134.0, 136.0, 134.0, 128.0, 146.0, 174.0, 127.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 168.0, 174.0, 174.0, 169.0, 167.0, 166.0, 168.0, 167.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 62.0, 65.0, 62.0, 62.0, 62.0, 63.0], "value": 62.7, "unit": "score"}]}]} 00:50:32 INFO - Return code: 0 00:50:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:50:32 ERROR - # TBPL SUCCESS # 00:50:32 INFO - Running post-action listener: _resource_record_post_action 00:50:32 INFO - [mozharness: 2016-12-30 08:50:32.418864Z] Finished run-tests step (success) 00:50:32 INFO - Running post-run listener: _resource_record_post_run 00:50:32 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 410476544; Read time: 0; Write time: 323724 00:50:32 INFO - TinderboxPrint: CPU usage
13.4% 00:50:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:50:32 INFO - TinderboxPrint: I/O write bytes / time
410,476,544 / 323,724 00:50:32 INFO - TinderboxPrint: CPU idle
8,239.3 (86.6%) 00:50:32 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 00:50:32 INFO - TinderboxPrint: Swap in / out
0 / 0 00:50:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117358592; Read time: 0; Write time: 96948 00:50:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 293117952; Read time: 0; Write time: 226776 00:50:33 INFO - Running post-run listener: _upload_blobber_files 00:50:33 INFO - Blob upload gear active. 00:50:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:50:33 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 00:50:33 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'] 00:50:33 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 00:50:33 INFO - (blobuploader) - INFO - Open directory for files ... 00:50:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:50:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:34 INFO - (blobuploader) - INFO - Done attempting. 00:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:50:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:35 INFO - (blobuploader) - INFO - Done attempting. 00:50:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:50:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:50:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:36 INFO - (blobuploader) - INFO - Done attempting. 00:50:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:50:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:39 INFO - (blobuploader) - INFO - Done attempting. 00:50:39 INFO - (blobuploader) - INFO - Iteration through files over. 00:50:39 INFO - Return code: 0 00:50:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:50:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:50:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2008f694b53565c4fe0ee1b9bcce1ab69234da1483a058758d8b0a94d324eb787193d4bccf1f2a27b828b0153c3c5d372d27f8b0e83aa266acad3e34ebc7806f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a3f0e05684d62f24691c1234325a7320ccfb4be9480e1061057b9df273eeeea1f97e2de958050709eb3bf42d383bd42688745796cc9a88055c7527bb86e8aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2e5f38cdef45653f5e3f095c30889ca950176b4a5a0bd674958086bdd9b7989778687d20cbc3fea2c3afb952dff5c2a563fdc6b9bd6a815df005a56b660fafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/68aae6388740dbe5f7500a5be6ab89bff56b80ad9cbecbd046ab562a2ef7ee2b5d1275336dda1f8c7b0f24a93c353425d5e493fa6c0bf826e95accda95cffbe9"} 00:50:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:50:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:50:39 INFO - Contents: 00:50:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2008f694b53565c4fe0ee1b9bcce1ab69234da1483a058758d8b0a94d324eb787193d4bccf1f2a27b828b0153c3c5d372d27f8b0e83aa266acad3e34ebc7806f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a3f0e05684d62f24691c1234325a7320ccfb4be9480e1061057b9df273eeeea1f97e2de958050709eb3bf42d383bd42688745796cc9a88055c7527bb86e8aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2e5f38cdef45653f5e3f095c30889ca950176b4a5a0bd674958086bdd9b7989778687d20cbc3fea2c3afb952dff5c2a563fdc6b9bd6a815df005a56b660fafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/68aae6388740dbe5f7500a5be6ab89bff56b80ad9cbecbd046ab562a2ef7ee2b5d1275336dda1f8c7b0f24a93c353425d5e493fa6c0bf826e95accda95cffbe9"} 00:50:39 INFO - Running post-run listener: copy_logs_to_upload_dir 00:50:39 INFO - Copying logs to upload dir... 00:50:39 INFO - mkdir: /builds/slave/test/build/upload/logs 00:50:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.652389 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-30 00:50:39.398084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 00:50:39.402047) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650 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/2008f694b53565c4fe0ee1b9bcce1ab69234da1483a058758d8b0a94d324eb787193d4bccf1f2a27b828b0153c3c5d372d27f8b0e83aa266acad3e34ebc7806f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a3f0e05684d62f24691c1234325a7320ccfb4be9480e1061057b9df273eeeea1f97e2de958050709eb3bf42d383bd42688745796cc9a88055c7527bb86e8aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2e5f38cdef45653f5e3f095c30889ca950176b4a5a0bd674958086bdd9b7989778687d20cbc3fea2c3afb952dff5c2a563fdc6b9bd6a815df005a56b660fafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/68aae6388740dbe5f7500a5be6ab89bff56b80ad9cbecbd046ab562a2ef7ee2b5d1275336dda1f8c7b0f24a93c353425d5e493fa6c0bf826e95accda95cffbe9"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011731 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483065355/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/2008f694b53565c4fe0ee1b9bcce1ab69234da1483a058758d8b0a94d324eb787193d4bccf1f2a27b828b0153c3c5d372d27f8b0e83aa266acad3e34ebc7806f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a3f0e05684d62f24691c1234325a7320ccfb4be9480e1061057b9df273eeeea1f97e2de958050709eb3bf42d383bd42688745796cc9a88055c7527bb86e8aac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2e5f38cdef45653f5e3f095c30889ca950176b4a5a0bd674958086bdd9b7989778687d20cbc3fea2c3afb952dff5c2a563fdc6b9bd6a815df005a56b660fafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/68aae6388740dbe5f7500a5be6ab89bff56b80ad9cbecbd046ab562a2ef7ee2b5d1275336dda1f8c7b0f24a93c353425d5e493fa6c0bf826e95accda95cffbe9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 00:50:39.427948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:50:39.428383) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483086602.577602-412450650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 00:50:39.511752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 00:50:39.512067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 00:50:39.512393) ========= ========= Total master_lag: 0.18 =========