builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1483211641.3 results: success (0) buildid: 20161231111339 builduid: 53e2aa3f7d6141e09a8f1fb6689dc7ad revision: fc12fe53968e08b95e47b1cbc55cd622b484b31e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.296166) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.296723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.297244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.348380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.348641) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-31 11:14:01-- 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% 30.9M=0s 2016-12-31 11:14:01 (30.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.495467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.495761) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.544528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.544831) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fc12fe53968e08b95e47b1cbc55cd622b484b31e --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 fc12fe53968e08b95e47b1cbc55cd622b484b31e --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=8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-31 11:14:01,706 truncating revision to first 12 chars 2016-12-31 11:14:01,706 Setting DEBUG logging. 2016-12-31 11:14:01,706 attempt 1/10 2016-12-31 11:14:01,706 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fc12fe53968e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-31 11:14:02,000 unpacking tar archive at: mozilla-inbound-fc12fe53968e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.147597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.148065) ========= script_repo_revision: fc12fe53968e08b95e47b1cbc55cd622b484b31e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.148849) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.149316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.162704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-12-31 11:14:02.163121) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:02 INFO - MultiFileLogger online at 20161231 11:14:02 in /builds/slave/test 11:14:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:02 INFO - {'append_to_log': False, 11:14:02 INFO - 'base_work_dir': '/builds/slave/test', 11:14:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:02 INFO - 'branch': 'Mozilla-Inbound', 11:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:02 INFO - 'config_files': ('talos/linux_config.py',), 11:14:02 INFO - 'default_actions': ('clobber', 11:14:02 INFO - 'read-buildbot-config', 11:14:02 INFO - 'download-and-extract', 11:14:02 INFO - 'populate-webroot', 11:14:02 INFO - 'create-virtualenv', 11:14:02 INFO - 'install', 11:14:02 INFO - 'run-tests'), 11:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:02 INFO - 'download_minidump_stackwalk': True, 11:14:02 INFO - 'download_symbols': 'ondemand', 11:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:02 INFO - 'installer_path': 'installer.exe', 11:14:02 INFO - 'log_level': 'info', 11:14:02 INFO - 'log_name': 'talos', 11:14:02 INFO - 'log_to_console': True, 11:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:02 INFO - 'opt_config_files': (), 11:14:02 INFO - 'pip_index': False, 11:14:02 INFO - 'sps_profile': False, 11:14:02 INFO - 'sps_profile_interval': 0, 11:14:02 INFO - 'suite': 'dromaeojs-e10s', 11:14:02 INFO - 'system_bits': '32', 11:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:02 INFO - 'title': 'talos-linux64-ix-041', 11:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:02 INFO - 'use_talos_json': True, 11:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:02 INFO - 'work_dir': 'build'} 11:14:02 INFO - [mozharness: 2016-12-31 19:14:02.421744Z] Running clobber step. 11:14:02 INFO - Running pre-action listener: _resource_record_pre_action 11:14:02 INFO - Running main action method: clobber 11:14:02 INFO - rmtree: /builds/slave/test/build 11:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:03 INFO - Running post-action listener: _resource_record_post_action 11:14:03 INFO - [mozharness: 2016-12-31 19:14:03.393845Z] Finished clobber step (success) 11:14:03 INFO - [mozharness: 2016-12-31 19:14:03.393944Z] Running read-buildbot-config step. 11:14:03 INFO - Running pre-action listener: _resource_record_pre_action 11:14:03 INFO - Running main action method: read_buildbot_config 11:14:03 INFO - Using buildbot properties: 11:14:03 INFO - { 11:14:03 INFO - "project": "", 11:14:03 INFO - "product": "firefox", 11:14:03 INFO - "script_repo_revision": "production", 11:14:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:14:03 INFO - "repository": "", 11:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:14:03 INFO - "buildid": "20161231111339", 11:14:03 INFO - "stage_platform": "linux64-pgo", 11:14:03 INFO - "basedir": "/builds/slave/test", 11:14:03 INFO - "buildnumber": 2189, 11:14:03 INFO - "platform": "ubuntu64_hw", 11:14:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:14:03 INFO - "slavebuilddir": "test", 11:14:03 INFO - "branch": "mozilla-inbound", 11:14:03 INFO - "revision": "fc12fe53968e08b95e47b1cbc55cd622b484b31e", 11:14:03 INFO - "slavename": "talos-linux64-ix-041", 11:14:03 INFO - "builduid": "53e2aa3f7d6141e09a8f1fb6689dc7ad", 11:14:03 INFO - "repo_path": "integration/mozilla-inbound" 11:14:03 INFO - } 11:14:03 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:14:03 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:14:03 INFO - Running post-action listener: _resource_record_post_action 11:14:03 INFO - [mozharness: 2016-12-31 19:14:03.396336Z] Finished read-buildbot-config step (success) 11:14:03 INFO - [mozharness: 2016-12-31 19:14:03.396431Z] Running download-and-extract step. 11:14:03 INFO - Running pre-action listener: _resource_record_pre_action 11:14:03 INFO - Running main action method: download_and_extract 11:14:03 INFO - mkdir: /builds/slave/test/build/tests 11:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:14:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:14:03 INFO - Downloaded 1361 bytes. 11:14:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:14:03 INFO - Using the following test package requirements: 11:14:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:14:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'jsshell-linux-x86_64.zip'], 11:14:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:03 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:14:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:03 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:14:03 INFO - Expected file size: 21836610 11:14:03 INFO - Obtained file size: 21836610 11:14:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:14:07 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:14:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:14:08 INFO - Expected file size: 21836610 11:14:08 INFO - Obtained file size: 21836610 11:14:12 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:14:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:14:14 INFO - Expected file size: 14409776 11:14:14 INFO - Obtained file size: 14409776 11:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:14:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:14:20 INFO - Downloaded 61377599 bytes. 11:14:20 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:14:20 INFO - mkdir: /builds/slave/test/properties 11:14:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:20 INFO - Contents: 11:14:20 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:14:20 INFO - Running post-action listener: _resource_record_post_action 11:14:20 INFO - Running post-action listener: set_extra_try_arguments 11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.544064Z] Finished download-and-extract step (success) 11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.544292Z] Running populate-webroot step. 11:14:20 INFO - Running pre-action listener: _resource_record_pre_action 11:14:20 INFO - Running main action method: populate_webroot 11:14:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:20 INFO - '--tppagecycles', 11:14:20 INFO - '7'], 11:14:20 INFO - 'tests': ['tsvgm']}}, 11:14:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:14:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:14:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:14:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['damp', 'tps']}, 11:14:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'tests': ['damp', 'tps']}, 11:14:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['dromaeo_dom']}, 11:14:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['basic_compositor_video']}, 11:14:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:14:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['a11yr', 11:14:20 INFO - 'ts_paint', 11:14:20 INFO - 'tpaint', 11:14:20 INFO - 'sessionrestore', 11:14:20 INFO - 'sessionrestore_no_auto_restore', 11:14:20 INFO - 'tabpaint']}, 11:14:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:14:20 INFO - 'ts_paint', 11:14:20 INFO - 'tpaint', 11:14:20 INFO - 'sessionrestore', 11:14:20 INFO - 'sessionrestore_no_auto_restore', 11:14:20 INFO - 'tabpaint']}, 11:14:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:14:20 INFO - 'ts_paint', 11:14:20 INFO - 'tpaint', 11:14:20 INFO - 'sessionrestore', 11:14:20 INFO - 'sessionrestore_no_auto_restore', 11:14:20 INFO - 'tabpaint']}, 11:14:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:14:20 INFO - 'ts_paint', 11:14:20 INFO - 'tpaint', 11:14:20 INFO - 'sessionrestore', 11:14:20 INFO - 'sessionrestore_no_auto_restore', 11:14:20 INFO - 'tabpaint']}, 11:14:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['a11yr', 11:14:20 INFO - 'ts_paint', 11:14:20 INFO - 'tpaint', 11:14:20 INFO - 'sessionrestore', 11:14:20 INFO - 'sessionrestore_no_auto_restore', 11:14:20 INFO - 'tabpaint']}, 11:14:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['a11yr', 11:14:20 INFO - 'ts_paint', 11:14:20 INFO - 'tpaint', 11:14:20 INFO - 'sessionrestore', 11:14:20 INFO - 'sessionrestore_no_auto_restore', 11:14:20 INFO - 'tabpaint']}, 11:14:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['tsvgx', 11:14:20 INFO - 'tsvgr_opacity', 11:14:20 INFO - 'tart', 11:14:20 INFO - 'tscrollx', 11:14:20 INFO - 'cart', 11:14:20 INFO - 'tsvg_static']}, 11:14:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:14:20 INFO - 'tsvgr_opacity', 11:14:20 INFO - 'tart', 11:14:20 INFO - 'tscrollx', 11:14:20 INFO - 'cart', 11:14:20 INFO - 'tsvg_static']}, 11:14:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'talos_options': ['--disable-e10s'], 11:14:20 INFO - 'tests': ['tp5o']}, 11:14:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:14:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'talos_options': ['--disable-e10s', 11:14:20 INFO - '--xperf_path', 11:14:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:20 INFO - 'tests': ['tp5n']}, 11:14:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:14:20 INFO - 'talos_options': ['--xperf_path', 11:14:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:20 INFO - 'tests': ['tp5n']}}, 11:14:20 INFO - 'talos.zip': {'path': '', 11:14:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:20 INFO - Running post-action listener: _resource_record_post_action 11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.560074Z] Finished populate-webroot step (success) 11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.560163Z] Running create-virtualenv step. 11:14:20 INFO - Running pre-action listener: _resource_record_pre_action 11:14:20 INFO - Running main action method: create_virtualenv 11:14:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:14:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:20 INFO - Using real prefix '/usr' 11:14:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:23 INFO - Installing pip.................done. 11:14:23 INFO - Return code: 0 11:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:14:23 INFO - Reading from file tmpfile_stdout 11:14:23 INFO - Output received: 11:14:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:14:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:23 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:14:23 INFO - Using env: {'DISPLAY': ':0', 11:14:23 INFO - 'HOME': '/home/cltbld', 11:14:23 INFO - 'LANG': 'en_US.UTF-8', 11:14:23 INFO - 'LANGUAGE': 'en_US:en', 11:14:23 INFO - 'LOGNAME': 'cltbld', 11:14:23 INFO - 'MAIL': '/var/mail/cltbld', 11:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:23 INFO - 'MOZ_NO_REMOTE': '1', 11:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:23 INFO - 'NO_EM_RESTART': '1', 11:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:23 INFO - 'PWD': '/builds/slave/test', 11:14:23 INFO - 'SHELL': '/bin/bash', 11:14:23 INFO - 'SHLVL': '1', 11:14:23 INFO - 'TERM': 'linux', 11:14:23 INFO - 'TMOUT': '86400', 11:14:23 INFO - 'USER': 'cltbld', 11:14:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:23 INFO - '_': '/tools/buildbot/bin/python'} 11:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:14:23 INFO - Cleaning up... 11:14:23 INFO - Return code: 0 11:14:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:23 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:14:23 INFO - Using env: {'DISPLAY': ':0', 11:14:23 INFO - 'HOME': '/home/cltbld', 11:14:23 INFO - 'LANG': 'en_US.UTF-8', 11:14:23 INFO - 'LANGUAGE': 'en_US:en', 11:14:23 INFO - 'LOGNAME': 'cltbld', 11:14:23 INFO - 'MAIL': '/var/mail/cltbld', 11:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:23 INFO - 'MOZ_NO_REMOTE': '1', 11:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:23 INFO - 'NO_EM_RESTART': '1', 11:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:23 INFO - 'PWD': '/builds/slave/test', 11:14:23 INFO - 'SHELL': '/bin/bash', 11:14:23 INFO - 'SHLVL': '1', 11:14:23 INFO - 'TERM': 'linux', 11:14:23 INFO - 'TMOUT': '86400', 11:14:23 INFO - 'USER': 'cltbld', 11:14:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:23 INFO - '_': '/tools/buildbot/bin/python'} 11:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:23 INFO - Downloading/unpacking psutil>=3.1.1 11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:25 INFO - Installing collected packages: psutil 11:14:25 INFO - Running setup.py install for psutil 11:14:25 INFO - building 'psutil._psutil_linux' extension 11:14:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:14:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:14:26 INFO - building 'psutil._psutil_posix' extension 11:14:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:14:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:26 INFO - Successfully installed psutil 11:14:26 INFO - Cleaning up... 11:14:26 INFO - Return code: 0 11:14:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:26 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:14:26 INFO - Using env: {'DISPLAY': ':0', 11:14:26 INFO - 'HOME': '/home/cltbld', 11:14:26 INFO - 'LANG': 'en_US.UTF-8', 11:14:26 INFO - 'LANGUAGE': 'en_US:en', 11:14:26 INFO - 'LOGNAME': 'cltbld', 11:14:26 INFO - 'MAIL': '/var/mail/cltbld', 11:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:26 INFO - 'MOZ_NO_REMOTE': '1', 11:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:26 INFO - 'NO_EM_RESTART': '1', 11:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:26 INFO - 'PWD': '/builds/slave/test', 11:14:26 INFO - 'SHELL': '/bin/bash', 11:14:26 INFO - 'SHLVL': '1', 11:14:26 INFO - 'TERM': 'linux', 11:14:26 INFO - 'TMOUT': '86400', 11:14:26 INFO - 'USER': 'cltbld', 11:14:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:26 INFO - '_': '/tools/buildbot/bin/python'} 11:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:14:28 INFO - Installing collected packages: mozsystemmonitor 11:14:28 INFO - Running setup.py install for mozsystemmonitor 11:14:28 INFO - Successfully installed mozsystemmonitor 11:14:28 INFO - Cleaning up... 11:14:28 INFO - Return code: 0 11:14:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:14:28 INFO - Using env: {'DISPLAY': ':0', 11:14:28 INFO - 'HOME': '/home/cltbld', 11:14:28 INFO - 'LANG': 'en_US.UTF-8', 11:14:28 INFO - 'LANGUAGE': 'en_US:en', 11:14:28 INFO - 'LOGNAME': 'cltbld', 11:14:28 INFO - 'MAIL': '/var/mail/cltbld', 11:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:28 INFO - 'MOZ_NO_REMOTE': '1', 11:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:28 INFO - 'NO_EM_RESTART': '1', 11:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:28 INFO - 'PWD': '/builds/slave/test', 11:14:28 INFO - 'SHELL': '/bin/bash', 11:14:28 INFO - 'SHLVL': '1', 11:14:28 INFO - 'TERM': 'linux', 11:14:28 INFO - 'TMOUT': '86400', 11:14:28 INFO - 'USER': 'cltbld', 11:14:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:28 INFO - '_': '/tools/buildbot/bin/python'} 11:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:29 INFO - Downloading/unpacking jsonschema==2.5.1 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:31 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:31 INFO - warning: no files found matching '*.txt' 11:14:31 INFO - no previously-included directories found matching 'build' 11:14:31 INFO - no previously-included directories found matching 'dist' 11:14:31 INFO - no previously-included directories found matching '.git*' 11:14:31 INFO - Installing collected packages: jsonschema, functools32 11:14:31 INFO - Running setup.py install for functools32 11:14:31 INFO - warning: no files found matching '*.txt' 11:14:31 INFO - no previously-included directories found matching 'build' 11:14:31 INFO - no previously-included directories found matching 'dist' 11:14:31 INFO - no previously-included directories found matching '.git*' 11:14:31 INFO - Successfully installed jsonschema functools32 11:14:31 INFO - Cleaning up... 11:14:31 INFO - Return code: 0 11:14:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:14:31 INFO - Using env: {'DISPLAY': ':0', 11:14:31 INFO - 'HOME': '/home/cltbld', 11:14:31 INFO - 'LANG': 'en_US.UTF-8', 11:14:31 INFO - 'LANGUAGE': 'en_US:en', 11:14:31 INFO - 'LOGNAME': 'cltbld', 11:14:31 INFO - 'MAIL': '/var/mail/cltbld', 11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:31 INFO - 'MOZ_NO_REMOTE': '1', 11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:31 INFO - 'NO_EM_RESTART': '1', 11:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:31 INFO - 'PWD': '/builds/slave/test', 11:14:31 INFO - 'SHELL': '/bin/bash', 11:14:31 INFO - 'SHLVL': '1', 11:14:31 INFO - 'TERM': 'linux', 11:14:31 INFO - 'TMOUT': '86400', 11:14:31 INFO - 'USER': 'cltbld', 11:14:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:31 INFO - '_': '/tools/buildbot/bin/python'} 11:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:14:31 INFO - Cleaning up... 11:14:31 INFO - Return code: 0 11:14:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:14:31 INFO - Using env: {'DISPLAY': ':0', 11:14:31 INFO - 'HOME': '/home/cltbld', 11:14:31 INFO - 'LANG': 'en_US.UTF-8', 11:14:31 INFO - 'LANGUAGE': 'en_US:en', 11:14:31 INFO - 'LOGNAME': 'cltbld', 11:14:31 INFO - 'MAIL': '/var/mail/cltbld', 11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:31 INFO - 'MOZ_NO_REMOTE': '1', 11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:31 INFO - 'NO_EM_RESTART': '1', 11:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:31 INFO - 'PWD': '/builds/slave/test', 11:14:31 INFO - 'SHELL': '/bin/bash', 11:14:31 INFO - 'SHLVL': '1', 11:14:31 INFO - 'TERM': 'linux', 11:14:31 INFO - 'TMOUT': '86400', 11:14:31 INFO - 'USER': 'cltbld', 11:14:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:31 INFO - '_': '/tools/buildbot/bin/python'} 11:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:32 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:34 INFO - Downloading docopt-0.6.1.tar.gz 11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:34 INFO - Running setup.py install for blobuploader 11:14:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:34 INFO - Running setup.py install for requests 11:14:35 INFO - Running setup.py install for docopt 11:14:35 INFO - Successfully installed blobuploader requests docopt 11:14:35 INFO - Cleaning up... 11:14:35 INFO - Return code: 0 11:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:35 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:35 INFO - Using env: {'DISPLAY': ':0', 11:14:35 INFO - 'HOME': '/home/cltbld', 11:14:35 INFO - 'LANG': 'en_US.UTF-8', 11:14:35 INFO - 'LANGUAGE': 'en_US:en', 11:14:35 INFO - 'LOGNAME': 'cltbld', 11:14:35 INFO - 'MAIL': '/var/mail/cltbld', 11:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:35 INFO - 'MOZ_NO_REMOTE': '1', 11:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:35 INFO - 'NO_EM_RESTART': '1', 11:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:35 INFO - 'PWD': '/builds/slave/test', 11:14:35 INFO - 'SHELL': '/bin/bash', 11:14:35 INFO - 'SHLVL': '1', 11:14:35 INFO - 'TERM': 'linux', 11:14:35 INFO - 'TMOUT': '86400', 11:14:35 INFO - 'USER': 'cltbld', 11:14:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:35 INFO - '_': '/tools/buildbot/bin/python'} 11:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:35 INFO - Running setup.py (path:/tmp/pip-WC48yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:35 INFO - Running setup.py (path:/tmp/pip-4qEjRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:35 INFO - Running setup.py (path:/tmp/pip-uCAt8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:35 INFO - Running setup.py (path:/tmp/pip-gsQNu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:35 INFO - Running setup.py (path:/tmp/pip-M_pzjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:36 INFO - Running setup.py (path:/tmp/pip-89ph_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:36 INFO - Running setup.py (path:/tmp/pip-O73nuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:36 INFO - Running setup.py (path:/tmp/pip-Md2eNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:36 INFO - Running setup.py (path:/tmp/pip-tFq75Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:36 INFO - Running setup.py (path:/tmp/pip-qZ7xIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:36 INFO - Running setup.py (path:/tmp/pip-d38rU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:36 INFO - Running setup.py (path:/tmp/pip-wAZC0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:36 INFO - Running setup.py (path:/tmp/pip-SsgQ2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:36 INFO - Running setup.py (path:/tmp/pip-1pzzk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:36 INFO - Running setup.py (path:/tmp/pip-UtxP7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:36 INFO - Running setup.py (path:/tmp/pip-HpODZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:36 INFO - Running setup.py (path:/tmp/pip-RKm_wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:36 INFO - Running setup.py install for manifestparser 11:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:36 INFO - Running setup.py install for mozcrash 11:14:37 INFO - Running setup.py install for mozdebug 11:14:37 INFO - Running setup.py install for mozdevice 11:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Running setup.py install for mozfile 11:14:37 INFO - Running setup.py install for mozhttpd 11:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Running setup.py install for mozinfo 11:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Running setup.py install for mozInstall 11:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Running setup.py install for mozleak 11:14:37 INFO - Running setup.py install for mozlog 11:14:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:37 INFO - Running setup.py install for moznetwork 11:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:38 INFO - Running setup.py install for mozprocess 11:14:38 INFO - Running setup.py install for mozprofile 11:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:38 INFO - Running setup.py install for mozrunner 11:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:38 INFO - Running setup.py install for mozscreenshot 11:14:38 INFO - Running setup.py install for moztest 11:14:38 INFO - Running setup.py install for mozversion 11:14:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:38 INFO - Cleaning up... 11:14:38 INFO - Return code: 0 11:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:38 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:38 INFO - Using env: {'DISPLAY': ':0', 11:14:38 INFO - 'HOME': '/home/cltbld', 11:14:38 INFO - 'LANG': 'en_US.UTF-8', 11:14:38 INFO - 'LANGUAGE': 'en_US:en', 11:14:38 INFO - 'LOGNAME': 'cltbld', 11:14:38 INFO - 'MAIL': '/var/mail/cltbld', 11:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:38 INFO - 'MOZ_NO_REMOTE': '1', 11:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:38 INFO - 'NO_EM_RESTART': '1', 11:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:38 INFO - 'PWD': '/builds/slave/test', 11:14:38 INFO - 'SHELL': '/bin/bash', 11:14:38 INFO - 'SHLVL': '1', 11:14:38 INFO - 'TERM': 'linux', 11:14:38 INFO - 'TMOUT': '86400', 11:14:38 INFO - 'USER': 'cltbld', 11:14:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:38 INFO - '_': '/tools/buildbot/bin/python'} 11:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:38 INFO - Running setup.py (path:/tmp/pip-QBsWrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:39 INFO - Running setup.py (path:/tmp/pip-ZyWgG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:39 INFO - Running setup.py (path:/tmp/pip-0eBIt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:39 INFO - Running setup.py (path:/tmp/pip-oYP968-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:39 INFO - Running setup.py (path:/tmp/pip-7R_veQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:39 INFO - Running setup.py (path:/tmp/pip-gZPcsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:39 INFO - Running setup.py (path:/tmp/pip-Sb7Smw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:39 INFO - Running setup.py (path:/tmp/pip-0lH35K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:39 INFO - Running setup.py (path:/tmp/pip-Ct19AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:39 INFO - Running setup.py (path:/tmp/pip-RlEKvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:39 INFO - Running setup.py (path:/tmp/pip-vL3Wqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:39 INFO - Running setup.py (path:/tmp/pip-BnaBwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:39 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)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:39 INFO - Running setup.py (path:/tmp/pip-yhTrje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:39 INFO - Running setup.py (path:/tmp/pip-PbI6B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:39 INFO - Running setup.py (path:/tmp/pip-TUq3x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:40 INFO - Running setup.py (path:/tmp/pip-TH6q8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:40 INFO - Running setup.py (path:/tmp/pip-OMzWQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:42 INFO - Downloading blessings-1.6.tar.gz 11:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:42 INFO - Installing collected packages: blessings 11:14:42 INFO - Running setup.py install for blessings 11:14:42 INFO - Successfully installed blessings 11:14:42 INFO - Cleaning up... 11:14:42 INFO - Return code: 0 11:14:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:42 INFO - Reading from file tmpfile_stdout 11:14:42 INFO - Current package versions: 11:14:42 INFO - argparse == 1.2.1 11:14:42 INFO - blessings == 1.6 11:14:42 INFO - blobuploader == 1.2.4 11:14:42 INFO - docopt == 0.6.1 11:14:42 INFO - functools32 == 3.2.3-2 11:14:42 INFO - jsonschema == 2.5.1 11:14:42 INFO - manifestparser == 1.1 11:14:42 INFO - mozInstall == 1.12 11:14:42 INFO - mozcrash == 1.0 11:14:42 INFO - mozdebug == 0.1 11:14:42 INFO - mozdevice == 0.49 11:14:42 INFO - mozfile == 1.2 11:14:42 INFO - mozhttpd == 0.7 11:14:42 INFO - mozinfo == 0.9 11:14:42 INFO - mozleak == 0.1 11:14:42 INFO - mozlog == 3.4 11:14:42 INFO - moznetwork == 0.27 11:14:42 INFO - mozprocess == 0.23 11:14:42 INFO - mozprofile == 0.28 11:14:42 INFO - mozrunner == 6.13 11:14:42 INFO - mozscreenshot == 0.1 11:14:42 INFO - mozsystemmonitor == 0.3 11:14:42 INFO - moztest == 0.8 11:14:42 INFO - mozversion == 1.4 11:14:42 INFO - psutil == 3.1.1 11:14:42 INFO - requests == 1.2.3 11:14:42 INFO - wsgiref == 0.1.2 11:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:42 INFO - Using env: {'DISPLAY': ':0', 11:14:42 INFO - 'HOME': '/home/cltbld', 11:14:42 INFO - 'LANG': 'en_US.UTF-8', 11:14:42 INFO - 'LANGUAGE': 'en_US:en', 11:14:42 INFO - 'LOGNAME': 'cltbld', 11:14:42 INFO - 'MAIL': '/var/mail/cltbld', 11:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:42 INFO - 'MOZ_NO_REMOTE': '1', 11:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:42 INFO - 'NO_EM_RESTART': '1', 11:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:42 INFO - 'PWD': '/builds/slave/test', 11:14:42 INFO - 'SHELL': '/bin/bash', 11:14:42 INFO - 'SHLVL': '1', 11:14:42 INFO - 'TERM': 'linux', 11:14:42 INFO - 'TMOUT': '86400', 11:14:42 INFO - 'USER': 'cltbld', 11:14:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:42 INFO - '_': '/tools/buildbot/bin/python'} 11:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:14:42 INFO - Cleaning up... 11:14:42 INFO - Return code: 0 11:14:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:42 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 0xf7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ed480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:42 INFO - Using env: {'DISPLAY': ':0', 11:14:42 INFO - 'HOME': '/home/cltbld', 11:14:42 INFO - 'LANG': 'en_US.UTF-8', 11:14:42 INFO - 'LANGUAGE': 'en_US:en', 11:14:42 INFO - 'LOGNAME': 'cltbld', 11:14:42 INFO - 'MAIL': '/var/mail/cltbld', 11:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:42 INFO - 'MOZ_NO_REMOTE': '1', 11:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:42 INFO - 'NO_EM_RESTART': '1', 11:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:42 INFO - 'PWD': '/builds/slave/test', 11:14:42 INFO - 'SHELL': '/bin/bash', 11:14:42 INFO - 'SHLVL': '1', 11:14:42 INFO - 'TERM': 'linux', 11:14:42 INFO - 'TMOUT': '86400', 11:14:42 INFO - 'USER': 'cltbld', 11:14:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:42 INFO - '_': '/tools/buildbot/bin/python'} 11:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:14:43 INFO - Cleaning up... 11:14:43 INFO - Return code: 0 11:14:43 INFO - Running post-action listener: _resource_record_post_action 11:14:43 INFO - Running post-action listener: _start_resource_monitoring 11:14:43 INFO - Starting resource monitoring. 11:14:43 INFO - [mozharness: 2016-12-31 19:14:43.159982Z] Finished create-virtualenv step (success) 11:14:43 INFO - [mozharness: 2016-12-31 19:14:43.160526Z] Running install step. 11:14:43 INFO - Running pre-action listener: _resource_record_pre_action 11:14:43 INFO - Running main action method: install 11:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:43 INFO - Reading from file tmpfile_stdout 11:14:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:43 INFO - Reading from file tmpfile_stdout 11:14:43 INFO - Output received: 11:14:43 INFO - Usage: mozinstall [options] installer 11:14:43 INFO - Options: 11:14:43 INFO - -h, --help show this help message and exit 11:14:43 INFO - -d DEST, --destination=DEST 11:14:43 INFO - Directory to install application into. [default: 11:14:43 INFO - "/builds/slave/test"] 11:14:43 INFO - --app=APP Application being installed. [default: firefox] 11:14:43 INFO - mkdir: /builds/slave/test/build/application 11:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:15:00 INFO - Reading from file tmpfile_stdout 11:15:00 INFO - Output received: 11:15:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:00 INFO - Running post-action listener: _resource_record_post_action 11:15:00 INFO - [mozharness: 2016-12-31 19:15:00.798365Z] Finished install step (success) 11:15:00 INFO - [mozharness: 2016-12-31 19:15:00.798634Z] Running run-tests step. 11:15:00 INFO - Running pre-action listener: _resource_record_pre_action 11:15:00 INFO - Running main action method: run_tests 11:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:00 INFO - Python 2.7.3 11:15:00 INFO - Return code: 0 11:15:00 INFO - grabbing minidump binary from tooltool 11:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:00 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 0x12ea820>, '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 0x12eb520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12eb9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:15:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:15:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:15:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:00 INFO - Return code: 0 11:15:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:00 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:15:00 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:15:00 INFO - Using env: {'DISPLAY': ':0', 11:15:00 INFO - 'HOME': '/home/cltbld', 11:15:00 INFO - 'LANG': 'en_US.UTF-8', 11:15:00 INFO - 'LANGUAGE': 'en_US:en', 11:15:00 INFO - 'LOGNAME': 'cltbld', 11:15:00 INFO - 'MAIL': '/var/mail/cltbld', 11:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:00 INFO - 'MOZ_NO_REMOTE': '1', 11:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:00 INFO - 'NO_EM_RESTART': '1', 11:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:00 INFO - 'PWD': '/builds/slave/test', 11:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:00 INFO - 'SHELL': '/bin/bash', 11:15:00 INFO - 'SHLVL': '1', 11:15:00 INFO - 'TERM': 'linux', 11:15:00 INFO - 'TMOUT': '86400', 11:15:00 INFO - 'USER': 'cltbld', 11:15:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889', 11:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:00 INFO - '_': '/tools/buildbot/bin/python'} 11:15:00 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:15:01 INFO - mozversion application_buildid: 20161231093012 11:15:01 INFO - mozversion application_changeset: fc12fe53968e08b95e47b1cbc55cd622b484b31e 11:15:01 INFO - mozversion application_display_name: Nightly 11:15:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:01 INFO - mozversion application_name: Firefox 11:15:01 INFO - mozversion application_remotingname: firefox 11:15:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:15:01 INFO - mozversion application_vendor: Mozilla 11:15:01 INFO - mozversion application_version: 53.0a1 11:15:01 INFO - mozversion platform_buildid: 20161231093012 11:15:01 INFO - mozversion platform_changeset: fc12fe53968e08b95e47b1cbc55cd622b484b31e 11:15:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:15:01 INFO - mozversion platform_version: 53.0a1 11:15:01 INFO - using testdate: 1483211701 11:15:01 INFO - actual date: 1483211701 11:15:01 INFO - starting webserver on 'localhost:56219' 11:15:01 INFO - SUITE-START | Running 2 tests 11:15:01 INFO - TEST-START | dromaeo_css 11:15:01 INFO - operating with platform_type : linux_ 11:15:01 INFO - Initialising browser for dromaeo_css test... 11:15:01 INFO - TEST-INFO | started process 24757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuaRXox/profile http://localhost:56219/getInfo.html) 11:15:01 INFO - PROCESS | 24757 | 1483211701562 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 11:15:05 INFO - PROCESS | 24757 | __metrics Screen width/height:1600/1200 11:15:05 INFO - PROCESS | 24757 | colorDepth:24 11:15:05 INFO - PROCESS | 24757 | Browser inner width/height: 1024/697 11:15:05 INFO - PROCESS | 24757 | __metrics 11:15:05 ERROR - PROCESS | 24757 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 11:15:06 INFO - TEST-INFO | 24757: exit 0 11:15:06 INFO - Browser initialized. 11:15:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:06 INFO - TEST-INFO | started process 24881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuaRXox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:18 INFO - PROCESS | 24881 | RSS: Main: 154255360 11:15:18 INFO - PROCESS | 24881 | 11:16:08 INFO - PROCESS | 24881 | 1483211768364 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:18:18 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:56219/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56219/tests/dromaeo/cssquery-ext.html) 11:18:20 INFO - PROCESS | 24881 | RSS: Main: 164429824 11:18:20 INFO - PROCESS | 24881 | 11:20:07 INFO - PROCESS | 24881 | ************************* 11:20:07 INFO - PROCESS | 24881 | A coding exception was thrown and uncaught in a Task. 11:20:07 INFO - PROCESS | 24881 | 11:20:07 INFO - PROCESS | 24881 | Full message: ReferenceError: fetch is not defined 11:20:07 INFO - PROCESS | 24881 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:20:07 INFO - PROCESS | 24881 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:20:07 INFO - PROCESS | 24881 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:20:07 INFO - PROCESS | 24881 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:20:07 INFO - PROCESS | 24881 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:20:07 INFO - PROCESS | 24881 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:20:07 INFO - PROCESS | 24881 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:20:07 INFO - PROCESS | 24881 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:20:07 INFO - PROCESS | 24881 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:20:07 INFO - PROCESS | 24881 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:20:07 INFO - PROCESS | 24881 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:20:07 INFO - PROCESS | 24881 | 11:20:07 INFO - PROCESS | 24881 | ************************* 11:21:22 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:56219/tests/dromaeo/cssquery-ext.html (next: http://localhost:56219/tests/dromaeo/cssquery-jquery.html) 11:21:23 INFO - PROCESS | 24881 | RSS: Main: 159158272 11:21:23 INFO - PROCESS | 24881 | 11:24:25 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:56219/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56219/tests/dromaeo/cssquery-mootools.html) 11:24:25 INFO - PROCESS | 24881 | RSS: Main: 166866944 11:24:25 INFO - PROCESS | 24881 | 11:27:27 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:56219/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56219/tests/dromaeo/cssquery-prototype.html) 11:27:28 INFO - PROCESS | 24881 | RSS: Main: 161681408 11:27:28 INFO - PROCESS | 24881 | 11:30:30 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:56219/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56219/tests/dromaeo/cssquery-yui.html) 11:30:31 INFO - PROCESS | 24881 | RSS: Main: 165691392 11:30:31 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:56219/tests/dromaeo/cssquery-yui.html (next: http://localhost:56219/tests/dromaeo/cssquery-dojo.html) 11:33:34 INFO - PROCESS | 24881 | RSS: Main: 165765120 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | __start_tp_report 11:33:34 INFO - PROCESS | 24881 | _x_x_mozilla_page_load 11:33:34 INFO - PROCESS | 24881 | _x_x_mozilla_page_load_details 11:33:34 INFO - PROCESS | 24881 | |i|pagename|runs| 11:33:34 INFO - PROCESS | 24881 | |0;dojo.html;3190.154609028608;3192.840357982101;3194.7444204463645;3213.919652008698;3233.886813961511;5264.710440925747;5285.867853303665;5317.867053323664;5334.5999050071305;5369.543588794957;5297.549708274792;5332.680039197651;5338.359396872371;5373.731313434332;5464.972675136629;4813.133635945528;4828.87927801806;4843.58829499493;4927;4945.530174633422;4756.262779269202;4934.605231581465;4966.478519755427;4997.075541024922;4997.550220480156;4860.902781944376;4963.230699241623;4981.9252711209365;4983.451820299764;5095.133827249358;4830.2513110467935;4842.2736589511505;4858.854234372974;4888.877778055541;4960.156773348539;4863.8784030399165;4867.5132486751045;4901.558859702608;4902;4907.141250281186;5260.500252476008;5300.178472336794;5325.760340784674;5331.573474122061;5361.839144825662;5667.4615911488345;5691.630044047124;5692.487676109128;5715.514181294553;5739.684317362543;5775.624584402;5810.4770570648425;5825.621334613236;5830.82507524775;5865.178874957509;5346.545543628797;5404.189371594292;5414.3232095988005;5418.051840927822;5421.918671219935;5812.389699081536;5818.156367326714;5841.269841269841;5853.94146058534;5945.316288626776;5623.8594035149445;5654.886902261932;5660.518855897295;5662.85842853932;5693.971530142323;5688.687122208318;5689.573282003867;5717.399673034354;5745.052066409079;5748.223989761329;5623.718814059281;5669.914951275734;5692.658440493584;5711.857203569944;5714.028615135437;5730.484256416942;5750.683712395775;5762.74067666956;5773.336066352339;5811;4302.9569704303185;4319.222539942841;4324.891877703019;4326.6754993375625;4354.368616550582;3794.962050379516;3811.0472381904524;3813.56144043433;3853.4412510185866;3881.573026967031;5518.089515230023;5519.254900588449;5534.916976245359;5584.52531534816;5590.636608620427;5775.971120144372;5780.046292361713;5812.041013232769;5824.301083869963;5833.095870140135;5406.351237851483;5438.211459338374;5493.313335833021;5578.2748242728185;5580.832575022756;4741.0754902794315;4786.521347865255;4808.759562021885;4824.710517368899;4833.637477189225;6058.878822423439;6097.115918191926;6099.634021958696;6100.206973093469;6100.511959043266;5602.187682786055;5613.438656134354;5811.360750317377;5826.475617194473;5834.591578589458;6057.909131363122;6063.909041364295;6106.816795496142;6130.459285710702;6142.652254521207;5676.7445464955;5702.37273899879;5714.085746280575;5716.942830571641;5749.9712501437225;5595.944040559542;5783.219265399117;5806.65160090396;5807.709614519342;5829.183914252093;5495.477929596682;5529.060059789765;5551.333839939233;5599.216109744558;5655.349634792052;5582.134769110794;5595.972020139873;5607.831765047055;5609.719514024364;5613.803516876889;5436.103042998019;5477.1510415885605;5556.944430555643;5589.776408943597;5613.747381367766;5583.218349431002;5585.581081418991;5607.831765047055;5622.803201887914;5687.914681279867;5388.595855310789;5422.918656220081;5428.538574221077;5429.321334833146;5430.70131142791 11:33:34 INFO - PROCESS | 24881 | |1;ext.html;539.8488423241492;550.5072959701071;551.5973339462195;577.1314172170884;578.6730497269043;40372.1925561489;43049.13901721968;43166;46618.7669061655;46982;44605;44634;45026;45234.773826130906;45293.77353113238;8717.21545060946;8951.23914467271;8972.205558888216;8978.28173746102;10050.648227312045;10081.848772268422;10385.2211084169;10421.947890260539;10422.478876056204;10425.478726063704;10411.06300432961;10468.476576171199;10487.423191724452;10503.894961050368;10505.474726263694;10337.534810933526;10357.63748268807;10375.688729338095;10392.480375981246;10408.271421000532;10156.695299141038;10202.948985255027;10241.84637230442;10242.385456872536;10260.640877569249;38770.80614596909;39134.21731565381;39284.21431571381;39302.410463843065;39326.80336598327;4034.213328400963;4052.797360131982;4132.876013719593;4170.914542728636;4197.076643138505;29559.852200739075;29592;29862.402751945057;30001;30128.342941138228;4222.387753775685;4345.826166953318;4367.847125350598;4374.650027997753;4419.0940857124215;335523;336061.99999999756;336181;337125;338330;52215.47784522182;52619.210711839354;52713;52779;52838.47161528412;55426;55742.72128639412;55848.72075639596;55916;56192;15538.844611553966;16072.357105715875;16197.109158996132;16215.189240537926;16220.270087846075;11903.869132432405;12187.268763874195;12470.127091103717;12521.874781252252;12804.295763733084;17415.47753567395;17446.302147913942;17595.64808703819;17650.205740741698;17684.64630707379;6606.570572912745;6805.591664500146;6852.177738671391;6853.965730171317;6879.140107486564;880.2561835249204;902.4900930973979;916.7845556294266;917.8256131335025;947.6351604632266;29287.9056194349;29436.705632943824;30248.69751302459;30367.848160759495;30697;1002.4787110702393;1077.235163034239;1082.2099867097063;1097.7639807441278;1126.2735535579504;15105.39578416873;15158.740870712849;15793.447229347148;15930.681386372207;16166.919165404097;506235;508657;513861;514352;514523;53422.46577534253;53607;53651.73174134104;53963.19055214175;54001.45998540043;1401.4464286606733;1406.6975600245792;1410.132768347459;1422.957311280684;1431.3487363249697;28010.85994570014;28312.71687283101;28473;29068.854655726587;29654.406911862072;46206.537934620224;48021.27968080412;49476;49594.752026239636;54588.72705636605;453465;454113;458054;458586;458950;25499.87250063738;25712.485750285265;25881.611775823;27237.72762272352;38171.42742858804;41346.79326603348;41637.37543936904;42275.7886210567;42391.36412953746;42736.57263427326;35247;35665;35720.464193036605;35951;36157.27685446329;35191.29617407689;35527.28945421025;35798.46302305415;35893.82053089718;36056.27887442184;34941.301173976884;35747.82126089353;35777.82111089428;36099.63900360963;36687.08282292964;30432.695673042985;32867;33054;33075.83462082674;33182.170445738084;24399.39001524976;24738;24911.252662420156;25184.74815251824;32457.35085298328 11:33:34 INFO - PROCESS | 24881 | |2;jquery.html;378.63840032768707;384.84798504590685;387.4227401172254;395.80209895052474;407.5394803871625;17067.91466042671;17818.287268509277;18103.275868965244;18428.723569146474;18429.07854607271;18735.718964215546;18769.343072992448;19282;19375.51561210967;19378.12798424071;5536.169574563827;5538.47384498473;5626.2967129108865;5648.322201335845;5749.05140651794;5495.505404513593;5586.301712285965;5638.351589567191;5647.661140331573;5649.830505084854;5427.240186373911;5541.6674999499955;5595.160725891128;5611.466910643482;5639.971800140994;5611.7474713637985;5624.3813180550105;5657.405972372882;5663.207150998843;5679.4036626154075;5006.599472042228;5013.498650134958;5024.120778863721;5057.8229761958155;5073;22113.55772884533;22140.55718885613;22244.221452249254;22294.21970231034;22395.888020559956;3080.183751305883;3119.3293441909873;3150.8109513429267;3159.0522843146964;3206.294615184679;13890.58328250154;14295.928520357436;14354.64113397163;14462.204578748164;14513.637159071002;1868.4207895552286;1925.4704956137034;1934.520092129522;1938.6413513500047;1950.2589016173904;74602.25397746007;74899.62550187268;75032.62483687601;75113.62443187804;76701.23298767052;9877.40735555869;10047.346922450017;10138.746531336776;10316;10317.174626029899;13888.375023123983;13985.79021314681;14021.579352619437;14081.85918140826;14092.154470731788;7408.518446301081;7758.534487930742;7767.990161278997;7882.330001949784;7986.161453047463;7359.632018399058;7380.594067326241;7610.8097297568;7628.732994345171;7673.3477654398885;6233.407826256498;6398.328175541595;6454.322296158835;6489.448396886318;6523.217213934358;1852.4164888060218;1858.9721154182428;1876.6715824730618;1880.8213219744102;1901.8763780354232;849.4987957105337;876.513534988075;878.7846977490556;884.3058199313637;896.878921345623;17438.825611743974;17553.56116097108;17719;19461.22155113808;19612;954.4368822394681;955.9044095590524;958.3579002068631;961.5336561767538;965.0928127560071;9633.662821801203;9925.751856203507;10011.899881001242;10051.597936082475;10235.641752538626;440539;446788;448773;455301;462212;86753.56623216844;87696;88992;89497.55251223702;89600.5519972396;1059.6979860739807;1080.1574771678104;1099.3898386395626;1102.691246450995;1113.4544073403974;15290.847091529387;15733.685326293182;15992.12043337581;16046.277917493508;16343.264553094901;40777.18445631011;40862;41465.1706965865;41918.790406049;42078.579214208694;49760.502394975585;54385.184222235905;55017.72491137519;55158.72420637871;55785.721071394386;8289.502629842229;8470.110638382881;8475.788105297417;8665;8666.436681615674;12570.748585028065;13216.140950838164;13246.933765331112;13259.138156019828;13513.594592162252;10711.678649640524;10774.515146818569;11099.334039957628;11241.100711943189;11592.072634189413;11317.886821132013;11323.15076369259;11451.713707157387;11536.077113831041;11780.646580602595;11554.364509952033;11713.648590542298;11766.647000589996;11797.174197806415;12167;8254.628541715518;8338.207870252316;8540.40217184791;8553.101924297858;8571;8512.574371281287;11682.76634467289;11823.290602563873;11941.925226729636;11950.223235489666 11:33:34 INFO - PROCESS | 24881 | |3;mootools.html;1379.255202190817;1382.903196776226;1387.0568013750647;1389.9722005559895;1392.1716578635712;7789.766307010792;8149.91850081499;8230.958845205772;8232.54720990346;8339.457935234206;8260.380471464634;8446.28206602438;8504.829903401927;8506.064332923374;8527.957360213206;2311.560803447344;2343.718753749544;2350.647402889563;2357.8585284882874;2364.5507353602848;2333.428310064037;2345.683332750074;2387.940301492459;2398.0887262840097;2404.95190096198;2346.038124369009;2375.845570037942;2378.9286321410386;2381.2380038387723;2385.940351491218;2272.784085511874;2289.9656505152434;2296.8047715944167;2298.4943312471146;2298.7356454007668;2261.185973049701;2325.9767402326097;2344.788968992782;2348.8120950323932;2349.2599831053335;8020.3984701147065;8194.959025204895;8205.138460461625;8209.876851847168;8213.466124701876;5088.618353623493;5230.790768369261;5246.291750613656;5255.86860328491;5257.842264732064;3352.8826491072696;3502.842372093262;3547.450145227494;3607.3867442534834;3612.259486805199;1314.7567699975439;1420.9076410033315;1441.9206943618096;1478.1943840606896;1517.3172072567388;10803.081738052275;10864.565417383295;10971.890281097167;10999.560017599286;11025.283356581876;4290.249206388869;4443.777811109431;4463.152001119777;4476.6418686505;4570.4743954445;8792.516411597424;8810.735677929544;8812.691555795516;8859.202671759573;8865.379423440427;5166.6125040621355;5190.11767999441;5219.921701174486;5225.608079394061;5227.529522343008;4803.519648035239;4807.110684523374;4831.565159135695;4895.094407534618;4897.681650692693;3491.860325586999;3547.2373439710586;3589.7307701921936;3626.2384899170943;3630.183208778004;1072.1155047086029;1092.8688557373166;1162.1458228202264;1231.8891299782883;1232.5377983256278;922.082527884759;930.283681565191;942;942.3874481586886;963.9566219520138;5236.345456817898;5246.868828279324;5312.5218730314455;5404.054290499147;5660.349059858087;928.7028150991617;929.5259417697023;932.1191474057086;944.7024187380953;954.4798085043668;3652.7443078984215;3692.1877187018813;3698.9445158322646;3787.3372159872465;3848.730588858753;9454.621815127455;9729.1243788058;9814.312998090065;9837.311388202757;9855.45794981283;9233.815323693489;9632.9036709632;9696.854547181798;9715.854262186072;9730.659426920023;7714.845703085907;7892.289693927574;7912.881306780403;7916.247956444128;7930.405219608552;5483.670979741229;5491.75287112073;5694.060480020916;5739.282589676291;5786.189933409242;8792.208701216921;8819.514926679094;8850.734477965414;8932.910670893209;9012.909870901207;8709.259712924473;8904.376693631384;9017.549122543978;9026.097390260922;9185.770355740893;7178.712851485882;7237.8914316284245;7241.782746517613;7303.269673032654;7331.74338898136;7737.342325902361;7739.7678069658;7759.262870027338;7771.650275737718;7794.805129871798;7078.115235595551;7142.142942846892;7157.57054576727;7162.64186790648;7349.595772232365;6999.160100787938;7040.049593304839;7044;7060.293970602898;7100.538464999759;6081.817545473643;6147.231596050494;6198.194234749454;6199.861047938454;6203.96898015507;4742.502037286035;4783.115123702126;4810.6151507878585;4841.830535931225;4898.338724272177;4712.151812673752;4826.758662066813;4830.203016502238;4906.681065730716;4910.386201724785 11:33:34 INFO - PROCESS | 24881 | |4;prototype.html;384.1414438729439;396.44497703215495;399.45873341622104;407.22830236701435;409.3573090248308;5145.3053837731895;5240.187770895508;5295.928361550301;5357;5371.677699338043;5213.452587478317;5313.840584782462;5314.787408503656;5335.226392173142;5353.973230133844;4262.019735460831;4280.357946308048;4283.293256612671;4293.957060429387;4318.805653745573;3999.2601368746873;4183.979080104596;4261.2329780639475;4305.5909688579695;4323.5460276670965;4160.292750232453;4180.686448516373;4183.456150700405;4192.371144328345;4192.706510544263;4137.441445404877;4151.398047283127;4158.459400277945;4160.667146628278;4168.6039826216465;3704.9629503705155;3711;3714.331420344337;3715.3312403767313;3715.3620929140343;5040.31955685985;5181.35233095863;5185.896282074337;5188.974055129738;5205.453427390107;4734.455537613184;4735.952640473585;4736.881577960578;4738.218193998021;4744.6441516886025;5449.354642283137;5504.889902201933;5512.586556008276;5544.63959842613;5544.695041772701;3903.7852918089493;3968.1666849961543;3999.460072890181;4000.7799571023584;4010.83956641734;5704.12119758564;5746.396628354046;5756.7121643917635;5776.768929242825;5781.508571771363;4110.938335924963;4111.239420707178;4117.444145040441;4131.586841315844;4185.016521117535;3941.2708648900043;4152.688548358885;4187.91624167515;4212.578742125825;4242.957570424318;4717.669763116617;4731.195696731495;4754.381930349033;4755.286706993978;4783.521647835189;5602.803901863415;5617.719114044281;5626.831195064073;5690.788816275926;5701;1368.3637108744283;1396.9930150349182;1409.2178840743281;1417.5038736442368;1421.9075760075561;948.8671585977969;968.8449848024283;969.471637957315;983.5967253426061;987.3976874106789;5265.815696450606;5277.445868183862;5284.365876094893;5294.735263236823;5331.733413329318;5560.916586251209;5588.714595642944;5592.993261213021;5625.324961004706;5627.52166065889;5145.536901678867;5167.431582525919;5257.185136303879;5294.444083371268;5330.733463326896;2897.5363941769215;2919.656957799436;2941.249981254766;2941.676415594283;2949.9557506637416;5862.736176872051;5872.823815285548;5885.705714714333;5916.816636672683;5928.8814223716145;5449.3460784706085;5609.298837645294;5659.207710920475;5682.659040457503;5708.514776243983;5792.913106303409;5829.849508768206;5884.176215329857;5888.646681199056;5905.675187864536;5210.765515551885;5403.540699040468;5456.980917060713;5476.945230547643;5551.945780061403;5398.325209348832;5427.83716488506;5444.713220447343;5473.507384335429;5509.228707980966;5848.853778655568;5856.209411729533;5860.534866283429;5879;5889.204957330706;3932.5280966283085;3992.4011398289326;4006.419069235003;4018.598140185958;4053.574374690615;5492.5605951524585;5499.535292765532;5521.923224971092;5543.1962365455975;5579.4420557945505;5402.405735369185;5514.228008078792;5568.654092071657;5590.329160500766;5609.467100625434;5558.833235002957;5571.66570005801;5599.32808063035;5610.551155907436;5658.745356459051;5280.603954703336;5472.5621950243085;5492.47821456961;5525.281713377396;5547.278853748987;5588.960029589252;5611.466910643482;5622.7750889963945;5624.493795558419;5626.2967129108865;5423.701696406735;5436.510714035756;5445.156000819879;5504.834854954358;5505.834824955257 11:33:34 INFO - PROCESS | 24881 | |5;yui.html;743.8400743840074;751.9661615227315;787.9559583551792;823.2878560045561;848.1137211613865;15505.534833954986;16808.91595542022;16863.747043794352;16864.156792160375;16915.40796072138;15289.617759556017;15468.839837012241;15472.845271547281;15480.458183963563;15907.761383579227;818.2553875972851;820.4379999700195;829.4525613095358;832.8625776746829;842.1620487614832;828.3042244514606;831.3349320543571;836.8661014237723;842.1157784326433;842.4145219072747;879.0286733159862;880.216607219575;880.8590625499921;881.0176653031855;881.1496905486205;860.5396113079472;867.8784970104191;870.9346798990101;872.520113937332;872.672747719602;640.5548144039894;641.4066988036095;642.4988508963016;643.3502162815544;643.5688088980395;15885.92057039719;16161.111138887356;16241.51275461738;16521.91739041297;16714.83285167145;14749.262536873113;14868.925655371762;14946.775798363033;15169.696606067928;15302.387904483807;12167.574134905324;12328.815067773901;12415.44130514129;12551.184173028816;12570.497180112785;3655.926881462356;3686.760360576554;3706.22169344438;3770.359038963383;3783.829727662262;65986.67006664936;67282.3271767281;67496.32503674999;79438;79497;11276.267042642203;11479.19645624815;11606.303621782552;11729.120315976164;11894.405279735978;21655.783442165375;21672.13311467555;21748;21781;21825;7880.684772609146;7986.480878742863;8049.356051515864;8181.836363272821;8336.541490217975;4484.417025786627;4532.138893610269;4608.953910460919;4642.326862604903;4648.907021859543;3678.4114541673202;3763.303788799081;3793.6585707286476;3796.6583007529457;3800.8669696560487;623.2085251730277;633.072548716133;638.4030931079456;643.3566433566433;654.0908137688616;719.2663483247059;729.1614643160408;743.3198623259765;745.5563939456015;768.7655265144073;9129.95435022834;9792.461414622265;9898.65354712596;10379.63671271517;10500.789984200273;720.8853186640775;739.0872272743158;752.7553545097865;757.4849102610278;767.5739964319856;4529.388532548064;4796.688215265996;4811.182099043171;4873.244647079709;4883.243097319921;78624;78740;80290.59854700688;82230.17769822344;83959.5802020986;71166;71708.64145679238;72711;73104;74470;61727.38272617306;62202.37797622057;62384.68807655932;65258.673706632115;65394;9152.862707059267;9257.21313688317;9496.525173741147;9537.618495260389;9553.092456216647;44403.77798110989;44591.55408445874;44746.77626611846;44753.77623111864;45958.31062534131;51673;54023.45976540184;54082;54773.45226547684;55214;11333.206675532634;11378.601748938747;11731.530738770354;12090.939545302217;12438.19151755133;13695.726085478434;13794.93102534481;13965.860341396456;14616.634584135481;14817.110973341634;11965.184251530922;12181.086418518824;12342.568010119603;12471;12706.745865082461;12789.104762666524;12912.612621621367;12941.417636206204;12954.870451295366;13294.734105318033;13414.195148291134;13618;13665.590032299047;13694.589162325146;14036.228007459687;10904.727381815517;10945.616903408343;11286.322820630789;11344.773104538028;11548.660700984292;10396.688099357032;11110.388928609003;11841.644750657493;12126.211796233216;12145.878541214828 11:33:34 INFO - PROCESS | 24881 | __end_tp_report 11:33:34 INFO - PROCESS | 24881 | __start_cc_report 11:33:34 INFO - PROCESS | 24881 | _x_x_mozilla_cycle_collect,315 11:33:34 INFO - PROCESS | 24881 | __end_cc_report 11:33:34 INFO - PROCESS | 24881 | __startTimestamp1483212814313__endTimestamp 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | ------- Summary: start ------- 11:33:34 INFO - PROCESS | 24881 | Number of tests: 6 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | [#0] dojo.html Cycles:165 Average:5342.40 Median:5578.27 stddev:617.03 (11.1%) stddev-sans-first:595.37 11:33:34 INFO - PROCESS | 24881 | Values: 3190.2 3192.8 3194.7 3213.9 3233.9 5264.7 5285.9 5317.9 5334.6 5369.5 5297.5 5332.7 5338.4 5373.7 5465.0 4813.1 4828.9 4843.6 4927.0 4945.5 4756.3 4934.6 4966.5 4997.1 4997.6 4860.9 4963.2 4981.9 4983.5 5095.1 4830.3 4842.3 4858.9 4888.9 4960.2 4863.9 4867.5 4901.6 4902.0 4907.1 5260.5 5300.2 5325.8 5331.6 5361.8 5667.5 5691.6 5692.5 5715.5 5739.7 5775.6 5810.5 5825.6 5830.8 5865.2 5346.5 5404.2 5414.3 5418.1 5421.9 5812.4 5818.2 5841.3 5853.9 5945.3 5623.9 5654.9 5660.5 5662.9 5694.0 5688.7 5689.6 5717.4 5745.1 5748.2 5623.7 5669.9 5692.7 5711.9 5714.0 5730.5 5750.7 5762.7 5773.3 5811.0 4303.0 4319.2 4324.9 4326.7 4354.4 3795.0 3811.0 3813.6 3853.4 3881.6 5518.1 5519.3 5534.9 5584.5 5590.6 5776.0 5780.0 5812.0 5824.3 5833.1 5406.4 5438.2 5493.3 5578.3 5580.8 4741.1 4786.5 4808.8 4824.7 4833.6 6058.9 6097.1 6099.6 6100.2 6100.5 5602.2 5613.4 5811.4 5826.5 5834.6 6057.9 6063.9 6106.8 6130.5 6142.7 5676.7 5702.4 5714.1 5716.9 5750.0 5595.9 5783.2 5806.7 5807.7 5829.2 5495.5 5529.1 5551.3 5599.2 5655.3 5582.1 5596.0 5607.8 5609.7 5613.8 5436.1 5477.2 5556.9 5589.8 5613.7 5583.2 5585.6 5607.8 5622.8 5687.9 5388.6 5422.9 5428.5 5429.3 5430.7 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | [#1] ext.html Cycles:180 Average:58372.06 Median:35734.14 stddev:116989.89 (327.4%) stddev-sans-first:117237.50 11:33:34 INFO - PROCESS | 24881 | Values: 539.8 550.5 551.6 577.1 578.7 40372.2 43049.1 43166.0 46618.8 46982.0 44605.0 44634.0 45026.0 45234.8 45293.8 8717.2 8951.2 8972.2 8978.3 10050.6 10081.8 10385.2 10421.9 10422.5 10425.5 10411.1 10468.5 10487.4 10503.9 10505.5 10337.5 10357.6 10375.7 10392.5 10408.3 10156.7 10202.9 10241.8 10242.4 10260.6 38770.8 39134.2 39284.2 39302.4 39326.8 4034.2 4052.8 4132.9 4170.9 4197.1 29559.9 29592.0 29862.4 30001.0 30128.3 4222.4 4345.8 4367.8 4374.7 4419.1 335523.0 336062.0 336181.0 337125.0 338330.0 52215.5 52619.2 52713.0 52779.0 52838.5 55426.0 55742.7 55848.7 55916.0 56192.0 15538.8 16072.4 16197.1 16215.2 16220.3 11903.9 12187.3 12470.1 12521.9 12804.3 17415.5 17446.3 17595.6 17650.2 17684.6 6606.6 6805.6 6852.2 6854.0 6879.1 880.3 902.5 916.8 917.8 947.6 29287.9 29436.7 30248.7 30367.8 30697.0 1002.5 1077.2 1082.2 1097.8 1126.3 15105.4 15158.7 15793.4 15930.7 16166.9 506235.0 508657.0 513861.0 514352.0 514523.0 53422.5 53607.0 53651.7 53963.2 54001.5 1401.4 1406.7 1410.1 1423.0 1431.3 28010.9 28312.7 28473.0 29068.9 29654.4 46206.5 48021.3 49476.0 49594.8 54588.7 453465.0 454113.0 458054.0 458586.0 458950.0 25499.9 25712.5 25881.6 27237.7 38171.4 41346.8 41637.4 42275.8 42391.4 42736.6 35247.0 35665.0 35720.5 35951.0 36157.3 35191.3 35527.3 35798.5 35893.8 36056.3 34941.3 35747.8 35777.8 36099.6 36687.1 30432.7 32867.0 33054.0 33075.8 33182.2 24399.4 24738.0 24911.3 25184.7 32457.4 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | [#2] jquery.html Cycles:180 Average:27417.68 Median:20592.36 stddev:74336.54 (361.0%) stddev-sans-first:74517.35 11:33:34 INFO - PROCESS | 24881 | Values: 378.6 384.8 387.4 395.8 407.5 17067.9 17818.3 18103.3 18428.7 18429.1 18735.7 18769.3 19282.0 19375.5 19378.1 5536.2 5538.5 5626.3 5648.3 5749.1 5495.5 5586.3 5638.4 5647.7 5649.8 5427.2 5541.7 5595.2 5611.5 5640.0 5611.7 5624.4 5657.4 5663.2 5679.4 5006.6 5013.5 5024.1 5057.8 5073.0 22113.6 22140.6 22244.2 22294.2 22395.9 3080.2 3119.3 3150.8 3159.1 3206.3 13890.6 14295.9 14354.6 14462.2 14513.6 1868.4 1925.5 1934.5 1938.6 1950.3 74602.3 74899.6 75032.6 75113.6 76701.2 9877.4 10047.3 10138.7 10316.0 10317.2 13888.4 13985.8 14021.6 14081.9 14092.2 7408.5 7758.5 7768.0 7882.3 7986.2 7359.6 7380.6 7610.8 7628.7 7673.3 6233.4 6398.3 6454.3 6489.4 6523.2 1852.4 1859.0 1876.7 1880.8 1901.9 849.5 876.5 878.8 884.3 896.9 17438.8 17553.6 17719.0 19461.2 19612.0 954.4 955.9 958.4 961.5 965.1 9633.7 9925.8 10011.9 10051.6 10235.6 440539.0 446788.0 448773.0 455301.0 462212.0 86753.6 87696.0 88992.0 89497.6 89600.6 1059.7 1080.2 1099.4 1102.7 1113.5 15290.8 15733.7 15992.1 16046.3 16343.3 40777.2 40862.0 41465.2 41918.8 42078.6 49760.5 54385.2 55017.7 55158.7 55785.7 8289.5 8470.1 8475.8 8665.0 8666.4 12570.7 13216.1 13246.9 13259.1 13513.6 10711.7 10774.5 11099.3 11241.1 11592.1 11317.9 11323.2 11451.7 11536.1 11780.6 11554.4 11713.6 11766.6 11797.2 12167.0 8254.6 8338.2 8540.4 8553.1 8571.0 8512.6 11682.8 11823.3 11941.9 11950.2 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | [#3] mootools.html Cycles:180 Average:5383.06 Median:5256.86 stddev:2885.48 (54.9%) stddev-sans-first:2877.88 11:33:34 INFO - PROCESS | 24881 | Values: 1379.3 1382.9 1387.1 1390.0 1392.2 7789.8 8149.9 8231.0 8232.5 8339.5 8260.4 8446.3 8504.8 8506.1 8528.0 2311.6 2343.7 2350.6 2357.9 2364.6 2333.4 2345.7 2387.9 2398.1 2405.0 2346.0 2375.8 2378.9 2381.2 2385.9 2272.8 2290.0 2296.8 2298.5 2298.7 2261.2 2326.0 2344.8 2348.8 2349.3 8020.4 8195.0 8205.1 8209.9 8213.5 5088.6 5230.8 5246.3 5255.9 5257.8 3352.9 3502.8 3547.5 3607.4 3612.3 1314.8 1420.9 1441.9 1478.2 1517.3 10803.1 10864.6 10971.9 10999.6 11025.3 4290.2 4443.8 4463.2 4476.6 4570.5 8792.5 8810.7 8812.7 8859.2 8865.4 5166.6 5190.1 5219.9 5225.6 5227.5 4803.5 4807.1 4831.6 4895.1 4897.7 3491.9 3547.2 3589.7 3626.2 3630.2 1072.1 1092.9 1162.1 1231.9 1232.5 922.1 930.3 942.0 942.4 964.0 5236.3 5246.9 5312.5 5404.1 5660.3 928.7 929.5 932.1 944.7 954.5 3652.7 3692.2 3698.9 3787.3 3848.7 9454.6 9729.1 9814.3 9837.3 9855.5 9233.8 9632.9 9696.9 9715.9 9730.7 7714.8 7892.3 7912.9 7916.2 7930.4 5483.7 5491.8 5694.1 5739.3 5786.2 8792.2 8819.5 8850.7 8932.9 9012.9 8709.3 8904.4 9017.5 9026.1 9185.8 7178.7 7237.9 7241.8 7303.3 7331.7 7737.3 7739.8 7759.3 7771.7 7794.8 7078.1 7142.1 7157.6 7162.6 7349.6 6999.2 7040.0 7044.0 7060.3 7100.5 6081.8 6147.2 6198.2 6199.9 6204.0 4742.5 4783.1 4810.6 4841.8 4898.3 4712.2 4826.8 4830.2 4906.7 4910.4 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | [#4] prototype.html Cycles:180 Average:4669.63 Median:5322.76 stddev:1351.08 (25.4%) stddev-sans-first:1316.02 11:33:34 INFO - PROCESS | 24881 | Values: 384.1 396.4 399.5 407.2 409.4 5145.3 5240.2 5295.9 5357.0 5371.7 5213.5 5313.8 5314.8 5335.2 5354.0 4262.0 4280.4 4283.3 4294.0 4318.8 3999.3 4184.0 4261.2 4305.6 4323.5 4160.3 4180.7 4183.5 4192.4 4192.7 4137.4 4151.4 4158.5 4160.7 4168.6 3705.0 3711.0 3714.3 3715.3 3715.4 5040.3 5181.4 5185.9 5189.0 5205.5 4734.5 4736.0 4736.9 4738.2 4744.6 5449.4 5504.9 5512.6 5544.6 5544.7 3903.8 3968.2 3999.5 4000.8 4010.8 5704.1 5746.4 5756.7 5776.8 5781.5 4110.9 4111.2 4117.4 4131.6 4185.0 3941.3 4152.7 4187.9 4212.6 4243.0 4717.7 4731.2 4754.4 4755.3 4783.5 5602.8 5617.7 5626.8 5690.8 5701.0 1368.4 1397.0 1409.2 1417.5 1421.9 948.9 968.8 969.5 983.6 987.4 5265.8 5277.4 5284.4 5294.7 5331.7 5560.9 5588.7 5593.0 5625.3 5627.5 5145.5 5167.4 5257.2 5294.4 5330.7 2897.5 2919.7 2941.2 2941.7 2950.0 5862.7 5872.8 5885.7 5916.8 5928.9 5449.3 5609.3 5659.2 5682.7 5708.5 5792.9 5829.8 5884.2 5888.6 5905.7 5210.8 5403.5 5457.0 5476.9 5551.9 5398.3 5427.8 5444.7 5473.5 5509.2 5848.9 5856.2 5860.5 5879.0 5889.2 3932.5 3992.4 4006.4 4018.6 4053.6 5492.6 5499.5 5521.9 5543.2 5579.4 5402.4 5514.2 5568.7 5590.3 5609.5 5558.8 5571.7 5599.3 5610.6 5658.7 5280.6 5472.6 5492.5 5525.3 5547.3 5589.0 5611.5 5622.8 5624.5 5626.3 5423.7 5436.5 5445.2 5504.8 5505.8 11:33:34 INFO - PROCESS | 24881 | 11:33:34 INFO - PROCESS | 24881 | [#5] yui.html Cycles:180 Average:17658.26 Median:4625.64 stddev:22390.81 (484.1%) stddev-sans-first:22417.59 11:33:34 INFO - PROCESS | 24881 | Values: 743.8 752.0 788.0 823.3 848.1 15505.5 16808.9 16863.7 16864.2 16915.4 15289.6 15468.8 15472.8 15480.5 15907.8 818.3 820.4 829.5 832.9 842.2 828.3 831.3 836.9 842.1 842.4 879.0 880.2 880.9 881.0 881.1 860.5 867.9 870.9 872.5 872.7 640.6 641.4 642.5 643.4 643.6 15885.9 16161.1 16241.5 16521.9 16714.8 14749.3 14868.9 14946.8 15169.7 15302.4 12167.6 12328.8 12415.4 12551.2 12570.5 3655.9 3686.8 3706.2 3770.4 3783.8 65986.7 67282.3 67496.3 79438.0 79497.0 11276.3 11479.2 11606.3 11729.1 11894.4 21655.8 21672.1 21748.0 21781.0 21825.0 7880.7 7986.5 8049.4 8181.8 8336.5 4484.4 4532.1 4609.0 4642.3 4648.9 3678.4 3763.3 3793.7 3796.7 3800.9 623.2 633.1 638.4 643.4 654.1 719.3 729.2 743.3 745.6 768.8 9130.0 9792.5 9898.7 10379.6 10500.8 720.9 739.1 752.8 757.5 767.6 4529.4 4796.7 4811.2 4873.2 4883.2 78624.0 78740.0 80290.6 82230.2 83959.6 71166.0 71708.6 72711.0 73104.0 74470.0 61727.4 62202.4 62384.7 65258.7 65394.0 9152.9 9257.2 9496.5 9537.6 9553.1 44403.8 44591.6 44746.8 44753.8 45958.3 51673.0 54023.5 54082.0 54773.5 55214.0 11333.2 11378.6 11731.5 12090.9 12438.2 13695.7 13794.9 13965.9 14616.6 14817.1 11965.2 12181.1 12342.6 12471.0 12706.7 12789.1 12912.6 12941.4 12954.9 13294.7 13414.2 13618.0 13665.6 13694.6 14036.2 10904.7 10945.6 11286.3 11344.8 11548.7 10396.7 11110.4 11841.6 12126.2 12145.9 11:33:34 INFO - PROCESS | 24881 | -------- Summary: end -------- 11:33:34 INFO - PROCESS | 24881 | 11:33:35 INFO - TEST-INFO | 24881: exit 0 11:33:35 INFO - TEST-OK | dromaeo_css | took 1114022ms 11:33:35 INFO - TEST-START | kraken 11:33:35 INFO - operating with platform_type : linux_ 11:33:35 INFO - Initialising browser for kraken test... 11:33:35 INFO - TEST-INFO | started process 25238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ZnP63/profile http://localhost:56219/getInfo.html) 11:33:35 INFO - PROCESS | 25238 | 1483212815547 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 11:33:39 INFO - PROCESS | 25238 | __metrics Screen width/height:1600/1200 11:33:39 INFO - PROCESS | 25238 | colorDepth:24 11:33:39 INFO - PROCESS | 25238 | Browser inner width/height: 1024/697 11:33:39 INFO - PROCESS | 25238 | __metrics 11:33:39 ERROR - PROCESS | 25238 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 11:33:40 INFO - TEST-INFO | 25238: exit 0 11:33:40 INFO - Browser initialized. 11:33:40 INFO - Running cycle 1/1 for kraken test... 11:33:40 INFO - TEST-INFO | started process 25360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ZnP63/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:52 INFO - PROCESS | 25360 | RSS: Main: 154673152 11:33:52 INFO - PROCESS | 25360 | 11:33:55 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56219/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:55 INFO - PROCESS | 25360 | RSS: Main: 161001472 11:33:55 INFO - PROCESS | 25360 | 11:33:58 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56219/tests/kraken/driver.html?testName=audio-dft) 11:33:59 INFO - PROCESS | 25360 | RSS: Main: 160174080 11:33:59 INFO - PROCESS | 25360 | 11:34:02 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56219/tests/kraken/driver.html?testName=audio-fft) 11:34:02 INFO - PROCESS | 25360 | RSS: Main: 156741632 11:34:02 INFO - PROCESS | 25360 | 11:34:04 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56219/tests/kraken/driver.html?testName=audio-oscillator) 11:34:05 INFO - PROCESS | 25360 | RSS: Main: 157859840 11:34:05 INFO - PROCESS | 25360 | 11:34:07 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56219/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:08 INFO - PROCESS | 25360 | RSS: Main: 157585408 11:34:08 INFO - PROCESS | 25360 | 11:34:11 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56219/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:11 INFO - PROCESS | 25360 | RSS: Main: 160931840 11:34:11 INFO - PROCESS | 25360 | 11:34:15 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56219/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:15 INFO - PROCESS | 25360 | RSS: Main: 160481280 11:34:15 INFO - PROCESS | 25360 | 11:34:18 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56219/tests/kraken/driver.html?testName=json-parse-financial) 11:34:19 INFO - PROCESS | 25360 | RSS: Main: 159989760 11:34:19 INFO - PROCESS | 25360 | 11:34:20 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56219/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:21 INFO - PROCESS | 25360 | RSS: Main: 159674368 11:34:21 INFO - PROCESS | 25360 | 11:34:23 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:24 INFO - PROCESS | 25360 | RSS: Main: 160395264 11:34:24 INFO - PROCESS | 25360 | 11:34:26 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:26 INFO - PROCESS | 25360 | RSS: Main: 160575488 11:34:26 INFO - PROCESS | 25360 | 11:34:29 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:30 INFO - PROCESS | 25360 | RSS: Main: 160538624 11:34:30 INFO - PROCESS | 25360 | 11:34:33 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:33 INFO - PROCESS | 25360 | RSS: Main: 160800768 11:34:33 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | Cycle 1(1): loaded http://localhost:56219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56219/tests/kraken/driver.html?testName=ai-astar) 11:34:35 INFO - PROCESS | 25360 | RSS: Main: 162476032 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | __start_tp_report 11:34:35 INFO - PROCESS | 25360 | _x_x_mozilla_page_load 11:34:35 INFO - PROCESS | 25360 | _x_x_mozilla_page_load_details 11:34:35 INFO - PROCESS | 25360 | |i|pagename|runs| 11:34:35 INFO - PROCESS | 25360 | |0;ai-astar;103;113;113;112;113;112;114;112;111;116 11:34:35 INFO - PROCESS | 25360 | |1;audio-beat-detection;145;124;121;168;123;120;121;120;140;120 11:34:35 INFO - PROCESS | 25360 | |2;audio-dft;163;163;164;161;162;165;168;164;161;164 11:34:35 INFO - PROCESS | 25360 | |3;audio-fft;76;77;76;122;76;76;77;76;98;76 11:34:35 INFO - PROCESS | 25360 | |4;audio-oscillator;85;85;113;83;83;82;95;84;83;108 11:34:35 INFO - PROCESS | 25360 | |5;imaging-gaussian-blur;118;118;118;117;117;118;117;117;118;121 11:34:35 INFO - PROCESS | 25360 | |6;imaging-darkroom;148;148;148;149;148;148;149;148;148;147 11:34:35 INFO - PROCESS | 25360 | |7;imaging-desaturate;96;96;97;96;96;96;96;96;97;96 11:34:35 INFO - PROCESS | 25360 | |8;json-parse-financial;56;58;56;56;59;59;59;57;66;58 11:34:35 INFO - PROCESS | 25360 | |9;json-stringify-tinderbox;68;70;71;70;70;69;69;69;71;69 11:34:35 INFO - PROCESS | 25360 | |10;stanford-crypto-aes;82;81;85;84;82;81;91;81;86;81 11:34:35 INFO - PROCESS | 25360 | |11;stanford-crypto-ccm;137;138;131;130;126;138;135;128;172;136 11:34:35 INFO - PROCESS | 25360 | |12;stanford-crypto-pbkdf2;170;168;170;168;170;166;163;166;169;169 11:34:35 INFO - PROCESS | 25360 | |13;stanford-crypto-sha256-iterative;64;64;63;64;62;65;63;62;62;62 11:34:35 INFO - PROCESS | 25360 | __end_tp_report 11:34:35 INFO - PROCESS | 25360 | __start_cc_report 11:34:35 INFO - PROCESS | 25360 | _x_x_mozilla_cycle_collect,710 11:34:35 INFO - PROCESS | 25360 | __end_cc_report 11:34:35 INFO - PROCESS | 25360 | __startTimestamp1483212875613__endTimestamp 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | ------- Summary: start ------- 11:34:35 INFO - PROCESS | 25360 | Number of tests: 14 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.41 (3.0%) stddev-sans-first:1.45 11:34:35 INFO - PROCESS | 25360 | Values: 103.0 113.0 113.0 112.0 113.0 112.0 114.0 112.0 111.0 116.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:123.50 stddev:16.04 (13.0%) stddev-sans-first:16.09 11:34:35 INFO - PROCESS | 25360 | Values: 145.0 124.0 121.0 168.0 123.0 120.0 121.0 120.0 140.0 120.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.07 (1.3%) stddev-sans-first:2.19 11:34:35 INFO - PROCESS | 25360 | Values: 163.0 163.0 164.0 161.0 162.0 165.0 168.0 164.0 161.0 164.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.32 (20.2%) stddev-sans-first:16.04 11:34:35 INFO - PROCESS | 25360 | Values: 76.0 77.0 76.0 122.0 76.0 76.0 77.0 76.0 98.0 76.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.50 stddev:11.43 (13.7%) stddev-sans-first:11.97 11:34:35 INFO - PROCESS | 25360 | Values: 85.0 85.0 113.0 83.0 83.0 82.0 95.0 84.0 83.0 108.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 11:34:35 INFO - PROCESS | 25360 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 121.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:34:35 INFO - PROCESS | 25360 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 149.0 148.0 148.0 147.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:34:35 INFO - PROCESS | 25360 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:2.95 (5.0%) stddev-sans-first:3.00 11:34:35 INFO - PROCESS | 25360 | Values: 56.0 58.0 56.0 56.0 59.0 59.0 59.0 57.0 66.0 58.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 11:34:35 INFO - PROCESS | 25360 | Values: 68.0 70.0 71.0 70.0 70.0 69.0 69.0 69.0 71.0 69.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:3.24 (3.9%) stddev-sans-first:3.40 11:34:35 INFO - PROCESS | 25360 | Values: 82.0 81.0 85.0 84.0 82.0 81.0 91.0 81.0 86.0 81.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:136.50 stddev:12.99 (9.5%) stddev-sans-first:13.78 11:34:35 INFO - PROCESS | 25360 | Values: 137.0 138.0 131.0 130.0 126.0 138.0 135.0 128.0 172.0 136.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:169.00 stddev:2.28 (1.4%) stddev-sans-first:2.29 11:34:35 INFO - PROCESS | 25360 | Values: 170.0 168.0 170.0 168.0 170.0 166.0 163.0 166.0 169.0 169.0 11:34:35 INFO - PROCESS | 25360 | 11:34:35 INFO - PROCESS | 25360 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.10 (1.7%) stddev-sans-first:1.12 11:34:35 INFO - PROCESS | 25360 | Values: 64.0 64.0 63.0 64.0 62.0 65.0 63.0 62.0 62.0 62.0 11:34:35 INFO - PROCESS | 25360 | -------- Summary: end -------- 11:34:35 INFO - PROCESS | 25360 | 11:34:36 INFO - TEST-INFO | 25360: exit 0 11:34:36 INFO - TEST-OK | kraken | took 61548ms 11:34:36 INFO - SUITE-END | took 1175s 11:34:36 INFO - Completed test suite (00:19:35) 11:34:36 INFO - javascript benchmark 11:34:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7118.135495217382, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3190.154609028608, 3192.840357982101, 3194.7444204463645, 3213.919652008698, 3233.886813961511, 5264.710440925747, 5285.867853303665, 5317.867053323664, 5334.5999050071305, 5369.543588794957, 5297.549708274792, 5332.680039197651, 5338.359396872371, 5373.731313434332, 5464.972675136629, 4813.133635945528, 4828.87927801806, 4843.58829499493, 4927.0, 4945.530174633422, 4756.262779269202, 4934.605231581465, 4966.478519755427, 4997.075541024922, 4997.550220480156, 4860.902781944376, 4963.230699241623, 4981.9252711209365, 4983.451820299764, 5095.133827249358, 4830.2513110467935, 4842.2736589511505, 4858.854234372974, 4888.877778055541, 4960.156773348539, 4863.8784030399165, 4867.5132486751045, 4901.558859702608, 4902.0, 4907.141250281186, 5260.500252476008, 5300.178472336794, 5325.760340784674, 5331.573474122061, 5361.839144825662, 5667.4615911488345, 5691.630044047124, 5692.487676109128, 5715.514181294553, 5739.684317362543, 5775.624584402, 5810.4770570648425, 5825.621334613236, 5830.82507524775, 5865.178874957509, 5346.545543628797, 5404.189371594292, 5414.3232095988005, 5418.051840927822, 5421.918671219935, 5812.389699081536, 5818.156367326714, 5841.269841269841, 5853.94146058534, 5945.316288626776, 5623.8594035149445, 5654.886902261932, 5660.518855897295, 5662.85842853932, 5693.971530142323, 5688.687122208318, 5689.573282003867, 5717.399673034354, 5745.052066409079, 5748.223989761329, 5623.718814059281, 5669.914951275734, 5692.658440493584, 5711.857203569944, 5714.028615135437, 5730.484256416942, 5750.683712395775, 5762.74067666956, 5773.336066352339, 5811.0, 4302.9569704303185, 4319.222539942841, 4324.891877703019, 4326.6754993375625, 4354.368616550582, 3794.962050379516, 3811.0472381904524, 3813.56144043433, 3853.4412510185866, 3881.573026967031, 5518.089515230023, 5519.254900588449, 5534.916976245359, 5584.52531534816, 5590.636608620427, 5775.971120144372, 5780.046292361713, 5812.041013232769, 5824.301083869963, 5833.095870140135, 5406.351237851483, 5438.211459338374, 5493.313335833021, 5578.2748242728185, 5580.832575022756, 4741.0754902794315, 4786.521347865255, 4808.759562021885, 4824.710517368899, 4833.637477189225, 6058.878822423439, 6097.115918191926, 6099.634021958696, 6100.206973093469, 6100.511959043266, 5602.187682786055, 5613.438656134354, 5811.360750317377, 5826.475617194473, 5834.591578589458, 6057.909131363122, 6063.909041364295, 6106.816795496142, 6130.459285710702, 6142.652254521207, 5676.7445464955, 5702.37273899879, 5714.085746280575, 5716.942830571641, 5749.9712501437225, 5595.944040559542, 5783.219265399117, 5806.65160090396, 5807.709614519342, 5829.183914252093, 5495.477929596682, 5529.060059789765, 5551.333839939233, 5599.216109744558, 5655.349634792052, 5582.134769110794, 5595.972020139873, 5607.831765047055, 5609.719514024364, 5613.803516876889, 5436.103042998019, 5477.1510415885605, 5556.944430555643, 5589.776408943597, 5613.747381367766, 5583.218349431002, 5585.581081418991, 5607.831765047055, 5622.803201887914, 5687.914681279867, 5388.595855310789, 5422.918656220081, 5428.538574221077, 5429.321334833146, 5430.70131142791], "value": 5300.711251054255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.8488423241492, 550.5072959701071, 551.5973339462195, 577.1314172170884, 578.6730497269043, 40372.1925561489, 43049.13901721968, 43166.0, 46618.7669061655, 46982.0, 44605.0, 44634.0, 45026.0, 45234.773826130906, 45293.77353113238, 8717.21545060946, 8951.23914467271, 8972.205558888216, 8978.28173746102, 10050.648227312045, 10081.848772268422, 10385.2211084169, 10421.947890260539, 10422.478876056204, 10425.478726063704, 10411.06300432961, 10468.476576171199, 10487.423191724452, 10503.894961050368, 10505.474726263694, 10337.534810933526, 10357.63748268807, 10375.688729338095, 10392.480375981246, 10408.271421000532, 10156.695299141038, 10202.948985255027, 10241.84637230442, 10242.385456872536, 10260.640877569249, 38770.80614596909, 39134.21731565381, 39284.21431571381, 39302.410463843065, 39326.80336598327, 4034.213328400963, 4052.797360131982, 4132.876013719593, 4170.914542728636, 4197.076643138505, 29559.852200739075, 29592.0, 29862.402751945057, 30001.0, 30128.342941138228, 4222.387753775685, 4345.826166953318, 4367.847125350598, 4374.650027997753, 4419.0940857124215, 335523.0, 336061.99999999756, 336181.0, 337125.0, 338330.0, 52215.47784522182, 52619.210711839354, 52713.0, 52779.0, 52838.47161528412, 55426.0, 55742.72128639412, 55848.72075639596, 55916.0, 56192.0, 15538.844611553966, 16072.357105715875, 16197.109158996132, 16215.189240537926, 16220.270087846075, 11903.869132432405, 12187.268763874195, 12470.127091103717, 12521.874781252252, 12804.295763733084, 17415.47753567395, 17446.302147913942, 17595.64808703819, 17650.205740741698, 17684.64630707379, 6606.570572912745, 6805.591664500146, 6852.177738671391, 6853.965730171317, 6879.140107486564, 880.2561835249204, 902.4900930973979, 916.7845556294266, 917.8256131335025, 947.6351604632266, 29287.9056194349, 29436.705632943824, 30248.69751302459, 30367.848160759495, 30697.0, 1002.4787110702393, 1077.235163034239, 1082.2099867097063, 1097.7639807441278, 1126.2735535579504, 15105.39578416873, 15158.740870712849, 15793.447229347148, 15930.681386372207, 16166.919165404097, 506235.0, 508657.0, 513861.0, 514352.0, 514523.0, 53422.46577534253, 53607.0, 53651.73174134104, 53963.19055214175, 54001.45998540043, 1401.4464286606733, 1406.6975600245792, 1410.132768347459, 1422.957311280684, 1431.3487363249697, 28010.85994570014, 28312.71687283101, 28473.0, 29068.854655726587, 29654.406911862072, 46206.537934620224, 48021.27968080412, 49476.0, 49594.752026239636, 54588.72705636605, 453465.0, 454113.0, 458054.0, 458586.0, 458950.0, 25499.87250063738, 25712.485750285265, 25881.611775823, 27237.72762272352, 38171.42742858804, 41346.79326603348, 41637.37543936904, 42275.7886210567, 42391.36412953746, 42736.57263427326, 35247.0, 35665.0, 35720.464193036605, 35951.0, 36157.27685446329, 35191.29617407689, 35527.28945421025, 35798.46302305415, 35893.82053089718, 36056.27887442184, 34941.301173976884, 35747.82126089353, 35777.82111089428, 36099.63900360963, 36687.08282292964, 30432.695673042985, 32867.0, 33054.0, 33075.83462082674, 33182.170445738084, 24399.39001524976, 24738.0, 24911.252662420156, 25184.74815251824, 32457.35085298328], "value": 19569.11044203559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.63840032768707, 384.84798504590685, 387.4227401172254, 395.80209895052474, 407.5394803871625, 17067.91466042671, 17818.287268509277, 18103.275868965244, 18428.723569146474, 18429.07854607271, 18735.718964215546, 18769.343072992448, 19282.0, 19375.51561210967, 19378.12798424071, 5536.169574563827, 5538.47384498473, 5626.2967129108865, 5648.322201335845, 5749.05140651794, 5495.505404513593, 5586.301712285965, 5638.351589567191, 5647.661140331573, 5649.830505084854, 5427.240186373911, 5541.6674999499955, 5595.160725891128, 5611.466910643482, 5639.971800140994, 5611.7474713637985, 5624.3813180550105, 5657.405972372882, 5663.207150998843, 5679.4036626154075, 5006.599472042228, 5013.498650134958, 5024.120778863721, 5057.8229761958155, 5073.0, 22113.55772884533, 22140.55718885613, 22244.221452249254, 22294.21970231034, 22395.888020559956, 3080.183751305883, 3119.3293441909873, 3150.8109513429267, 3159.0522843146964, 3206.294615184679, 13890.58328250154, 14295.928520357436, 14354.64113397163, 14462.204578748164, 14513.637159071002, 1868.4207895552286, 1925.4704956137034, 1934.520092129522, 1938.6413513500047, 1950.2589016173904, 74602.25397746007, 74899.62550187268, 75032.62483687601, 75113.62443187804, 76701.23298767052, 9877.40735555869, 10047.346922450017, 10138.746531336776, 10316.0, 10317.174626029899, 13888.375023123983, 13985.79021314681, 14021.579352619437, 14081.85918140826, 14092.154470731788, 7408.518446301081, 7758.534487930742, 7767.990161278997, 7882.330001949784, 7986.161453047463, 7359.632018399058, 7380.594067326241, 7610.8097297568, 7628.732994345171, 7673.3477654398885, 6233.407826256498, 6398.328175541595, 6454.322296158835, 6489.448396886318, 6523.217213934358, 1852.4164888060218, 1858.9721154182428, 1876.6715824730618, 1880.8213219744102, 1901.8763780354232, 849.4987957105337, 876.513534988075, 878.7846977490556, 884.3058199313637, 896.878921345623, 17438.825611743974, 17553.56116097108, 17719.0, 19461.22155113808, 19612.0, 954.4368822394681, 955.9044095590524, 958.3579002068631, 961.5336561767538, 965.0928127560071, 9633.662821801203, 9925.751856203507, 10011.899881001242, 10051.597936082475, 10235.641752538626, 440539.0, 446788.0, 448773.0, 455301.0, 462212.0, 86753.56623216844, 87696.0, 88992.0, 89497.55251223702, 89600.5519972396, 1059.6979860739807, 1080.1574771678104, 1099.3898386395626, 1102.691246450995, 1113.4544073403974, 15290.847091529387, 15733.685326293182, 15992.12043337581, 16046.277917493508, 16343.264553094901, 40777.18445631011, 40862.0, 41465.1706965865, 41918.790406049, 42078.579214208694, 49760.502394975585, 54385.184222235905, 55017.72491137519, 55158.72420637871, 55785.721071394386, 8289.502629842229, 8470.110638382881, 8475.788105297417, 8665.0, 8666.436681615674, 12570.748585028065, 13216.140950838164, 13246.933765331112, 13259.138156019828, 13513.594592162252, 10711.678649640524, 10774.515146818569, 11099.334039957628, 11241.100711943189, 11592.072634189413, 11317.886821132013, 11323.15076369259, 11451.713707157387, 11536.077113831041, 11780.646580602595, 11554.364509952033, 11713.648590542298, 11766.647000589996, 11797.174197806415, 12167.0, 8254.628541715518, 8338.207870252316, 8540.40217184791, 8553.101924297858, 8571.0, 8512.574371281287, 11682.76634467289, 11823.290602563873, 11941.925226729636, 11950.223235489666], "value": 9123.705918407306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.255202190817, 1382.903196776226, 1387.0568013750647, 1389.9722005559895, 1392.1716578635712, 7789.766307010792, 8149.91850081499, 8230.958845205772, 8232.54720990346, 8339.457935234206, 8260.380471464634, 8446.28206602438, 8504.829903401927, 8506.064332923374, 8527.957360213206, 2311.560803447344, 2343.718753749544, 2350.647402889563, 2357.8585284882874, 2364.5507353602848, 2333.428310064037, 2345.683332750074, 2387.940301492459, 2398.0887262840097, 2404.95190096198, 2346.038124369009, 2375.845570037942, 2378.9286321410386, 2381.2380038387723, 2385.940351491218, 2272.784085511874, 2289.9656505152434, 2296.8047715944167, 2298.4943312471146, 2298.7356454007668, 2261.185973049701, 2325.9767402326097, 2344.788968992782, 2348.8120950323932, 2349.2599831053335, 8020.3984701147065, 8194.959025204895, 8205.138460461625, 8209.876851847168, 8213.466124701876, 5088.618353623493, 5230.790768369261, 5246.291750613656, 5255.86860328491, 5257.842264732064, 3352.8826491072696, 3502.842372093262, 3547.450145227494, 3607.3867442534834, 3612.259486805199, 1314.7567699975439, 1420.9076410033315, 1441.9206943618096, 1478.1943840606896, 1517.3172072567388, 10803.081738052275, 10864.565417383295, 10971.890281097167, 10999.560017599286, 11025.283356581876, 4290.249206388869, 4443.777811109431, 4463.152001119777, 4476.6418686505, 4570.4743954445, 8792.516411597424, 8810.735677929544, 8812.691555795516, 8859.202671759573, 8865.379423440427, 5166.6125040621355, 5190.11767999441, 5219.921701174486, 5225.608079394061, 5227.529522343008, 4803.519648035239, 4807.110684523374, 4831.565159135695, 4895.094407534618, 4897.681650692693, 3491.860325586999, 3547.2373439710586, 3589.7307701921936, 3626.2384899170943, 3630.183208778004, 1072.1155047086029, 1092.8688557373166, 1162.1458228202264, 1231.8891299782883, 1232.5377983256278, 922.082527884759, 930.283681565191, 942.0, 942.3874481586886, 963.9566219520138, 5236.345456817898, 5246.868828279324, 5312.5218730314455, 5404.054290499147, 5660.349059858087, 928.7028150991617, 929.5259417697023, 932.1191474057086, 944.7024187380953, 954.4798085043668, 3652.7443078984215, 3692.1877187018813, 3698.9445158322646, 3787.3372159872465, 3848.730588858753, 9454.621815127455, 9729.1243788058, 9814.312998090065, 9837.311388202757, 9855.45794981283, 9233.815323693489, 9632.9036709632, 9696.854547181798, 9715.854262186072, 9730.659426920023, 7714.845703085907, 7892.289693927574, 7912.881306780403, 7916.247956444128, 7930.405219608552, 5483.670979741229, 5491.75287112073, 5694.060480020916, 5739.282589676291, 5786.189933409242, 8792.208701216921, 8819.514926679094, 8850.734477965414, 8932.910670893209, 9012.909870901207, 8709.259712924473, 8904.376693631384, 9017.549122543978, 9026.097390260922, 9185.770355740893, 7178.712851485882, 7237.8914316284245, 7241.782746517613, 7303.269673032654, 7331.74338898136, 7737.342325902361, 7739.7678069658, 7759.262870027338, 7771.650275737718, 7794.805129871798, 7078.115235595551, 7142.142942846892, 7157.57054576727, 7162.64186790648, 7349.595772232365, 6999.160100787938, 7040.049593304839, 7044.0, 7060.293970602898, 7100.538464999759, 6081.817545473643, 6147.231596050494, 6198.194234749454, 6199.861047938454, 6203.96898015507, 4742.502037286035, 4783.115123702126, 4810.6151507878585, 4841.830535931225, 4898.338724272177, 4712.151812673752, 4826.758662066813, 4830.203016502238, 4906.681065730716, 4910.386201724785], "value": 4408.27420224995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1414438729439, 396.44497703215495, 399.45873341622104, 407.22830236701435, 409.3573090248308, 5145.3053837731895, 5240.187770895508, 5295.928361550301, 5357.0, 5371.677699338043, 5213.452587478317, 5313.840584782462, 5314.787408503656, 5335.226392173142, 5353.973230133844, 4262.019735460831, 4280.357946308048, 4283.293256612671, 4293.957060429387, 4318.805653745573, 3999.2601368746873, 4183.979080104596, 4261.2329780639475, 4305.5909688579695, 4323.5460276670965, 4160.292750232453, 4180.686448516373, 4183.456150700405, 4192.371144328345, 4192.706510544263, 4137.441445404877, 4151.398047283127, 4158.459400277945, 4160.667146628278, 4168.6039826216465, 3704.9629503705155, 3711.0, 3714.331420344337, 3715.3312403767313, 3715.3620929140343, 5040.31955685985, 5181.35233095863, 5185.896282074337, 5188.974055129738, 5205.453427390107, 4734.455537613184, 4735.952640473585, 4736.881577960578, 4738.218193998021, 4744.6441516886025, 5449.354642283137, 5504.889902201933, 5512.586556008276, 5544.63959842613, 5544.695041772701, 3903.7852918089493, 3968.1666849961543, 3999.460072890181, 4000.7799571023584, 4010.83956641734, 5704.12119758564, 5746.396628354046, 5756.7121643917635, 5776.768929242825, 5781.508571771363, 4110.938335924963, 4111.239420707178, 4117.444145040441, 4131.586841315844, 4185.016521117535, 3941.2708648900043, 4152.688548358885, 4187.91624167515, 4212.578742125825, 4242.957570424318, 4717.669763116617, 4731.195696731495, 4754.381930349033, 4755.286706993978, 4783.521647835189, 5602.803901863415, 5617.719114044281, 5626.831195064073, 5690.788816275926, 5701.0, 1368.3637108744283, 1396.9930150349182, 1409.2178840743281, 1417.5038736442368, 1421.9075760075561, 948.8671585977969, 968.8449848024283, 969.471637957315, 983.5967253426061, 987.3976874106789, 5265.815696450606, 5277.445868183862, 5284.365876094893, 5294.735263236823, 5331.733413329318, 5560.916586251209, 5588.714595642944, 5592.993261213021, 5625.324961004706, 5627.52166065889, 5145.536901678867, 5167.431582525919, 5257.185136303879, 5294.444083371268, 5330.733463326896, 2897.5363941769215, 2919.656957799436, 2941.249981254766, 2941.676415594283, 2949.9557506637416, 5862.736176872051, 5872.823815285548, 5885.705714714333, 5916.816636672683, 5928.8814223716145, 5449.3460784706085, 5609.298837645294, 5659.207710920475, 5682.659040457503, 5708.514776243983, 5792.913106303409, 5829.849508768206, 5884.176215329857, 5888.646681199056, 5905.675187864536, 5210.765515551885, 5403.540699040468, 5456.980917060713, 5476.945230547643, 5551.945780061403, 5398.325209348832, 5427.83716488506, 5444.713220447343, 5473.507384335429, 5509.228707980966, 5848.853778655568, 5856.209411729533, 5860.534866283429, 5879.0, 5889.204957330706, 3932.5280966283085, 3992.4011398289326, 4006.419069235003, 4018.598140185958, 4053.574374690615, 5492.5605951524585, 5499.535292765532, 5521.923224971092, 5543.1962365455975, 5579.4420557945505, 5402.405735369185, 5514.228008078792, 5568.654092071657, 5590.329160500766, 5609.467100625434, 5558.833235002957, 5571.66570005801, 5599.32808063035, 5610.551155907436, 5658.745356459051, 5280.603954703336, 5472.5621950243085, 5492.47821456961, 5525.281713377396, 5547.278853748987, 5588.960029589252, 5611.466910643482, 5622.7750889963945, 5624.493795558419, 5626.2967129108865, 5423.701696406735, 5436.510714035756, 5445.156000819879, 5504.834854954358, 5505.834824955257], "value": 4256.9391593887085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.8400743840074, 751.9661615227315, 787.9559583551792, 823.2878560045561, 848.1137211613865, 15505.534833954986, 16808.91595542022, 16863.747043794352, 16864.156792160375, 16915.40796072138, 15289.617759556017, 15468.839837012241, 15472.845271547281, 15480.458183963563, 15907.761383579227, 818.2553875972851, 820.4379999700195, 829.4525613095358, 832.8625776746829, 842.1620487614832, 828.3042244514606, 831.3349320543571, 836.8661014237723, 842.1157784326433, 842.4145219072747, 879.0286733159862, 880.216607219575, 880.8590625499921, 881.0176653031855, 881.1496905486205, 860.5396113079472, 867.8784970104191, 870.9346798990101, 872.520113937332, 872.672747719602, 640.5548144039894, 641.4066988036095, 642.4988508963016, 643.3502162815544, 643.5688088980395, 15885.92057039719, 16161.111138887356, 16241.51275461738, 16521.91739041297, 16714.83285167145, 14749.262536873113, 14868.925655371762, 14946.775798363033, 15169.696606067928, 15302.387904483807, 12167.574134905324, 12328.815067773901, 12415.44130514129, 12551.184173028816, 12570.497180112785, 3655.926881462356, 3686.760360576554, 3706.22169344438, 3770.359038963383, 3783.829727662262, 65986.67006664936, 67282.3271767281, 67496.32503674999, 79438.0, 79497.0, 11276.267042642203, 11479.19645624815, 11606.303621782552, 11729.120315976164, 11894.405279735978, 21655.783442165375, 21672.13311467555, 21748.0, 21781.0, 21825.0, 7880.684772609146, 7986.480878742863, 8049.356051515864, 8181.836363272821, 8336.541490217975, 4484.417025786627, 4532.138893610269, 4608.953910460919, 4642.326862604903, 4648.907021859543, 3678.4114541673202, 3763.303788799081, 3793.6585707286476, 3796.6583007529457, 3800.8669696560487, 623.2085251730277, 633.072548716133, 638.4030931079456, 643.3566433566433, 654.0908137688616, 719.2663483247059, 729.1614643160408, 743.3198623259765, 745.5563939456015, 768.7655265144073, 9129.95435022834, 9792.461414622265, 9898.65354712596, 10379.63671271517, 10500.789984200273, 720.8853186640775, 739.0872272743158, 752.7553545097865, 757.4849102610278, 767.5739964319856, 4529.388532548064, 4796.688215265996, 4811.182099043171, 4873.244647079709, 4883.243097319921, 78624.0, 78740.0, 80290.59854700688, 82230.17769822344, 83959.5802020986, 71166.0, 71708.64145679238, 72711.0, 73104.0, 74470.0, 61727.38272617306, 62202.37797622057, 62384.68807655932, 65258.673706632115, 65394.0, 9152.862707059267, 9257.21313688317, 9496.525173741147, 9537.618495260389, 9553.092456216647, 44403.77798110989, 44591.55408445874, 44746.77626611846, 44753.77623111864, 45958.31062534131, 51673.0, 54023.45976540184, 54082.0, 54773.45226547684, 55214.0, 11333.206675532634, 11378.601748938747, 11731.530738770354, 12090.939545302217, 12438.19151755133, 13695.726085478434, 13794.93102534481, 13965.860341396456, 14616.634584135481, 14817.110973341634, 11965.184251530922, 12181.086418518824, 12342.568010119603, 12471.0, 12706.745865082461, 12789.104762666524, 12912.612621621367, 12941.417636206204, 12954.870451295366, 13294.734105318033, 13414.195148291134, 13618.0, 13665.590032299047, 13694.589162325146, 14036.228007459687, 10904.727381815517, 10945.616903408343, 11286.322820630789, 11344.773104538028, 11548.660700984292, 10396.688099357032, 11110.388928609003, 11841.644750657493, 12126.211796233216, 12145.878541214828], "value": 7323.344608325608, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 112.0, 113.0, 112.0, 114.0, 112.0, 111.0, 116.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 121.0, 168.0, 123.0, 120.0, 121.0, 120.0, 140.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 161.0, 162.0, 165.0, 168.0, 164.0, 161.0, 164.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 122.0, 76.0, 76.0, 77.0, 76.0, 98.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 83.0, 83.0, 82.0, 95.0, 84.0, 83.0, 108.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 121.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 56.0, 59.0, 59.0, 59.0, 57.0, 66.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 70.0, 70.0, 69.0, 69.0, 69.0, 71.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 85.0, 84.0, 82.0, 81.0, 91.0, 81.0, 86.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 131.0, 130.0, 126.0, 138.0, 135.0, 128.0, 172.0, 136.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 170.0, 168.0, 170.0, 166.0, 163.0, 166.0, 169.0, 169.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 62.0, 65.0, 63.0, 62.0, 62.0, 62.0], "value": 63.1, "unit": "score"}]}]} 11:34:36 INFO - Return code: 0 11:34:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:34:36 ERROR - # TBPL SUCCESS # 11:34:36 INFO - Running post-action listener: _resource_record_post_action 11:34:36 INFO - [mozharness: 2016-12-31 19:34:36.944147Z] Finished run-tests step (success) 11:34:36 INFO - Running post-run listener: _resource_record_post_run 11:34:37 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401018880; Read time: 12; Write time: 318280 11:34:37 INFO - TinderboxPrint: CPU usage
13.4% 11:34:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:34:37 INFO - TinderboxPrint: I/O write bytes / time
401,018,880 / 318,280 11:34:37 INFO - TinderboxPrint: CPU idle
8,239.3 (86.6%) 11:34:37 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 11:34:37 INFO - TinderboxPrint: Swap in / out
0 / 0 11:34:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105385984; Read time: 0; Write time: 74716 11:34:37 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295632896; Read time: 0; Write time: 243564 11:34:37 INFO - Running post-run listener: _upload_blobber_files 11:34:37 INFO - Blob upload gear active. 11:34:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:34:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:41 INFO - (blobuploader) - INFO - Done attempting. 11:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:41 INFO - (blobuploader) - INFO - Done attempting. 11:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:42 INFO - (blobuploader) - INFO - Done attempting. 11:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:43 INFO - (blobuploader) - INFO - Done attempting. 11:34:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:43 INFO - Return code: 0 11:34:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/271ce6cfeba9eaaab35c8ad30e436fb1dd170fd560a472a604b717ca929081c2fde2cf97b0b06fa80f6cf2206ea343b8b0a1e8e6858fde7ae73cb69dffd21603", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f766d6fbb89734ac8f77db560bd79ac6363c1245eac8f39c65de263142996447ee33494037b95227f9eabed5aad76e2f2d4dc386004baa40b174217f8e43d5f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e06df88e9bfe81fd394a80d29f6a5c7a17a867b6efd160290a5d890f40401307aa5a17f20b22be426a6fadc0fe50e11f4a7bf6deb476256618c3bf7ac3a5dac4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978f4f2f1ba5f208a57c488b36b00b504e1a3b98e00a4eefca7ec95a3d4dd94f28b4a9ef112ef85f55f105ab5a7f84ac38d6b4765e87565c18341c87af398de5"} 11:34:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:43 INFO - Contents: 11:34:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/271ce6cfeba9eaaab35c8ad30e436fb1dd170fd560a472a604b717ca929081c2fde2cf97b0b06fa80f6cf2206ea343b8b0a1e8e6858fde7ae73cb69dffd21603", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f766d6fbb89734ac8f77db560bd79ac6363c1245eac8f39c65de263142996447ee33494037b95227f9eabed5aad76e2f2d4dc386004baa40b174217f8e43d5f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e06df88e9bfe81fd394a80d29f6a5c7a17a867b6efd160290a5d890f40401307aa5a17f20b22be426a6fadc0fe50e11f4a7bf6deb476256618c3bf7ac3a5dac4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978f4f2f1ba5f208a57c488b36b00b504e1a3b98e00a4eefca7ec95a3d4dd94f28b4a9ef112ef85f55f105ab5a7f84ac38d6b4765e87565c18341c87af398de5"} 11:34:43 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:43 INFO - Copying logs to upload dir... 11:34:43 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.224099 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-12-31 11:34:43.401085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:43.404374) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/271ce6cfeba9eaaab35c8ad30e436fb1dd170fd560a472a604b717ca929081c2fde2cf97b0b06fa80f6cf2206ea343b8b0a1e8e6858fde7ae73cb69dffd21603", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f766d6fbb89734ac8f77db560bd79ac6363c1245eac8f39c65de263142996447ee33494037b95227f9eabed5aad76e2f2d4dc386004baa40b174217f8e43d5f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e06df88e9bfe81fd394a80d29f6a5c7a17a867b6efd160290a5d890f40401307aa5a17f20b22be426a6fadc0fe50e11f4a7bf6deb476256618c3bf7ac3a5dac4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978f4f2f1ba5f208a57c488b36b00b504e1a3b98e00a4eefca7ec95a3d4dd94f28b4a9ef112ef85f55f105ab5a7f84ac38d6b4765e87565c18341c87af398de5"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/271ce6cfeba9eaaab35c8ad30e436fb1dd170fd560a472a604b717ca929081c2fde2cf97b0b06fa80f6cf2206ea343b8b0a1e8e6858fde7ae73cb69dffd21603", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f766d6fbb89734ac8f77db560bd79ac6363c1245eac8f39c65de263142996447ee33494037b95227f9eabed5aad76e2f2d4dc386004baa40b174217f8e43d5f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e06df88e9bfe81fd394a80d29f6a5c7a17a867b6efd160290a5d890f40401307aa5a17f20b22be426a6fadc0fe50e11f4a7bf6deb476256618c3bf7ac3a5dac4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978f4f2f1ba5f208a57c488b36b00b504e1a3b98e00a4eefca7ec95a3d4dd94f28b4a9ef112ef85f55f105ab5a7f84ac38d6b4765e87565c18341c87af398de5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:43.429189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:43.429473) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1483208940.677654-375457889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:43.519598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 11:34:43.519875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 11:34:43.520150) ========= ========= Total master_lag: 0.17 =========