builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1483991341.48 results: success (0) buildid: 20170109112414 builduid: 7c8d54542bd641a2a3b236876c0d744a revision: dd6d4ca2066803fae7dc99fb872d7191a6421478 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.477175) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.477581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.477851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.496027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.496334) ========= 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=db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 11:49: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-01-09 11:49:01 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.595938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.599318) ========= 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=db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.648950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:01.652350) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dd6d4ca2066803fae7dc99fb872d7191a6421478 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dd6d4ca2066803fae7dc99fb872d7191a6421478 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 11:49:01,745 truncating revision to first 12 chars 2017-01-09 11:49:01,745 Setting DEBUG logging. 2017-01-09 11:49:01,745 attempt 1/10 2017-01-09 11:49:01,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dd6d4ca20668?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 11:49:02,335 unpacking tar archive at: mozilla-inbound-dd6d4ca20668/testing/mozharness/ program finished with exit code 0 elapsedTime=0.902492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:02.567983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:02.568312) ========= script_repo_revision: dd6d4ca2066803fae7dc99fb872d7191a6421478 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:02.568683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:02.568941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 11:49:02.578582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-09 11:49:02.579092) ========= /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=db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:02 INFO - MultiFileLogger online at 20170109 11:49:02 in /builds/slave/test 11:49: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:49:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:02 INFO - {'append_to_log': False, 11:49:02 INFO - 'base_work_dir': '/builds/slave/test', 11:49:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:49:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:02 INFO - 'branch': 'Mozilla-Inbound', 11:49:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:02 INFO - 'config_files': ('talos/linux_config.py',), 11:49:02 INFO - 'default_actions': ('clobber', 11:49:02 INFO - 'read-buildbot-config', 11:49:02 INFO - 'download-and-extract', 11:49:02 INFO - 'populate-webroot', 11:49:02 INFO - 'create-virtualenv', 11:49:02 INFO - 'install', 11:49:02 INFO - 'run-tests'), 11:49:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:02 INFO - 'download_minidump_stackwalk': True, 11:49:02 INFO - 'download_symbols': 'ondemand', 11:49:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:02 INFO - 'installer_path': 'installer.exe', 11:49:02 INFO - 'log_level': 'info', 11:49:02 INFO - 'log_name': 'talos', 11:49:02 INFO - 'log_to_console': True, 11:49:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:02 INFO - 'opt_config_files': (), 11:49:02 INFO - 'pip_index': False, 11:49:02 INFO - 'sps_profile': False, 11:49:02 INFO - 'sps_profile_interval': 0, 11:49:02 INFO - 'suite': 'dromaeojs-e10s', 11:49:02 INFO - 'system_bits': '32', 11:49:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:02 INFO - 'title': 'talos-linux64-ix-049', 11:49:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:02 INFO - 'use_talos_json': True, 11:49:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:02 INFO - 'work_dir': 'build'} 11:49:02 INFO - [mozharness: 2017-01-09 19:49:02.777860Z] Running clobber step. 11:49:02 INFO - Running pre-action listener: _resource_record_pre_action 11:49:02 INFO - Running main action method: clobber 11:49:02 INFO - rmtree: /builds/slave/test/build 11:49:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:03 INFO - Running post-action listener: _resource_record_post_action 11:49:03 INFO - [mozharness: 2017-01-09 19:49:03.764584Z] Finished clobber step (success) 11:49:03 INFO - [mozharness: 2017-01-09 19:49:03.764683Z] Running read-buildbot-config step. 11:49:03 INFO - Running pre-action listener: _resource_record_pre_action 11:49:03 INFO - Running main action method: read_buildbot_config 11:49:03 INFO - Using buildbot properties: 11:49:03 INFO - { 11:49:03 INFO - "project": "", 11:49:03 INFO - "product": "firefox", 11:49:03 INFO - "script_repo_revision": "production", 11:49:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:49:03 INFO - "repository": "", 11:49:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:49:03 INFO - "buildid": "20170109112414", 11:49:03 INFO - "stage_platform": "linux64-pgo", 11:49:03 INFO - "basedir": "/builds/slave/test", 11:49:03 INFO - "buildnumber": 1908, 11:49:03 INFO - "platform": "ubuntu64_hw", 11:49:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:49:03 INFO - "slavebuilddir": "test", 11:49:03 INFO - "branch": "mozilla-inbound", 11:49:03 INFO - "revision": "dd6d4ca2066803fae7dc99fb872d7191a6421478", 11:49:03 INFO - "slavename": "talos-linux64-ix-049", 11:49:03 INFO - "builduid": "7c8d54542bd641a2a3b236876c0d744a", 11:49:03 INFO - "repo_path": "integration/mozilla-inbound" 11:49:03 INFO - } 11:49:03 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:49:03 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:49:03 INFO - Running post-action listener: _resource_record_post_action 11:49:03 INFO - [mozharness: 2017-01-09 19:49:03.767023Z] Finished read-buildbot-config step (success) 11:49:03 INFO - [mozharness: 2017-01-09 19:49:03.767123Z] Running download-and-extract step. 11:49:03 INFO - Running pre-action listener: _resource_record_pre_action 11:49:03 INFO - Running main action method: download_and_extract 11:49:03 INFO - mkdir: /builds/slave/test/build/tests 11:49: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:49:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:49:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:49:03 INFO - Downloaded 1361 bytes. 11:49:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:49:03 INFO - Using the following test package requirements: 11:49:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:49:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:49:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'jsshell-linux-x86_64.zip'], 11:49:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:49:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:49:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:49:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:49:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:49:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:49: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/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:49: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/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:03 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:49:04 INFO - Expected file size: 21842125 11:49:04 INFO - Obtained file size: 21842125 11:49:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:49:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:49:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:08 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:49:08 INFO - Expected file size: 21842125 11:49:08 INFO - Obtained file size: 21842125 11:49: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/1483983610/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:49: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/1483983610/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:49:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:49:13 INFO - Expected file size: 14403537 11:49:13 INFO - Obtained file size: 14403537 11:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:13 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:13 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:49:13 INFO - Downloaded 61456530 bytes. 11:49:13 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:13 INFO - mkdir: /builds/slave/test/properties 11:49:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:13 INFO - Contents: 11:49:13 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:49:14 INFO - Running post-action listener: _resource_record_post_action 11:49:14 INFO - Running post-action listener: set_extra_try_arguments 11:49:14 INFO - [mozharness: 2017-01-09 19:49:14.237818Z] Finished download-and-extract step (success) 11:49:14 INFO - [mozharness: 2017-01-09 19:49:14.238046Z] Running populate-webroot step. 11:49:14 INFO - Running pre-action listener: _resource_record_pre_action 11:49:14 INFO - Running main action method: populate_webroot 11:49:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:14 INFO - '--tppagecycles', 11:49:14 INFO - '7'], 11:49:14 INFO - 'tests': ['tsvgm']}}, 11:49:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['damp', 'tps']}, 11:49:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'tests': ['damp', 'tps']}, 11:49:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['dromaeo_dom']}, 11:49:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['basic_compositor_video']}, 11:49:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['a11yr', 11:49:14 INFO - 'ts_paint', 11:49:14 INFO - 'tpaint', 11:49:14 INFO - 'sessionrestore', 11:49:14 INFO - 'sessionrestore_no_auto_restore', 11:49:14 INFO - 'tabpaint']}, 11:49:14 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:14 INFO - 'ts_paint', 11:49:14 INFO - 'tpaint', 11:49:14 INFO - 'sessionrestore', 11:49:14 INFO - 'sessionrestore_no_auto_restore', 11:49:14 INFO - 'tabpaint']}, 11:49:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:14 INFO - 'ts_paint', 11:49:14 INFO - 'tpaint', 11:49:14 INFO - 'sessionrestore', 11:49:14 INFO - 'sessionrestore_no_auto_restore', 11:49:14 INFO - 'tabpaint']}, 11:49:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:14 INFO - 'ts_paint', 11:49:14 INFO - 'tpaint', 11:49:14 INFO - 'sessionrestore', 11:49:14 INFO - 'sessionrestore_no_auto_restore', 11:49:14 INFO - 'tabpaint']}, 11:49:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['a11yr', 11:49:14 INFO - 'ts_paint', 11:49:14 INFO - 'tpaint', 11:49:14 INFO - 'sessionrestore', 11:49:14 INFO - 'sessionrestore_no_auto_restore', 11:49:14 INFO - 'tabpaint']}, 11:49:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['a11yr', 11:49:14 INFO - 'ts_paint', 11:49:14 INFO - 'tpaint', 11:49:14 INFO - 'sessionrestore', 11:49:14 INFO - 'sessionrestore_no_auto_restore', 11:49:14 INFO - 'tabpaint']}, 11:49:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['tsvgx', 11:49:14 INFO - 'tsvgr_opacity', 11:49:14 INFO - 'tart', 11:49:14 INFO - 'tscrollx', 11:49:14 INFO - 'cart', 11:49:14 INFO - 'tsvg_static']}, 11:49:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:14 INFO - 'tsvgr_opacity', 11:49:14 INFO - 'tart', 11:49:14 INFO - 'tscrollx', 11:49:14 INFO - 'cart', 11:49:14 INFO - 'tsvg_static']}, 11:49:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'talos_options': ['--disable-e10s'], 11:49:14 INFO - 'tests': ['tp5o']}, 11:49:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:49:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'talos_options': ['--disable-e10s', 11:49:14 INFO - '--xperf_path', 11:49:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:14 INFO - 'tests': ['tp5n']}, 11:49:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:49:14 INFO - 'talos_options': ['--xperf_path', 11:49:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:14 INFO - 'tests': ['tp5n']}}, 11:49:14 INFO - 'talos.zip': {'path': '', 11:49:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:14 INFO - Running post-action listener: _resource_record_post_action 11:49:14 INFO - [mozharness: 2017-01-09 19:49:14.256813Z] Finished populate-webroot step (success) 11:49:14 INFO - [mozharness: 2017-01-09 19:49:14.256901Z] Running create-virtualenv step. 11:49:14 INFO - Running pre-action listener: _resource_record_pre_action 11:49:14 INFO - Running main action method: create_virtualenv 11:49:14 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:49:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:14 INFO - Using real prefix '/usr' 11:49:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:16 INFO - Installing pip.................done. 11:49:16 INFO - Return code: 0 11:49:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:49:17 INFO - Reading from file tmpfile_stdout 11:49:17 INFO - Output received: 11:49:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:49:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:17 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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:49:17 INFO - Using env: {'DISPLAY': ':0', 11:49:17 INFO - 'HOME': '/home/cltbld', 11:49:17 INFO - 'LANG': 'en_US.UTF-8', 11:49:17 INFO - 'LANGUAGE': 'en_US:en', 11:49:17 INFO - 'LOGNAME': 'cltbld', 11:49:17 INFO - 'MAIL': '/var/mail/cltbld', 11:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:17 INFO - 'MOZ_NO_REMOTE': '1', 11:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:17 INFO - 'NO_EM_RESTART': '1', 11:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:17 INFO - 'PWD': '/builds/slave/test', 11:49:17 INFO - 'SHELL': '/bin/bash', 11:49:17 INFO - 'SHLVL': '1', 11:49:17 INFO - 'TERM': 'linux', 11:49:17 INFO - 'TMOUT': '86400', 11:49:17 INFO - 'USER': 'cltbld', 11:49:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:17 INFO - '_': '/tools/buildbot/bin/python'} 11:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:49:17 INFO - Cleaning up... 11:49:17 INFO - Return code: 0 11:49:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:17 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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:49:17 INFO - Using env: {'DISPLAY': ':0', 11:49:17 INFO - 'HOME': '/home/cltbld', 11:49:17 INFO - 'LANG': 'en_US.UTF-8', 11:49:17 INFO - 'LANGUAGE': 'en_US:en', 11:49:17 INFO - 'LOGNAME': 'cltbld', 11:49:17 INFO - 'MAIL': '/var/mail/cltbld', 11:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:17 INFO - 'MOZ_NO_REMOTE': '1', 11:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:17 INFO - 'NO_EM_RESTART': '1', 11:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:17 INFO - 'PWD': '/builds/slave/test', 11:49:17 INFO - 'SHELL': '/bin/bash', 11:49:17 INFO - 'SHLVL': '1', 11:49:17 INFO - 'TERM': 'linux', 11:49:17 INFO - 'TMOUT': '86400', 11:49:17 INFO - 'USER': 'cltbld', 11:49:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:17 INFO - '_': '/tools/buildbot/bin/python'} 11:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:17 INFO - Downloading/unpacking psutil>=3.1.1 11:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:19 INFO - Installing collected packages: psutil 11:49:19 INFO - Running setup.py install for psutil 11:49:19 INFO - building 'psutil._psutil_linux' extension 11:49:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:49:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:49:19 INFO - building 'psutil._psutil_posix' extension 11:49:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:49:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:49:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:20 INFO - Successfully installed psutil 11:49:20 INFO - Cleaning up... 11:49:20 INFO - Return code: 0 11:49:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:49:20 INFO - Using env: {'DISPLAY': ':0', 11:49:20 INFO - 'HOME': '/home/cltbld', 11:49:20 INFO - 'LANG': 'en_US.UTF-8', 11:49:20 INFO - 'LANGUAGE': 'en_US:en', 11:49:20 INFO - 'LOGNAME': 'cltbld', 11:49:20 INFO - 'MAIL': '/var/mail/cltbld', 11:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:20 INFO - 'MOZ_NO_REMOTE': '1', 11:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:20 INFO - 'NO_EM_RESTART': '1', 11:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:20 INFO - 'PWD': '/builds/slave/test', 11:49:20 INFO - 'SHELL': '/bin/bash', 11:49:20 INFO - 'SHLVL': '1', 11:49:20 INFO - 'TERM': 'linux', 11:49:20 INFO - 'TMOUT': '86400', 11:49:20 INFO - 'USER': 'cltbld', 11:49:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:20 INFO - '_': '/tools/buildbot/bin/python'} 11:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:49:22 INFO - Installing collected packages: mozsystemmonitor 11:49:22 INFO - Running setup.py install for mozsystemmonitor 11:49:22 INFO - Successfully installed mozsystemmonitor 11:49:22 INFO - Cleaning up... 11:49:22 INFO - Return code: 0 11:49:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:49:22 INFO - Using env: {'DISPLAY': ':0', 11:49:22 INFO - 'HOME': '/home/cltbld', 11:49:22 INFO - 'LANG': 'en_US.UTF-8', 11:49:22 INFO - 'LANGUAGE': 'en_US:en', 11:49:22 INFO - 'LOGNAME': 'cltbld', 11:49:22 INFO - 'MAIL': '/var/mail/cltbld', 11:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:22 INFO - 'MOZ_NO_REMOTE': '1', 11:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:22 INFO - 'NO_EM_RESTART': '1', 11:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:22 INFO - 'PWD': '/builds/slave/test', 11:49:22 INFO - 'SHELL': '/bin/bash', 11:49:22 INFO - 'SHLVL': '1', 11:49:22 INFO - 'TERM': 'linux', 11:49:22 INFO - 'TMOUT': '86400', 11:49:22 INFO - 'USER': 'cltbld', 11:49:22 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:22 INFO - '_': '/tools/buildbot/bin/python'} 11:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:22 INFO - Downloading/unpacking jsonschema==2.5.1 11:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:25 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:25 INFO - warning: no files found matching '*.txt' 11:49:25 INFO - no previously-included directories found matching 'build' 11:49:25 INFO - no previously-included directories found matching 'dist' 11:49:25 INFO - no previously-included directories found matching '.git*' 11:49:25 INFO - Installing collected packages: jsonschema, functools32 11:49:25 INFO - Running setup.py install for functools32 11:49:25 INFO - warning: no files found matching '*.txt' 11:49:25 INFO - no previously-included directories found matching 'build' 11:49:25 INFO - no previously-included directories found matching 'dist' 11:49:25 INFO - no previously-included directories found matching '.git*' 11:49:25 INFO - Successfully installed jsonschema functools32 11:49:25 INFO - Cleaning up... 11:49:25 INFO - Return code: 0 11:49:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:49:25 INFO - Using env: {'DISPLAY': ':0', 11:49:25 INFO - 'HOME': '/home/cltbld', 11:49:25 INFO - 'LANG': 'en_US.UTF-8', 11:49:25 INFO - 'LANGUAGE': 'en_US:en', 11:49:25 INFO - 'LOGNAME': 'cltbld', 11:49:25 INFO - 'MAIL': '/var/mail/cltbld', 11:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:25 INFO - 'MOZ_NO_REMOTE': '1', 11:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:25 INFO - 'NO_EM_RESTART': '1', 11:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:25 INFO - 'PWD': '/builds/slave/test', 11:49:25 INFO - 'SHELL': '/bin/bash', 11:49:25 INFO - 'SHLVL': '1', 11:49:25 INFO - 'TERM': 'linux', 11:49:25 INFO - 'TMOUT': '86400', 11:49:25 INFO - 'USER': 'cltbld', 11:49:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:25 INFO - '_': '/tools/buildbot/bin/python'} 11:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:49:25 INFO - Cleaning up... 11:49:25 INFO - Return code: 0 11:49:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:49:25 INFO - Using env: {'DISPLAY': ':0', 11:49:25 INFO - 'HOME': '/home/cltbld', 11:49:25 INFO - 'LANG': 'en_US.UTF-8', 11:49:25 INFO - 'LANGUAGE': 'en_US:en', 11:49:25 INFO - 'LOGNAME': 'cltbld', 11:49:25 INFO - 'MAIL': '/var/mail/cltbld', 11:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:25 INFO - 'MOZ_NO_REMOTE': '1', 11:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:25 INFO - 'NO_EM_RESTART': '1', 11:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:25 INFO - 'PWD': '/builds/slave/test', 11:49:25 INFO - 'SHELL': '/bin/bash', 11:49:25 INFO - 'SHLVL': '1', 11:49:25 INFO - 'TERM': 'linux', 11:49:25 INFO - 'TMOUT': '86400', 11:49:25 INFO - 'USER': 'cltbld', 11:49:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:25 INFO - '_': '/tools/buildbot/bin/python'} 11:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:28 INFO - Downloading docopt-0.6.1.tar.gz 11:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:28 INFO - Running setup.py install for blobuploader 11:49:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:28 INFO - Running setup.py install for requests 11:49:29 INFO - Running setup.py install for docopt 11:49:29 INFO - Successfully installed blobuploader requests docopt 11:49:29 INFO - Cleaning up... 11:49:29 INFO - Return code: 0 11:49:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:29 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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:29 INFO - Using env: {'DISPLAY': ':0', 11:49:29 INFO - 'HOME': '/home/cltbld', 11:49:29 INFO - 'LANG': 'en_US.UTF-8', 11:49:29 INFO - 'LANGUAGE': 'en_US:en', 11:49:29 INFO - 'LOGNAME': 'cltbld', 11:49:29 INFO - 'MAIL': '/var/mail/cltbld', 11:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:29 INFO - 'MOZ_NO_REMOTE': '1', 11:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:29 INFO - 'NO_EM_RESTART': '1', 11:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:29 INFO - 'PWD': '/builds/slave/test', 11:49:29 INFO - 'SHELL': '/bin/bash', 11:49:29 INFO - 'SHLVL': '1', 11:49:29 INFO - 'TERM': 'linux', 11:49:29 INFO - 'TMOUT': '86400', 11:49:29 INFO - 'USER': 'cltbld', 11:49:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:29 INFO - '_': '/tools/buildbot/bin/python'} 11:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:29 INFO - Running setup.py (path:/tmp/pip-AGBRGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:29 INFO - Running setup.py (path:/tmp/pip-pp9rep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:29 INFO - Running setup.py (path:/tmp/pip-EW0xZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:29 INFO - Running setup.py (path:/tmp/pip-92XNz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:29 INFO - Running setup.py (path:/tmp/pip-AxIEKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:29 INFO - Running setup.py (path:/tmp/pip-X4NqM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:29 INFO - Running setup.py (path:/tmp/pip-wGyEQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:30 INFO - Running setup.py (path:/tmp/pip-KoE8_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:30 INFO - Running setup.py (path:/tmp/pip-fb_619-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:30 INFO - Running setup.py (path:/tmp/pip-XuAA9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:30 INFO - Running setup.py (path:/tmp/pip-hoxAkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:30 INFO - Running setup.py (path:/tmp/pip-BddiEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:30 INFO - Running setup.py (path:/tmp/pip-gBGDYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:30 INFO - Running setup.py (path:/tmp/pip-IhQUtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:30 INFO - Running setup.py (path:/tmp/pip-MuBpvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:30 INFO - Running setup.py (path:/tmp/pip-kOCyWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:30 INFO - Running setup.py (path:/tmp/pip-4c6Yur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:30 INFO - Running setup.py install for manifestparser 11:49:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:30 INFO - Running setup.py install for mozcrash 11:49:31 INFO - Running setup.py install for mozdebug 11:49:31 INFO - Running setup.py install for mozdevice 11:49:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Running setup.py install for mozfile 11:49:31 INFO - Running setup.py install for mozhttpd 11:49:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Running setup.py install for mozinfo 11:49:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Running setup.py install for mozInstall 11:49:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Running setup.py install for mozleak 11:49:31 INFO - Running setup.py install for mozlog 11:49:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Running setup.py install for moznetwork 11:49:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:31 INFO - Running setup.py install for mozprocess 11:49:32 INFO - Running setup.py install for mozprofile 11:49:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:32 INFO - Running setup.py install for mozrunner 11:49:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:32 INFO - Running setup.py install for mozscreenshot 11:49:32 INFO - Running setup.py install for moztest 11:49:32 INFO - Running setup.py install for mozversion 11:49:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:32 INFO - Cleaning up... 11:49:32 INFO - Return code: 0 11:49:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:32 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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:32 INFO - Using env: {'DISPLAY': ':0', 11:49:32 INFO - 'HOME': '/home/cltbld', 11:49:32 INFO - 'LANG': 'en_US.UTF-8', 11:49:32 INFO - 'LANGUAGE': 'en_US:en', 11:49:32 INFO - 'LOGNAME': 'cltbld', 11:49:32 INFO - 'MAIL': '/var/mail/cltbld', 11:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:32 INFO - 'MOZ_NO_REMOTE': '1', 11:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:32 INFO - 'NO_EM_RESTART': '1', 11:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:32 INFO - 'PWD': '/builds/slave/test', 11:49:32 INFO - 'SHELL': '/bin/bash', 11:49:32 INFO - 'SHLVL': '1', 11:49:32 INFO - 'TERM': 'linux', 11:49:32 INFO - 'TMOUT': '86400', 11:49:32 INFO - 'USER': 'cltbld', 11:49:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:32 INFO - '_': '/tools/buildbot/bin/python'} 11:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:32 INFO - Running setup.py (path:/tmp/pip-rESoGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:32 INFO - Running setup.py (path:/tmp/pip-gtNP1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:32 INFO - Running setup.py (path:/tmp/pip-6fkv8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:33 INFO - Running setup.py (path:/tmp/pip-PFA_cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:33 INFO - Running setup.py (path:/tmp/pip-VOr8tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:33 INFO - Running setup.py (path:/tmp/pip-7ZdP0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:33 INFO - Running setup.py (path:/tmp/pip-uXigC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:33 INFO - Running setup.py (path:/tmp/pip-2HVxr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:33 INFO - Running setup.py (path:/tmp/pip-QVBsEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:33 INFO - Running setup.py (path:/tmp/pip-L_bh1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:33 INFO - Running setup.py (path:/tmp/pip-SKSfBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:33 INFO - Running setup.py (path:/tmp/pip-ieAba8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:33 INFO - Running setup.py (path:/tmp/pip-na6rnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:33 INFO - Running setup.py (path:/tmp/pip-x5BY5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:33 INFO - Running setup.py (path:/tmp/pip-G7b7Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:33 INFO - Running setup.py (path:/tmp/pip-QG6bW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:34 INFO - Running setup.py (path:/tmp/pip-czGBKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:36 INFO - Downloading blessings-1.6.tar.gz 11:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:36 INFO - Installing collected packages: blessings 11:49:36 INFO - Running setup.py install for blessings 11:49:36 INFO - Successfully installed blessings 11:49:36 INFO - Cleaning up... 11:49:36 INFO - Return code: 0 11:49:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:36 INFO - Reading from file tmpfile_stdout 11:49:36 INFO - Current package versions: 11:49:36 INFO - argparse == 1.2.1 11:49:36 INFO - blessings == 1.6 11:49:36 INFO - blobuploader == 1.2.4 11:49:36 INFO - docopt == 0.6.1 11:49:36 INFO - functools32 == 3.2.3-2 11:49:36 INFO - jsonschema == 2.5.1 11:49:36 INFO - manifestparser == 1.1 11:49:36 INFO - mozInstall == 1.12 11:49:36 INFO - mozcrash == 1.0 11:49:36 INFO - mozdebug == 0.1 11:49:36 INFO - mozdevice == 0.49 11:49:36 INFO - mozfile == 1.2 11:49:36 INFO - mozhttpd == 0.7 11:49:36 INFO - mozinfo == 0.9 11:49:36 INFO - mozleak == 0.1 11:49:36 INFO - mozlog == 3.4 11:49:36 INFO - moznetwork == 0.27 11:49:36 INFO - mozprocess == 0.24 11:49:36 INFO - mozprofile == 0.28 11:49:36 INFO - mozrunner == 6.13 11:49:36 INFO - mozscreenshot == 0.1 11:49:36 INFO - mozsystemmonitor == 0.3 11:49:36 INFO - moztest == 0.8 11:49:36 INFO - mozversion == 1.4 11:49:36 INFO - psutil == 3.1.1 11:49:36 INFO - requests == 1.2.3 11:49:36 INFO - wsgiref == 0.1.2 11:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:36 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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:36 INFO - Using env: {'DISPLAY': ':0', 11:49:36 INFO - 'HOME': '/home/cltbld', 11:49:36 INFO - 'LANG': 'en_US.UTF-8', 11:49:36 INFO - 'LANGUAGE': 'en_US:en', 11:49:36 INFO - 'LOGNAME': 'cltbld', 11:49:36 INFO - 'MAIL': '/var/mail/cltbld', 11:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:36 INFO - 'MOZ_NO_REMOTE': '1', 11:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:36 INFO - 'NO_EM_RESTART': '1', 11:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:36 INFO - 'PWD': '/builds/slave/test', 11:49:36 INFO - 'SHELL': '/bin/bash', 11:49:36 INFO - 'SHLVL': '1', 11:49:36 INFO - 'TERM': 'linux', 11:49:36 INFO - 'TMOUT': '86400', 11:49:36 INFO - 'USER': 'cltbld', 11:49:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:36 INFO - '_': '/tools/buildbot/bin/python'} 11:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:49:36 INFO - Cleaning up... 11:49:36 INFO - Return code: 0 11:49:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:36 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 0x1de21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2154480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, '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': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:49:36 INFO - Using env: {'DISPLAY': ':0', 11:49:36 INFO - 'HOME': '/home/cltbld', 11:49:36 INFO - 'LANG': 'en_US.UTF-8', 11:49:36 INFO - 'LANGUAGE': 'en_US:en', 11:49:36 INFO - 'LOGNAME': 'cltbld', 11:49:36 INFO - 'MAIL': '/var/mail/cltbld', 11:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:36 INFO - 'MOZ_NO_REMOTE': '1', 11:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:36 INFO - 'NO_EM_RESTART': '1', 11:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:36 INFO - 'PWD': '/builds/slave/test', 11:49:36 INFO - 'SHELL': '/bin/bash', 11:49:36 INFO - 'SHLVL': '1', 11:49:36 INFO - 'TERM': 'linux', 11:49:36 INFO - 'TMOUT': '86400', 11:49:36 INFO - 'USER': 'cltbld', 11:49:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:36 INFO - '_': '/tools/buildbot/bin/python'} 11:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:49:37 INFO - Cleaning up... 11:49:37 INFO - Return code: 0 11:49:37 INFO - Running post-action listener: _resource_record_post_action 11:49:37 INFO - Running post-action listener: _start_resource_monitoring 11:49:37 INFO - Starting resource monitoring. 11:49:37 INFO - [mozharness: 2017-01-09 19:49:37.096185Z] Finished create-virtualenv step (success) 11:49:37 INFO - [mozharness: 2017-01-09 19:49:37.096700Z] Running install step. 11:49:37 INFO - Running pre-action listener: _resource_record_pre_action 11:49:37 INFO - Running main action method: install 11:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:37 INFO - Reading from file tmpfile_stdout 11:49:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:37 INFO - Reading from file tmpfile_stdout 11:49:37 INFO - Output received: 11:49:37 INFO - Usage: mozinstall [options] installer 11:49:37 INFO - Options: 11:49:37 INFO - -h, --help show this help message and exit 11:49:37 INFO - -d DEST, --destination=DEST 11:49:37 INFO - Directory to install application into. [default: 11:49:37 INFO - "/builds/slave/test"] 11:49:37 INFO - --app=APP Application being installed. [default: firefox] 11:49:37 INFO - mkdir: /builds/slave/test/build/application 11:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:49:37 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:49:56 INFO - Reading from file tmpfile_stdout 11:49:56 INFO - Output received: 11:49:56 INFO - /builds/slave/test/build/application/firefox/firefox 11:49:56 INFO - Running post-action listener: _resource_record_post_action 11:49:56 INFO - [mozharness: 2017-01-09 19:49:56.309304Z] Finished install step (success) 11:49:56 INFO - [mozharness: 2017-01-09 19:49:56.309575Z] Running run-tests step. 11:49:56 INFO - Running pre-action listener: _resource_record_pre_action 11:49:56 INFO - Running main action method: run_tests 11:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:49:56 INFO - Python 2.7.3 11:49:56 INFO - Return code: 0 11:49:56 INFO - grabbing minidump binary from tooltool 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2151820>, '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 0x2152520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21529b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:49:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:49:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:49:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:49:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:56 INFO - Return code: 0 11:49:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:49:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:49:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:49:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:49:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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:49:56 INFO - Using env: {'DISPLAY': ':0', 11:49:56 INFO - 'HOME': '/home/cltbld', 11:49:56 INFO - 'LANG': 'en_US.UTF-8', 11:49:56 INFO - 'LANGUAGE': 'en_US:en', 11:49:56 INFO - 'LOGNAME': 'cltbld', 11:49:56 INFO - 'MAIL': '/var/mail/cltbld', 11:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:56 INFO - 'MOZ_NO_REMOTE': '1', 11:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:56 INFO - 'NO_EM_RESTART': '1', 11:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:56 INFO - 'PWD': '/builds/slave/test', 11:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:56 INFO - 'SHELL': '/bin/bash', 11:49:56 INFO - 'SHLVL': '1', 11:49:56 INFO - 'TERM': 'linux', 11:49:56 INFO - 'TMOUT': '86400', 11:49:56 INFO - 'USER': 'cltbld', 11:49:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025', 11:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:56 INFO - '_': '/tools/buildbot/bin/python'} 11:49:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:49:56 INFO - mozversion application_buildid: 20170109094010 11:49:56 INFO - mozversion application_changeset: dd6d4ca2066803fae7dc99fb872d7191a6421478 11:49:56 INFO - mozversion application_display_name: Nightly 11:49:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:56 INFO - mozversion application_name: Firefox 11:49:56 INFO - mozversion application_remotingname: firefox 11:49:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:49:56 INFO - mozversion application_vendor: Mozilla 11:49:56 INFO - mozversion application_version: 53.0a1 11:49:56 INFO - mozversion platform_buildid: 20170109094010 11:49:56 INFO - mozversion platform_changeset: dd6d4ca2066803fae7dc99fb872d7191a6421478 11:49:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:49:56 INFO - mozversion platform_version: 53.0a1 11:49:56 INFO - using testdate: 1483991396 11:49:56 INFO - actual date: 1483991396 11:49:56 INFO - starting webserver on 'localhost:35165' 11:49:56 INFO - SUITE-START | Running 2 tests 11:49:56 INFO - TEST-START | dromaeo_css 11:49:56 INFO - operating with platform_type : linux_ 11:49:56 INFO - Initialising browser for dromaeo_css test... 11:49:56 INFO - TEST-INFO | started process 11486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx7ooSI/profile http://localhost:35165/getInfo.html) 11:49:57 INFO - PROCESS | 11486 | 1483991397032 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 11:50:00 INFO - PROCESS | 11486 | __metrics Screen width/height:1600/1200 11:50:00 INFO - PROCESS | 11486 | colorDepth:24 11:50:00 INFO - PROCESS | 11486 | Browser inner width/height: 1024/697 11:50:00 INFO - PROCESS | 11486 | __metrics 11:50:01 ERROR - PROCESS | 11486 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 11:50:01 INFO - TEST-INFO | 11486: exit 0 11:50:01 INFO - Browser initialized. 11:50:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:01 INFO - TEST-INFO | started process 11609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx7ooSI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:13 INFO - PROCESS | 11609 | RSS: Main: 154820608 11:50:13 INFO - PROCESS | 11609 | 11:53:13 INFO - PROCESS | 11609 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35165/tests/dromaeo/cssquery-ext.html) 11:53:15 INFO - PROCESS | 11609 | RSS: Main: 163332096 11:53:15 INFO - PROCESS | 11609 | 11:55:02 INFO - PROCESS | 11609 | ************************* 11:55:02 INFO - PROCESS | 11609 | A coding exception was thrown and uncaught in a Task. 11:55:02 INFO - PROCESS | 11609 | 11:55:02 INFO - PROCESS | 11609 | Full message: ReferenceError: fetch is not defined 11:55:02 INFO - PROCESS | 11609 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:55:02 INFO - PROCESS | 11609 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:55:02 INFO - PROCESS | 11609 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:55:02 INFO - PROCESS | 11609 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:55:02 INFO - PROCESS | 11609 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:55:02 INFO - PROCESS | 11609 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:55:02 INFO - PROCESS | 11609 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:55:02 INFO - PROCESS | 11609 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:55:02 INFO - PROCESS | 11609 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:55:02 INFO - PROCESS | 11609 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:55:02 INFO - PROCESS | 11609 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:55:02 INFO - PROCESS | 11609 | 11:55:02 INFO - PROCESS | 11609 | ************************* 11:56:18 INFO - PROCESS | 11609 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-ext.html (next: http://localhost:35165/tests/dromaeo/cssquery-jquery.html) 11:56:18 INFO - PROCESS | 11609 | RSS: Main: 159870976 11:56:18 INFO - PROCESS | 11609 | 11:59:20 INFO - PROCESS | 11609 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35165/tests/dromaeo/cssquery-mootools.html) 11:59:21 INFO - PROCESS | 11609 | RSS: Main: 166395904 11:59:21 INFO - PROCESS | 11609 | 12:02:23 INFO - PROCESS | 11609 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35165/tests/dromaeo/cssquery-prototype.html) 12:02:23 INFO - PROCESS | 11609 | RSS: Main: 161021952 12:02:23 INFO - PROCESS | 11609 | 12:05:26 INFO - PROCESS | 11609 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35165/tests/dromaeo/cssquery-yui.html) 12:05:27 INFO - PROCESS | 11609 | RSS: Main: 164216832 12:05:27 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | Cycle 1(1): loaded http://localhost:35165/tests/dromaeo/cssquery-yui.html (next: http://localhost:35165/tests/dromaeo/cssquery-dojo.html) 12:08:29 INFO - PROCESS | 11609 | RSS: Main: 163823616 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | __start_tp_report 12:08:29 INFO - PROCESS | 11609 | _x_x_mozilla_page_load 12:08:29 INFO - PROCESS | 11609 | _x_x_mozilla_page_load_details 12:08:29 INFO - PROCESS | 11609 | |i|pagename|runs| 12:08:29 INFO - PROCESS | 11609 | |0;dojo.html;3129.405412971535;3196.4725820239655;3196.952045719313;3201.2020677954297;3227.5158726191053;5337.5196232339085;5407.91888121678;5454.61817672763;5462.754176062077;5488.64323818952;5341.973290133544;5423.267858839055;5451.536619387357;5479.2602998595175;5556.083246264372;4900.166971614834;4919.60643148549;4951.158303088484;5010.173321401964;5059.848204553869;4833.3716616839765;4963.602911767068;4970.378702662168;4984.501549845023;4989.052080104769;4922.75386230687;5059.367579052619;5091.9236211456855;5109.463506331819;5114.718690472023;4918.483559226302;4976.129177393942;5007.749612519359;5017;5097.617678674077;4960.479149689267;4973.378327709036;4992.500749924979;5008.899822003539;5023.2214006828635;5427.674339539601;5485.040117979377;5505;5517.475839795213;5527.143292789624;5744.22452968848;5778.219940308047;5790.739416726257;5797.130430435426;5801.6519008859605;5888.087346461305;5921.052631578927;5922.7038648067855;5934.554908381845;5965.164876917235;5436.374816896068;5495.560355171577;5497.312835895513;5501.9174712378945;5510.311211098613;5906.143609176731;5923.378045305181;5951;5962.40375962409;5968.820935371946;5747.712614369265;5789;5797.449242321973;5840.123981402823;5849.415058494202;5813.970930145407;5860.150278209721;5870.060790273621;5884.47039766423;5905.940940590625;5795.82612521625;5835.270591176103;5846.356900740915;5938.584299099021;5944.464998150101;5916.083007133901;5918.585699001114;5919.082542205965;5925.140854576062;5961.433663801932;4472.127935052698;4590.242609969385;4592.288195329729;4593.724376537419;4599;4017.598240175959;4043.3732771420478;4076.1236334188293;4078.408630748584;4085.2850751118435;5427.945720542823;5468.28912241406;5474.562035037187;5496.395396506381;5504.146857237055;5717.942820571824;5772.365039845614;5904.261967254093;5916.408359164049;5930.733117009745;5582.190582365615;5607.719614019283;5614.1859430382365;5645.68948707825;5657.57568182388;5082;5082.288479612857;5091.694498330112;5092.312537807423;5121.231815227746;5884.941150588611;6130.386961303923;6138.938610613926;6193.225846769154;6217.906731399033;5711.628744131618;5725.2843394575675;5742.16738572913;5760.366359700346;5827.213326201078;6038.51691864641;6064.605800622945;6076.756929722762;6101.054336577838;6104.481119104926;5682.431756824284;5690.573207009408;5702.344230413555;5712.942870571241;5746.281714785652;5772.960867043805;5811.186433899342;5890.410958904075;5915.58590898633;5948.464638182584;5718.3773731266165;5769.278840144982;5776.42235776419;5778.306603207642;5823.417658234142;5720.8283751487525;5725.541956643542;5756.395578464201;5757.453041961007;5764.308283005898;5520.447955204608;5521.613487055867;5560.19377190297;5566.749496272597;5763.308402991668;5656.5757568181725;5658.122990936411;5668.093105103164;5692.516136128475;5702.315722113373;5568.9443105568425;5581.358143813513;5587.525060369914;5594.720263986703;5603.8879222416135 12:08:29 INFO - PROCESS | 11609 | |1;ext.html;534.205070961569;566.3543560341211;598.7934162713863;612.2163630552894;614.342653360904;40536.391954120714;41208.58791412085;45148.54851451484;45181.32228016574;45227.77386113073;46400.76799616006;47365.52634473654;47433.05133897329;47451.28823067657;47474.52525474753;8994.865077023866;10468.528916198751;10871.565137394495;10873.293235939638;10897.945510272477;10452.686419407391;10490.79018419635;10511.316764410327;10551.366917984946;10559.577616895314;10624.734381640443;10626.840597391045;10638.946805265963;10703.197260205478;10709.410982395964;10582.365058096539;10645.30805497644;10646.57413703451;10652.467376631215;10659.467026648637;10431;10457.9477102614;10471.84292235617;10503.579856805718;10546.736331591695;39054.41418378727;39482.80258598689;39512;39515.60484395177;39650.40524392136;4109.321961876287;4142.606452387048;4201.516825565069;4216.746995180299;4269.146170765828;29472.70527294721;29688.257793555116;29771.85114074416;29825.552616710767;29890.10329690113;4141.4409054777525;4211.684123690736;4262.083652014831;4298.484181898192;4426.26966550522;321264.39367803244;321492;321538;322380;322930;53873.461265386846;54386.72806636021;54575;54687;54733;51249.23126153111;51310.743446283275;51460.74269628628;51479;51651;13941.233232172328;15034.248287585795;15293.158876261912;15430.38278468871;15447.0731756095;11260.605878794368;12355.135140540076;12547.560835370901;12577.811332830015;12606.558770443175;17739.822601774074;17866;17876.821231787777;17964.730529042074;18050.368237111637;7093.304544273144;7132.857342853114;7239.167495737952;7378.225286344964;7499.6250187490405;923.9953800231091;947.393668052447;955.5843208204453;961.1877963121151;1001.0640051551823;31801.204969875937;32120;32140.517892231634;32376.190595235308;32850.83574582112;1113.2429947635685;1125.4879030041475;1153.423288355822;1155.3183621663259;1250.593557093948;17295;17367.65264694699;17431.56421089483;17508.912455437643;17605.559861003578;444576;677160;686775;689720;691534;54629.1805622916;54850;55229.723851380484;55562.44437555573;55644.16533751997;1480.9259537023322;1485.6360191752874;1498.5579254120062;1502.1512845242403;1509.8867584931174;28475.28811779722;30269.394612108073;30425.543616846207;30663.693363066082;30950.690493094782;48159;48556.75721621369;48639;48878.75560622317;48945.75527122342;412640;414309;415472;417788;418273;26591.20226393211;27160.72839271582;27197.320066998484;27305.180844574694;28912.42175156443;42408.575914241694;42528.362074568286;43967.56032439763;44179;44599.77700111608;36320.27359452743;36776.816115919246;37143.25713485661;37526.31131599139;38188.618113818506;37261.627383726904;37517.81241093777;37518.43722344113;37737.43393849149;37820.43269351017;35799.28401432009;36722.44916326204;36763.26473470462;36811.447828282064;37702;31669;32351.838240809586;33087.83456082704;33315.500267495525;33331.500027499125;25097.121600743885;25302.74697253004;25306.620400693635;25422.872885635454;25612.871935640203 12:08:29 INFO - PROCESS | 11609 | |2;jquery.html;415.45160388287474;424.20303099907625;436.3128073284578;436.3215200363435;438.73018093872275;19357.903210483946;21294.46763830903;21483.03326350316;21894.452638684;22056.33830985073;20977.47556311093;21640.134394624198;21663.35009949704;21916.123355065818;22023.889880550614;5839.270091238605;6053.757849686007;6062.545309101813;6080.483158931496;6120.081987701836;5716.485516303532;5933.584649074566;5933.940660593382;5941.316748573904;6096.7561297548045;6036.637801731888;6089.330173680892;6093.78671746489;6100.084987251903;6101.267847858263;5687.459691329317;5896.469317761379;5928.851778705523;6005.4595086442;6015.157877897098;5663.886722265573;5795.88408231833;5821.854453638651;5860.384659610765;5895.204147440084;13799.931000345034;14035.228062456561;14036.438542458289;14070.85929140716;22671.206507772313;2890.7976441649093;3061.4336347775734;3109.9844500777576;3169.255225022118;3328.417526932777;10003.799924001552;10367.688969330931;10430.37417754937;10656.360618362845;10775.892241077645;1791.0686443049542;1797.766290382255;1800.4238643634042;1876.4089311866855;1970.3990282963691;92157;92673.99999999933;92750.536247319;93065;93647.53176234075;11988.76022479563;12006.699832504257;12209.755804883853;12272;12343.69140771488;16845.073520956466;16866.746998795028;16875.624875025045;16876.662466750597;16894.57763555921;8345.332373410112;8649.221570058726;8678.522681252593;8732.257758090633;8839.204471597586;8106.918930810734;8226.136255693185;8283;8459.407841451039;8488.575571221538;5130.846074617767;5132.767246247894;5154.201098829687;5169.198774190007;5274.182501712241;2013.5570174561574;2060.6187855246826;2093.4975605854484;2136.2309568555306;2152.547964927383;1117.8155604325357;1140.3395101723395;1141.223967701954;1141.3095077478172;1174.6769638349522;19357.51606209856;19850.404487865388;19882.60234795296;19882.801171988383;20176.798232017787;1100.8128618134776;1101.2346419238713;1107.1419649771492;1133.790248803974;1134.8184290513477;10851.6846646881;11013.614523491638;11016.394098324508;11066.889331106748;11113.555457781598;638420;642244;675448;683447;688124;76768.23231767722;100126;102225;102836;105486;961.8172547216006;971.3103696375512;994.4828689081637;1004.1063453526367;1008.1884083313004;16681.91659041697;16792.916035419745;16946;16969.915150424167;17239.310427582757;40820.38769418521;40952.79523602363;41728.58271417247;42027.7898610505;43141.784291078344;57174;58274;58487.70756146192;59265.703671481366;59289.814203716545;7238.52949558277;8510.957445212734;8714.782130446789;8818.51498167607;8891.510966896883;11599;13760.518381856587;13847.86152138506;13889.722205556034;13923.860761392256;10894.891051089704;11749;11824.586139485076;12056.216345937486;12176.330301833485;12016.63950081464;12045.51817927273;12214;12442.688932776391;12773.23360598367;11900.345480998629;12191.146619736888;12238.326892021025;12295.877041229473;12379.947704445223;8919.509426981318;9020.278377729635;9117.77205569866;9173.816523669622;9486.810263794823;11782.17524773292;11797.35114568707;11898.263399418356;12001.819972700241;12048.277103373826 12:08:29 INFO - PROCESS | 11609 | |3;mootools.html;1498.6777842763804;1500.917449540275;1513.1375116183776;1516.2039929037262;1524.656952185758;7515.699372025126;7758.6896524138965;7765.456418050739;8215.342772578195;8216.712415065467;7950.880736788953;8182.345412366996;8199.795005124875;8361.414700970934;8384;2198.67019947008;2231.8884055797225;2244.9887750561224;2246.7191601049867;2251.223327951854;2275.7951784339407;2310.584094862924;2319.946847040373;2339.2397470821966;2346.3547524430746;2273.4771002669395;2298.655201719747;2307.653851922208;2312.028947841902;2319.5360927814504;2128.8084072433558;2131.5843410534953;2144.356692992096;2155.6550951847707;2161.470439742265;2243.9439014024615;2270.2167752125492;2272.102519504803;2277.3851060213815;2284.931452056441;8344.41589088764;8367.8326433471;8426.073131955542;8437.156284371515;8456.154384561494;5048.495150484959;5150.896982060338;5172.301739265189;5176.964607078562;5178.456262092502;3016.3213277012715;3139.607549056368;3369.949450758241;3373.96626033739;3377;1327.5552689848912;1372.574501904403;1383.1424516799648;1402.8246469191351;1405.1428628536585;11037.613683521038;11043.889561104446;11044.944775276153;11078;11085.27945683536;4193.287141186006;4491.236489796743;4500.054988452396;4590.150822097922;4624.907501849944;9794.902050979541;9802.36284641496;9834.262430317754;9847.655332063343;9870.802583948282;5188.11801993662;5220.112580861262;5221.765020574083;5222.321098257278;5222.686638801684;4213.5154457237195;4704.1767690654;4776.546228108324;4791.448983366958;4844.685095468783;3845.65389114981;3902.6292502212814;3945.151792364655;3958.4062390641634;3959.980200098981;1270.4727538071597;1273.0706584193406;1274.2927675140386;1283.582835578422;1287.7038281195378;988.3970777825521;992.6426486464867;1004.1815920025156;1006.2654262388351;1011.858339832424;5515.338159420895;5532.391436942014;5570.777168913198;5648.096304591246;5713.228714123623;991.3853410885154;1021.9386836789816;1041.1514615588271;1051.3481641382239;1066.024587502442;3707.610700876423;3758.229562939591;3775.244951009809;3800.1639639279315;3810.6951443884423;9654.22766178704;9795.118439340351;9879.703608891745;9895;9902;9774;9847.064528869745;9854.901450985542;9870.631048548441;9875.209983201326;7417.221191774894;7630.7710768677025;7737.729179478692;7867.527948323119;7872.645730942007;5560.443955604407;5576.442355764391;5620.74706638194;5645.71771411436;5875.735591898289;8773.956130219309;8954;9003.234725048444;9073.364864459425;9180.6786762463;8989;9033.412828166149;9033.77415564616;9080.318976076689;9082.318826087938;6960.617166055916;7152.177499587614;7209.206987231296;7215.6031418270395;7323.597202153933;7860.6069696513805;7892.289693927344;7900.723474678359;7901.446898717035;7926.762197134095;7033.9296607033275;7138.678759455733;7216.422686185198;7233.348998590152;7263.055802745609;6828.055247625626;6894.24163342042;6916.3429474199875;7035.437165026888;7096.148462184571;6054.243219597551;6105.84735381619;6108.11432342299;6119.84700382494;6123.265208174869;4742.66801323904;4794.544518270759;4846.127697014571;4885.487023862585;4900.705957642553;4899.093667671492;4922.532359425849;4933.407991041098;5009.77456014473;5027.64806463544 12:08:29 INFO - PROCESS | 11609 | |4;prototype.html;369.62298455575313;388.6133297369118;393.4373845401077;400.51537639456257;409.29192496980227;5240.004399164166;5349.465053494649;5395.91906121408;5448.7548060337285;5466.2781223914535;5270.288511051017;5363.785448582052;5393.139366918407;5421.295231619883;5439.5104440600335;4364.585364390377;4368.301071828508;4375;4377.255866502686;4380.34294855771;4007.398890166484;4204.159168166364;4369;4380.7152535085115;4396.7361958282445;4216.283231850577;4229.217594744967;4229.407882896382;4233.74597524148;4257.7445353278745;4219.683523735702;4220.53574106848;4229.154169166179;4263.253930562139;4278.486581610196;3777.471154038437;3778.6977041836585;3784.8864534064023;3786.545614526247;3809.6190380961684;5075.873103172414;5241.737913104368;5248.921266181011;5254.239829657069;5271.393789714193;4826.831060912887;4833.347498087784;4853.854384368475;4853.927191092136;4875.8781030474165;5517.337919449692;5704.600677952545;5746.827595172152;5759.934412133769;5778.59549831512;4090.7750073745933;4096.528899176603;4111.938320925188;4122.855700050513;4150.522689890671;6021.09683547467;6056.152138700585;6062.211912451397;6081.726322315506;6112.755489780404;4057.2899742544937;4252.319628859368;4260.808263628144;4265.7014009019695;4280.272353699816;4236.745795252233;4247.638950689165;4256.489221293465;4256.531781504032;4271.209826182167;4821.493743156988;4843.54693591921;4862.197737373293;4868.221084626513;4874.731889746098;5521.680894024519;5765;5765.8558536036935;5787.392323806024;5801.970990145022;1417.7736258136845;1435.2393231587275;1440.1431148466645;1446.3780574352918;1448.7609544425052;950.805084957582;983.1348413396165;1001.8046480936148;1015.456730649114;1019.4596863662271;5275.788968441296;5279.894402111936;5291.470852914755;5319.787208511693;5337.226102215157;5648.85877853057;5691.146328050825;5731.369549349568;5731.398203188689;5739.942600573941;5008.574271186917;5100.29140238017;5230.660007099526;5305;5368.812091576854;3014.3669829336086;3014.954775678367;3035.7267845893975;3042.3571271513133;3050.176452357851;5887.322957859901;5893.233879595625;5925.614835035709;5947.256592925884;5966.672997530966;5669.489745922887;5977.323945773405;6001.549883758736;6020.277566691937;6032;6067.96844536421;6070.726817293233;6075.422834830684;6090.33006369299;6103.664298463627;5583.989763684989;5836.416358364129;5841.1238314253205;5852.5317974561085;5882.735276912635;5785.652860828363;5787.652740835563;5813;5851.3961287226775;5879.354290569347;5810.273715785527;6111.236095488064;6131.417515336036;6133.294671112879;6146.446819786241;4124.741953704149;4143.274926887722;4200.957990420056;4214.220369231702;4224.218519573888;5892.587518873809;5904.498117660047;5908.509532755051;5928.666050138684;5934.258217722785;5594.608377413542;5776.682282474504;5779.797707080232;5783.479486846204;5800.578858179773;5705.942940570541;5731.598788084794;5734.455226753452;5760.942390576208;5786.566007549366;5730.512906402836;5735.225744524602;5745.798897038583;5772.278465191851;5794.391588883106;5475.4250803665045;5621.775128994795;5723.540497173194;5725.56663418054;5754.9424505754405;5599.524040456607;5611.523020543136;5613.859653508695;5622.662640241599;5662.688552129673 12:08:29 INFO - PROCESS | 11609 | |5;yui.html;774.6475353714058;777.9844403111941;822.8765685147227;883.686291366565;900.7567956651704;14084.36620352084;15275.618109547268;15315.310811013504;15338.693226135485;15434.691306173883;14052.086614370084;14287.285635718225;14295.642608934782;14299.356528956221;14330.64173395663;632.813320070578;651.3942033908463;723.0636325957871;738.0774032459439;748.4237137404195;739.8446326271462;743.9702411903518;744.7393412305677;748.7978245873611;750.4671683105003;781.5857595474379;786.3080489169552;789.0886026639212;789.1004255149135;789.159545084486;775.4106878772118;780.5238804329355;783.7648705388418;785.3167744062645;788.0110461370972;574.2477354665401;574.3567204730687;574.5145352177403;574.5145352177403;575.4935656622188;15024.399024039025;15030.549083527512;15137.667142381231;15239.61900952474;15419.074855508705;14951.700965980619;15568.299426525833;15883.444079457164;15931.840681593152;16371.263293151836;12140.635780926586;12261;12342.506299748;12388.876111238862;12526.874731252661;3773.6792372648356;3860.7104467164795;3864.306197227976;3865.5554611219786;4007;79477;79829.20170798276;79952.20047799505;80947.59526202331;82307;11242.269252498561;11310.660680179608;11464.54141834334;11471.655850324503;11598.768024639628;24249.03003879825;24325;24435.144769932966;24441;24621;7656.234376562411;7784.299413052852;7808.453408261367;7907.84184316322;7985.560794156378;4326.502452217972;4337.522872484024;4442.511323754385;4471.150481408587;4511.007578332761;3610.530631017951;3686.6866316362875;3709.9814500927323;3713.442983552489;4065.2682517146604;720.9150228905569;722.6495149852317;727.3308556128375;733.5048842031714;735.7351353512731;752.3492179264897;767.919368466303;772.8531578999972;789.8578255913876;800.3277247112453;9126;10008.49957502122;10057.748556286006;10353.654024976855;10378.688639340831;767.666065261613;789.1595450844832;792.2117493094293;793.9523628582303;810.7040930060485;4618.376519169936;4782.928256076161;5005.18891112313;5035.843003683355;5057.165567681292;78307;80943.59528202322;81254;81312;83253.58373208095;57346.42653573494;61131.38868611346;69967.65016174989;71375.2862471379;71782;61115.6944215285;62912.68543657252;62969.37030629726;63472.365276346645;63564;9517.857232141385;9781.902180978099;9787.46168960714;9801.16690081351;9805.215582753506;42235;42789.7163085108;43330.13339733251;43816.90457738454;45057.09885802331;51212.74393628008;51518;53342;54318;54556;12442.191257568229;12471.438785254504;12531.436085375997;12595.87404125947;13221.272829994443;12426.130170887951;12479.438425270702;12514.18657787241;12862.742745144858;12890.033247506288;11552.768944621228;11909.642710718692;11921.582744603897;12056.397180141134;12366.134370593973;11957.581484647995;12355.567555135527;12423.254604723745;12447.128700990843;12820;11737.589184378507;11746.823797642872;11863.940680296544;12063.155579109378;12654.050946179257;9903.994922045475;10139.949300253451;10254.179665626583;10322.948385258025;10329.793404131726;8453.450525715809;8742.825143496968;9169.203392964942;9779.853302200616;9835.606575737176 12:08:29 INFO - PROCESS | 11609 | __end_tp_report 12:08:29 INFO - PROCESS | 11609 | __start_cc_report 12:08:29 INFO - PROCESS | 11609 | _x_x_mozilla_cycle_collect,311 12:08:29 INFO - PROCESS | 11609 | __end_cc_report 12:08:29 INFO - PROCESS | 11609 | __startTimestamp1483992509785__endTimestamp 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | ------- Summary: start ------- 12:08:29 INFO - PROCESS | 11609 | Number of tests: 6 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | [#0] dojo.html Cycles:165 Average:5445.42 Median:5645.69 stddev:604.52 (10.7%) stddev-sans-first:578.42 12:08:29 INFO - PROCESS | 11609 | Values: 3129.4 3196.5 3197.0 3201.2 3227.5 5337.5 5407.9 5454.6 5462.8 5488.6 5342.0 5423.3 5451.5 5479.3 5556.1 4900.2 4919.6 4951.2 5010.2 5059.8 4833.4 4963.6 4970.4 4984.5 4989.1 4922.8 5059.4 5091.9 5109.5 5114.7 4918.5 4976.1 5007.7 5017.0 5097.6 4960.5 4973.4 4992.5 5008.9 5023.2 5427.7 5485.0 5505.0 5517.5 5527.1 5744.2 5778.2 5790.7 5797.1 5801.7 5888.1 5921.1 5922.7 5934.6 5965.2 5436.4 5495.6 5497.3 5501.9 5510.3 5906.1 5923.4 5951.0 5962.4 5968.8 5747.7 5789.0 5797.4 5840.1 5849.4 5814.0 5860.2 5870.1 5884.5 5905.9 5795.8 5835.3 5846.4 5938.6 5944.5 5916.1 5918.6 5919.1 5925.1 5961.4 4472.1 4590.2 4592.3 4593.7 4599.0 4017.6 4043.4 4076.1 4078.4 4085.3 5427.9 5468.3 5474.6 5496.4 5504.1 5717.9 5772.4 5904.3 5916.4 5930.7 5582.2 5607.7 5614.2 5645.7 5657.6 5082.0 5082.3 5091.7 5092.3 5121.2 5884.9 6130.4 6138.9 6193.2 6217.9 5711.6 5725.3 5742.2 5760.4 5827.2 6038.5 6064.6 6076.8 6101.1 6104.5 5682.4 5690.6 5702.3 5712.9 5746.3 5773.0 5811.2 5890.4 5915.6 5948.5 5718.4 5769.3 5776.4 5778.3 5823.4 5720.8 5725.5 5756.4 5757.5 5764.3 5520.4 5521.6 5560.2 5566.7 5763.3 5656.6 5658.1 5668.1 5692.5 5702.3 5568.9 5581.4 5587.5 5594.7 5603.9 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | [#1] ext.html Cycles:180 Average:60650.33 Median:36059.78 stddev:128384.09 (356.0%) stddev-sans-first:128664.90 12:08:29 INFO - PROCESS | 11609 | Values: 534.2 566.4 598.8 612.2 614.3 40536.4 41208.6 45148.5 45181.3 45227.8 46400.8 47365.5 47433.1 47451.3 47474.5 8994.9 10468.5 10871.6 10873.3 10897.9 10452.7 10490.8 10511.3 10551.4 10559.6 10624.7 10626.8 10638.9 10703.2 10709.4 10582.4 10645.3 10646.6 10652.5 10659.5 10431.0 10457.9 10471.8 10503.6 10546.7 39054.4 39482.8 39512.0 39515.6 39650.4 4109.3 4142.6 4201.5 4216.7 4269.1 29472.7 29688.3 29771.9 29825.6 29890.1 4141.4 4211.7 4262.1 4298.5 4426.3 321264.4 321492.0 321538.0 322380.0 322930.0 53873.5 54386.7 54575.0 54687.0 54733.0 51249.2 51310.7 51460.7 51479.0 51651.0 13941.2 15034.2 15293.2 15430.4 15447.1 11260.6 12355.1 12547.6 12577.8 12606.6 17739.8 17866.0 17876.8 17964.7 18050.4 7093.3 7132.9 7239.2 7378.2 7499.6 924.0 947.4 955.6 961.2 1001.1 31801.2 32120.0 32140.5 32376.2 32850.8 1113.2 1125.5 1153.4 1155.3 1250.6 17295.0 17367.7 17431.6 17508.9 17605.6 444576.0 677160.0 686775.0 689720.0 691534.0 54629.2 54850.0 55229.7 55562.4 55644.2 1480.9 1485.6 1498.6 1502.2 1509.9 28475.3 30269.4 30425.5 30663.7 30950.7 48159.0 48556.8 48639.0 48878.8 48945.8 412640.0 414309.0 415472.0 417788.0 418273.0 26591.2 27160.7 27197.3 27305.2 28912.4 42408.6 42528.4 43967.6 44179.0 44599.8 36320.3 36776.8 37143.3 37526.3 38188.6 37261.6 37517.8 37518.4 37737.4 37820.4 35799.3 36722.4 36763.3 36811.4 37702.0 31669.0 32351.8 33087.8 33315.5 33331.5 25097.1 25302.7 25306.6 25422.9 25612.9 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | [#2] jquery.html Cycles:180 Average:34547.08 Median:21778.90 stddev:109292.21 (501.8%) stddev-sans-first:109568.75 12:08:29 INFO - PROCESS | 11609 | Values: 415.5 424.2 436.3 436.3 438.7 19357.9 21294.5 21483.0 21894.5 22056.3 20977.5 21640.1 21663.4 21916.1 22023.9 5839.3 6053.8 6062.5 6080.5 6120.1 5716.5 5933.6 5933.9 5941.3 6096.8 6036.6 6089.3 6093.8 6100.1 6101.3 5687.5 5896.5 5928.9 6005.5 6015.2 5663.9 5795.9 5821.9 5860.4 5895.2 13799.9 14035.2 14036.4 14070.9 22671.2 2890.8 3061.4 3110.0 3169.3 3328.4 10003.8 10367.7 10430.4 10656.4 10775.9 1791.1 1797.8 1800.4 1876.4 1970.4 92157.0 92674.0 92750.5 93065.0 93647.5 11988.8 12006.7 12209.8 12272.0 12343.7 16845.1 16866.7 16875.6 16876.7 16894.6 8345.3 8649.2 8678.5 8732.3 8839.2 8106.9 8226.1 8283.0 8459.4 8488.6 5130.8 5132.8 5154.2 5169.2 5274.2 2013.6 2060.6 2093.5 2136.2 2152.5 1117.8 1140.3 1141.2 1141.3 1174.7 19357.5 19850.4 19882.6 19882.8 20176.8 1100.8 1101.2 1107.1 1133.8 1134.8 10851.7 11013.6 11016.4 11066.9 11113.6 638420.0 642244.0 675448.0 683447.0 688124.0 76768.2 100126.0 102225.0 102836.0 105486.0 961.8 971.3 994.5 1004.1 1008.2 16681.9 16792.9 16946.0 16969.9 17239.3 40820.4 40952.8 41728.6 42027.8 43141.8 57174.0 58274.0 58487.7 59265.7 59289.8 7238.5 8511.0 8714.8 8818.5 8891.5 11599.0 13760.5 13847.9 13889.7 13923.9 10894.9 11749.0 11824.6 12056.2 12176.3 12016.6 12045.5 12214.0 12442.7 12773.2 11900.3 12191.1 12238.3 12295.9 12379.9 8919.5 9020.3 9117.8 9173.8 9486.8 11782.2 11797.4 11898.3 12001.8 12048.3 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | [#3] mootools.html Cycles:180 Average:5419.22 Median:5177.71 stddev:2938.85 (56.8%) stddev-sans-first:2932.33 12:08:29 INFO - PROCESS | 11609 | Values: 1498.7 1500.9 1513.1 1516.2 1524.7 7515.7 7758.7 7765.5 8215.3 8216.7 7950.9 8182.3 8199.8 8361.4 8384.0 2198.7 2231.9 2245.0 2246.7 2251.2 2275.8 2310.6 2319.9 2339.2 2346.4 2273.5 2298.7 2307.7 2312.0 2319.5 2128.8 2131.6 2144.4 2155.7 2161.5 2243.9 2270.2 2272.1 2277.4 2284.9 8344.4 8367.8 8426.1 8437.2 8456.2 5048.5 5150.9 5172.3 5177.0 5178.5 3016.3 3139.6 3369.9 3374.0 3377.0 1327.6 1372.6 1383.1 1402.8 1405.1 11037.6 11043.9 11044.9 11078.0 11085.3 4193.3 4491.2 4500.1 4590.2 4624.9 9794.9 9802.4 9834.3 9847.7 9870.8 5188.1 5220.1 5221.8 5222.3 5222.7 4213.5 4704.2 4776.5 4791.4 4844.7 3845.7 3902.6 3945.2 3958.4 3960.0 1270.5 1273.1 1274.3 1283.6 1287.7 988.4 992.6 1004.2 1006.3 1011.9 5515.3 5532.4 5570.8 5648.1 5713.2 991.4 1021.9 1041.2 1051.3 1066.0 3707.6 3758.2 3775.2 3800.2 3810.7 9654.2 9795.1 9879.7 9895.0 9902.0 9774.0 9847.1 9854.9 9870.6 9875.2 7417.2 7630.8 7737.7 7867.5 7872.6 5560.4 5576.4 5620.7 5645.7 5875.7 8774.0 8954.0 9003.2 9073.4 9180.7 8989.0 9033.4 9033.8 9080.3 9082.3 6960.6 7152.2 7209.2 7215.6 7323.6 7860.6 7892.3 7900.7 7901.4 7926.8 7033.9 7138.7 7216.4 7233.3 7263.1 6828.1 6894.2 6916.3 7035.4 7096.1 6054.2 6105.8 6108.1 6119.8 6123.3 4742.7 4794.5 4846.1 4885.5 4900.7 4899.1 4922.5 4933.4 5009.8 5027.6 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | [#4] prototype.html Cycles:180 Average:4805.60 Median:5366.30 stddev:1405.15 (26.2%) stddev-sans-first:1369.08 12:08:29 INFO - PROCESS | 11609 | Values: 369.6 388.6 393.4 400.5 409.3 5240.0 5349.5 5395.9 5448.8 5466.3 5270.3 5363.8 5393.1 5421.3 5439.5 4364.6 4368.3 4375.0 4377.3 4380.3 4007.4 4204.2 4369.0 4380.7 4396.7 4216.3 4229.2 4229.4 4233.7 4257.7 4219.7 4220.5 4229.2 4263.3 4278.5 3777.5 3778.7 3784.9 3786.5 3809.6 5075.9 5241.7 5248.9 5254.2 5271.4 4826.8 4833.3 4853.9 4853.9 4875.9 5517.3 5704.6 5746.8 5759.9 5778.6 4090.8 4096.5 4111.9 4122.9 4150.5 6021.1 6056.2 6062.2 6081.7 6112.8 4057.3 4252.3 4260.8 4265.7 4280.3 4236.7 4247.6 4256.5 4256.5 4271.2 4821.5 4843.5 4862.2 4868.2 4874.7 5521.7 5765.0 5765.9 5787.4 5802.0 1417.8 1435.2 1440.1 1446.4 1448.8 950.8 983.1 1001.8 1015.5 1019.5 5275.8 5279.9 5291.5 5319.8 5337.2 5648.9 5691.1 5731.4 5731.4 5739.9 5008.6 5100.3 5230.7 5305.0 5368.8 3014.4 3015.0 3035.7 3042.4 3050.2 5887.3 5893.2 5925.6 5947.3 5966.7 5669.5 5977.3 6001.5 6020.3 6032.0 6068.0 6070.7 6075.4 6090.3 6103.7 5584.0 5836.4 5841.1 5852.5 5882.7 5785.7 5787.7 5813.0 5851.4 5879.4 5810.3 6111.2 6131.4 6133.3 6146.4 4124.7 4143.3 4201.0 4214.2 4224.2 5892.6 5904.5 5908.5 5928.7 5934.3 5594.6 5776.7 5779.8 5783.5 5800.6 5705.9 5731.6 5734.5 5760.9 5786.6 5730.5 5735.2 5745.8 5772.3 5794.4 5475.4 5621.8 5723.5 5725.6 5754.9 5599.5 5611.5 5613.9 5622.7 5662.7 12:08:29 INFO - PROCESS | 11609 | 12:08:29 INFO - PROCESS | 11609 | [#5] yui.html Cycles:180 Average:17437.86 Median:5020.52 stddev:22578.05 (449.7%) stddev-sans-first:22606.72 12:08:29 INFO - PROCESS | 11609 | Values: 774.6 778.0 822.9 883.7 900.8 14084.4 15275.6 15315.3 15338.7 15434.7 14052.1 14287.3 14295.6 14299.4 14330.6 632.8 651.4 723.1 738.1 748.4 739.8 744.0 744.7 748.8 750.5 781.6 786.3 789.1 789.1 789.2 775.4 780.5 783.8 785.3 788.0 574.2 574.4 574.5 574.5 575.5 15024.4 15030.5 15137.7 15239.6 15419.1 14951.7 15568.3 15883.4 15931.8 16371.3 12140.6 12261.0 12342.5 12388.9 12526.9 3773.7 3860.7 3864.3 3865.6 4007.0 79477.0 79829.2 79952.2 80947.6 82307.0 11242.3 11310.7 11464.5 11471.7 11598.8 24249.0 24325.0 24435.1 24441.0 24621.0 7656.2 7784.3 7808.5 7907.8 7985.6 4326.5 4337.5 4442.5 4471.2 4511.0 3610.5 3686.7 3710.0 3713.4 4065.3 720.9 722.6 727.3 733.5 735.7 752.3 767.9 772.9 789.9 800.3 9126.0 10008.5 10057.7 10353.7 10378.7 767.7 789.2 792.2 794.0 810.7 4618.4 4782.9 5005.2 5035.8 5057.2 78307.0 80943.6 81254.0 81312.0 83253.6 57346.4 61131.4 69967.7 71375.3 71782.0 61115.7 62912.7 62969.4 63472.4 63564.0 9517.9 9781.9 9787.5 9801.2 9805.2 42235.0 42789.7 43330.1 43816.9 45057.1 51212.7 51518.0 53342.0 54318.0 54556.0 12442.2 12471.4 12531.4 12595.9 13221.3 12426.1 12479.4 12514.2 12862.7 12890.0 11552.8 11909.6 11921.6 12056.4 12366.1 11957.6 12355.6 12423.3 12447.1 12820.0 11737.6 11746.8 11863.9 12063.2 12654.1 9904.0 10139.9 10254.2 10322.9 10329.8 8453.5 8742.8 9169.2 9779.9 9835.6 12:08:29 INFO - PROCESS | 11609 | -------- Summary: end -------- 12:08:29 INFO - PROCESS | 11609 | 12:08:30 INFO - TEST-INFO | 11609: exit 0 12:08:30 INFO - TEST-OK | dromaeo_css | took 1113943ms 12:08:30 INFO - TEST-START | kraken 12:08:30 INFO - operating with platform_type : linux_ 12:08:30 INFO - Initialising browser for kraken test... 12:08:30 INFO - TEST-INFO | started process 11959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJvTMp9/profile http://localhost:35165/getInfo.html) 12:08:30 INFO - PROCESS | 11959 | 1483992510966 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 12:08:34 INFO - PROCESS | 11959 | __metrics Screen width/height:1600/1200 12:08:34 INFO - PROCESS | 11959 | colorDepth:24 12:08:34 INFO - PROCESS | 11959 | Browser inner width/height: 1024/697 12:08:34 INFO - PROCESS | 11959 | __metrics 12:08:35 ERROR - PROCESS | 11959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 12:08:36 INFO - TEST-INFO | 11959: exit 0 12:08:36 INFO - Browser initialized. 12:08:36 INFO - Running cycle 1/1 for kraken test... 12:08:36 INFO - TEST-INFO | started process 12082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJvTMp9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:08:47 INFO - PROCESS | 12082 | RSS: Main: 155365376 12:08:47 INFO - PROCESS | 12082 | 12:08:50 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:51 INFO - PROCESS | 12082 | RSS: Main: 160911360 12:08:51 INFO - PROCESS | 12082 | 12:08:53 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-dft) 12:08:54 INFO - PROCESS | 12082 | RSS: Main: 160043008 12:08:54 INFO - PROCESS | 12082 | 12:08:57 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-fft) 12:08:57 INFO - PROCESS | 12082 | RSS: Main: 157335552 12:08:57 INFO - PROCESS | 12082 | 12:09:00 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35165/tests/kraken/driver.html?testName=audio-oscillator) 12:09:00 INFO - PROCESS | 12082 | RSS: Main: 157384704 12:09:00 INFO - PROCESS | 12082 | 12:09:02 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:03 INFO - PROCESS | 12082 | RSS: Main: 157728768 12:09:03 INFO - PROCESS | 12082 | 12:09:06 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35165/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:07 INFO - PROCESS | 12082 | RSS: Main: 162099200 12:09:07 INFO - PROCESS | 12082 | 12:09:10 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35165/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:11 INFO - PROCESS | 12082 | RSS: Main: 161992704 12:09:11 INFO - PROCESS | 12082 | 12:09:13 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35165/tests/kraken/driver.html?testName=json-parse-financial) 12:09:14 INFO - PROCESS | 12082 | RSS: Main: 161648640 12:09:14 INFO - PROCESS | 12082 | 12:09:16 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:16 INFO - PROCESS | 12082 | RSS: Main: 161341440 12:09:16 INFO - PROCESS | 12082 | 12:09:18 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:19 INFO - PROCESS | 12082 | RSS: Main: 161296384 12:09:19 INFO - PROCESS | 12082 | 12:09:21 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:21 INFO - PROCESS | 12082 | RSS: Main: 161271808 12:09:21 INFO - PROCESS | 12082 | 12:09:24 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:25 INFO - PROCESS | 12082 | RSS: Main: 161513472 12:09:25 INFO - PROCESS | 12082 | 12:09:28 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:28 INFO - PROCESS | 12082 | RSS: Main: 161095680 12:09:28 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | Cycle 1(1): loaded http://localhost:35165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35165/tests/kraken/driver.html?testName=ai-astar) 12:09:30 INFO - PROCESS | 12082 | RSS: Main: 163389440 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | __start_tp_report 12:09:30 INFO - PROCESS | 12082 | _x_x_mozilla_page_load 12:09:30 INFO - PROCESS | 12082 | _x_x_mozilla_page_load_details 12:09:30 INFO - PROCESS | 12082 | |i|pagename|runs| 12:09:30 INFO - PROCESS | 12082 | |0;ai-astar;105;111;111;112;111;113;111;112;112;111 12:09:30 INFO - PROCESS | 12082 | |1;audio-beat-detection;148;120;118;164;117;123;119;119;147;118 12:09:30 INFO - PROCESS | 12082 | |2;audio-dft;163;163;163;160;162;166;166;168;161;164 12:09:30 INFO - PROCESS | 12082 | |3;audio-fft;76;76;77;105;80;78;76;76;90;76 12:09:30 INFO - PROCESS | 12082 | |4;audio-oscillator;83;84;97;83;83;83;95;84;85;114 12:09:30 INFO - PROCESS | 12082 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;119;118;118 12:09:30 INFO - PROCESS | 12082 | |6;imaging-darkroom;149;148;148;148;150;148;149;146;148;148 12:09:30 INFO - PROCESS | 12082 | |7;imaging-desaturate;96;97;96;96;96;97;96;97;96;101 12:09:30 INFO - PROCESS | 12082 | |8;json-parse-financial;57;58;59;60;58;59;60;59;58;59 12:09:30 INFO - PROCESS | 12082 | |9;json-stringify-tinderbox;67;68;72;67;68;67;66;67;68;68 12:09:30 INFO - PROCESS | 12082 | |10;stanford-crypto-aes;84;83;82;83;83;82;88;82;83;82 12:09:30 INFO - PROCESS | 12082 | |11;stanford-crypto-ccm;126;128;137;125;149;126;135;143;175;124 12:09:30 INFO - PROCESS | 12082 | |12;stanford-crypto-pbkdf2;173;171;172;169;177;175;169;169;167;166 12:09:30 INFO - PROCESS | 12082 | |13;stanford-crypto-sha256-iterative;63;63;63;64;63;63;66;62;65;61 12:09:30 INFO - PROCESS | 12082 | __end_tp_report 12:09:30 INFO - PROCESS | 12082 | __start_cc_report 12:09:30 INFO - PROCESS | 12082 | _x_x_mozilla_cycle_collect,727 12:09:30 INFO - PROCESS | 12082 | __end_cc_report 12:09:30 INFO - PROCESS | 12082 | __startTimestamp1483992570722__endTimestamp 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | ------- Summary: start ------- 12:09:30 INFO - PROCESS | 12082 | Number of tests: 14 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.18 (2.0%) stddev-sans-first:0.73 12:09:30 INFO - PROCESS | 12082 | Values: 105.0 111.0 111.0 112.0 111.0 113.0 111.0 112.0 112.0 111.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:121.50 stddev:17.04 (14.0%) stddev-sans-first:16.67 12:09:30 INFO - PROCESS | 12082 | Values: 148.0 120.0 118.0 164.0 117.0 123.0 119.0 119.0 147.0 118.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 12:09:30 INFO - PROCESS | 12082 | Values: 163.0 163.0 163.0 160.0 162.0 166.0 166.0 168.0 161.0 164.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.50 stddev:9.48 (12.4%) stddev-sans-first:9.88 12:09:30 INFO - PROCESS | 12082 | Values: 76.0 76.0 77.0 105.0 80.0 78.0 76.0 76.0 90.0 76.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:84.00 stddev:10.19 (12.1%) stddev-sans-first:10.57 12:09:30 INFO - PROCESS | 12082 | Values: 83.0 84.0 97.0 83.0 83.0 83.0 95.0 84.0 85.0 114.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:09:30 INFO - PROCESS | 12082 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 12:09:30 INFO - PROCESS | 12082 | Values: 149.0 148.0 148.0 148.0 150.0 148.0 149.0 146.0 148.0 148.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 12:09:30 INFO - PROCESS | 12082 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 101.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:0.95 (1.6%) stddev-sans-first:0.78 12:09:30 INFO - PROCESS | 12082 | Values: 57.0 58.0 59.0 60.0 58.0 59.0 60.0 59.0 58.0 59.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.62 (2.4%) stddev-sans-first:1.69 12:09:30 INFO - PROCESS | 12082 | Values: 67.0 68.0 72.0 67.0 68.0 67.0 66.0 67.0 68.0 68.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.81 (2.2%) stddev-sans-first:1.90 12:09:30 INFO - PROCESS | 12082 | Values: 84.0 83.0 82.0 83.0 83.0 82.0 88.0 82.0 83.0 82.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:15.86 (11.7%) stddev-sans-first:16.33 12:09:30 INFO - PROCESS | 12082 | Values: 126.0 128.0 137.0 125.0 149.0 126.0 135.0 143.0 175.0 124.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.50 stddev:3.49 (2.0%) stddev-sans-first:3.61 12:09:30 INFO - PROCESS | 12082 | Values: 173.0 171.0 172.0 169.0 177.0 175.0 169.0 169.0 167.0 166.0 12:09:30 INFO - PROCESS | 12082 | 12:09:30 INFO - PROCESS | 12082 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:1.50 12:09:30 INFO - PROCESS | 12082 | Values: 63.0 63.0 63.0 64.0 63.0 63.0 66.0 62.0 65.0 61.0 12:09:30 INFO - PROCESS | 12082 | -------- Summary: end -------- 12:09:30 INFO - PROCESS | 12082 | 12:09:31 INFO - TEST-INFO | 12082: exit 0 12:09:31 INFO - TEST-OK | kraken | took 61310ms 12:09:31 INFO - SUITE-END | took 1175s 12:09:31 INFO - Completed test suite (00:19:35) 12:09:31 INFO - javascript benchmark 12:09:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7249.78996244753, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.405412971535, 3196.4725820239655, 3196.952045719313, 3201.2020677954297, 3227.5158726191053, 5337.5196232339085, 5407.91888121678, 5454.61817672763, 5462.754176062077, 5488.64323818952, 5341.973290133544, 5423.267858839055, 5451.536619387357, 5479.2602998595175, 5556.083246264372, 4900.166971614834, 4919.60643148549, 4951.158303088484, 5010.173321401964, 5059.848204553869, 4833.3716616839765, 4963.602911767068, 4970.378702662168, 4984.501549845023, 4989.052080104769, 4922.75386230687, 5059.367579052619, 5091.9236211456855, 5109.463506331819, 5114.718690472023, 4918.483559226302, 4976.129177393942, 5007.749612519359, 5017.0, 5097.617678674077, 4960.479149689267, 4973.378327709036, 4992.500749924979, 5008.899822003539, 5023.2214006828635, 5427.674339539601, 5485.040117979377, 5505.0, 5517.475839795213, 5527.143292789624, 5744.22452968848, 5778.219940308047, 5790.739416726257, 5797.130430435426, 5801.6519008859605, 5888.087346461305, 5921.052631578927, 5922.7038648067855, 5934.554908381845, 5965.164876917235, 5436.374816896068, 5495.560355171577, 5497.312835895513, 5501.9174712378945, 5510.311211098613, 5906.143609176731, 5923.378045305181, 5951.0, 5962.40375962409, 5968.820935371946, 5747.712614369265, 5789.0, 5797.449242321973, 5840.123981402823, 5849.415058494202, 5813.970930145407, 5860.150278209721, 5870.060790273621, 5884.47039766423, 5905.940940590625, 5795.82612521625, 5835.270591176103, 5846.356900740915, 5938.584299099021, 5944.464998150101, 5916.083007133901, 5918.585699001114, 5919.082542205965, 5925.140854576062, 5961.433663801932, 4472.127935052698, 4590.242609969385, 4592.288195329729, 4593.724376537419, 4599.0, 4017.598240175959, 4043.3732771420478, 4076.1236334188293, 4078.408630748584, 4085.2850751118435, 5427.945720542823, 5468.28912241406, 5474.562035037187, 5496.395396506381, 5504.146857237055, 5717.942820571824, 5772.365039845614, 5904.261967254093, 5916.408359164049, 5930.733117009745, 5582.190582365615, 5607.719614019283, 5614.1859430382365, 5645.68948707825, 5657.57568182388, 5082.0, 5082.288479612857, 5091.694498330112, 5092.312537807423, 5121.231815227746, 5884.941150588611, 6130.386961303923, 6138.938610613926, 6193.225846769154, 6217.906731399033, 5711.628744131618, 5725.2843394575675, 5742.16738572913, 5760.366359700346, 5827.213326201078, 6038.51691864641, 6064.605800622945, 6076.756929722762, 6101.054336577838, 6104.481119104926, 5682.431756824284, 5690.573207009408, 5702.344230413555, 5712.942870571241, 5746.281714785652, 5772.960867043805, 5811.186433899342, 5890.410958904075, 5915.58590898633, 5948.464638182584, 5718.3773731266165, 5769.278840144982, 5776.42235776419, 5778.306603207642, 5823.417658234142, 5720.8283751487525, 5725.541956643542, 5756.395578464201, 5757.453041961007, 5764.308283005898, 5520.447955204608, 5521.613487055867, 5560.19377190297, 5566.749496272597, 5763.308402991668, 5656.5757568181725, 5658.122990936411, 5668.093105103164, 5692.516136128475, 5702.315722113373, 5568.9443105568425, 5581.358143813513, 5587.525060369914, 5594.720263986703, 5603.8879222416135], "value": 5405.580422706418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.205070961569, 566.3543560341211, 598.7934162713863, 612.2163630552894, 614.342653360904, 40536.391954120714, 41208.58791412085, 45148.54851451484, 45181.32228016574, 45227.77386113073, 46400.76799616006, 47365.52634473654, 47433.05133897329, 47451.28823067657, 47474.52525474753, 8994.865077023866, 10468.528916198751, 10871.565137394495, 10873.293235939638, 10897.945510272477, 10452.686419407391, 10490.79018419635, 10511.316764410327, 10551.366917984946, 10559.577616895314, 10624.734381640443, 10626.840597391045, 10638.946805265963, 10703.197260205478, 10709.410982395964, 10582.365058096539, 10645.30805497644, 10646.57413703451, 10652.467376631215, 10659.467026648637, 10431.0, 10457.9477102614, 10471.84292235617, 10503.579856805718, 10546.736331591695, 39054.41418378727, 39482.80258598689, 39512.0, 39515.60484395177, 39650.40524392136, 4109.321961876287, 4142.606452387048, 4201.516825565069, 4216.746995180299, 4269.146170765828, 29472.70527294721, 29688.257793555116, 29771.85114074416, 29825.552616710767, 29890.10329690113, 4141.4409054777525, 4211.684123690736, 4262.083652014831, 4298.484181898192, 4426.26966550522, 321264.39367803244, 321492.0, 321538.0, 322380.0, 322930.0, 53873.461265386846, 54386.72806636021, 54575.0, 54687.0, 54733.0, 51249.23126153111, 51310.743446283275, 51460.74269628628, 51479.0, 51651.0, 13941.233232172328, 15034.248287585795, 15293.158876261912, 15430.38278468871, 15447.0731756095, 11260.605878794368, 12355.135140540076, 12547.560835370901, 12577.811332830015, 12606.558770443175, 17739.822601774074, 17866.0, 17876.821231787777, 17964.730529042074, 18050.368237111637, 7093.304544273144, 7132.857342853114, 7239.167495737952, 7378.225286344964, 7499.6250187490405, 923.9953800231091, 947.393668052447, 955.5843208204453, 961.1877963121151, 1001.0640051551823, 31801.204969875937, 32120.0, 32140.517892231634, 32376.190595235308, 32850.83574582112, 1113.2429947635685, 1125.4879030041475, 1153.423288355822, 1155.3183621663259, 1250.593557093948, 17295.0, 17367.65264694699, 17431.56421089483, 17508.912455437643, 17605.559861003578, 444576.0, 677160.0, 686775.0, 689720.0, 691534.0, 54629.1805622916, 54850.0, 55229.723851380484, 55562.44437555573, 55644.16533751997, 1480.9259537023322, 1485.6360191752874, 1498.5579254120062, 1502.1512845242403, 1509.8867584931174, 28475.28811779722, 30269.394612108073, 30425.543616846207, 30663.693363066082, 30950.690493094782, 48159.0, 48556.75721621369, 48639.0, 48878.75560622317, 48945.75527122342, 412640.0, 414309.0, 415472.0, 417788.0, 418273.0, 26591.20226393211, 27160.72839271582, 27197.320066998484, 27305.180844574694, 28912.42175156443, 42408.575914241694, 42528.362074568286, 43967.56032439763, 44179.0, 44599.77700111608, 36320.27359452743, 36776.816115919246, 37143.25713485661, 37526.31131599139, 38188.618113818506, 37261.627383726904, 37517.81241093777, 37518.43722344113, 37737.43393849149, 37820.43269351017, 35799.28401432009, 36722.44916326204, 36763.26473470462, 36811.447828282064, 37702.0, 31669.0, 32351.838240809586, 33087.83456082704, 33315.500267495525, 33331.500027499125, 25097.121600743885, 25302.74697253004, 25306.620400693635, 25422.872885635454, 25612.871935640203], "value": 20031.697749220377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.45160388287474, 424.20303099907625, 436.3128073284578, 436.3215200363435, 438.73018093872275, 19357.903210483946, 21294.46763830903, 21483.03326350316, 21894.452638684, 22056.33830985073, 20977.47556311093, 21640.134394624198, 21663.35009949704, 21916.123355065818, 22023.889880550614, 5839.270091238605, 6053.757849686007, 6062.545309101813, 6080.483158931496, 6120.081987701836, 5716.485516303532, 5933.584649074566, 5933.940660593382, 5941.316748573904, 6096.7561297548045, 6036.637801731888, 6089.330173680892, 6093.78671746489, 6100.084987251903, 6101.267847858263, 5687.459691329317, 5896.469317761379, 5928.851778705523, 6005.4595086442, 6015.157877897098, 5663.886722265573, 5795.88408231833, 5821.854453638651, 5860.384659610765, 5895.204147440084, 13799.931000345034, 14035.228062456561, 14036.438542458289, 14070.85929140716, 22671.206507772313, 2890.7976441649093, 3061.4336347775734, 3109.9844500777576, 3169.255225022118, 3328.417526932777, 10003.799924001552, 10367.688969330931, 10430.37417754937, 10656.360618362845, 10775.892241077645, 1791.0686443049542, 1797.766290382255, 1800.4238643634042, 1876.4089311866855, 1970.3990282963691, 92157.0, 92673.99999999933, 92750.536247319, 93065.0, 93647.53176234075, 11988.76022479563, 12006.699832504257, 12209.755804883853, 12272.0, 12343.69140771488, 16845.073520956466, 16866.746998795028, 16875.624875025045, 16876.662466750597, 16894.57763555921, 8345.332373410112, 8649.221570058726, 8678.522681252593, 8732.257758090633, 8839.204471597586, 8106.918930810734, 8226.136255693185, 8283.0, 8459.407841451039, 8488.575571221538, 5130.846074617767, 5132.767246247894, 5154.201098829687, 5169.198774190007, 5274.182501712241, 2013.5570174561574, 2060.6187855246826, 2093.4975605854484, 2136.2309568555306, 2152.547964927383, 1117.8155604325357, 1140.3395101723395, 1141.223967701954, 1141.3095077478172, 1174.6769638349522, 19357.51606209856, 19850.404487865388, 19882.60234795296, 19882.801171988383, 20176.798232017787, 1100.8128618134776, 1101.2346419238713, 1107.1419649771492, 1133.790248803974, 1134.8184290513477, 10851.6846646881, 11013.614523491638, 11016.394098324508, 11066.889331106748, 11113.555457781598, 638420.0, 642244.0, 675448.0, 683447.0, 688124.0, 76768.23231767722, 100126.0, 102225.0, 102836.0, 105486.0, 961.8172547216006, 971.3103696375512, 994.4828689081637, 1004.1063453526367, 1008.1884083313004, 16681.91659041697, 16792.916035419745, 16946.0, 16969.915150424167, 17239.310427582757, 40820.38769418521, 40952.79523602363, 41728.58271417247, 42027.7898610505, 43141.784291078344, 57174.0, 58274.0, 58487.70756146192, 59265.703671481366, 59289.814203716545, 7238.52949558277, 8510.957445212734, 8714.782130446789, 8818.51498167607, 8891.510966896883, 11599.0, 13760.518381856587, 13847.86152138506, 13889.722205556034, 13923.860761392256, 10894.891051089704, 11749.0, 11824.586139485076, 12056.216345937486, 12176.330301833485, 12016.63950081464, 12045.51817927273, 12214.0, 12442.688932776391, 12773.23360598367, 11900.345480998629, 12191.146619736888, 12238.326892021025, 12295.877041229473, 12379.947704445223, 8919.509426981318, 9020.278377729635, 9117.77205569866, 9173.816523669622, 9486.810263794823, 11782.17524773292, 11797.35114568707, 11898.263399418356, 12001.819972700241, 12048.277103373826], "value": 9697.946038927103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.6777842763804, 1500.917449540275, 1513.1375116183776, 1516.2039929037262, 1524.656952185758, 7515.699372025126, 7758.6896524138965, 7765.456418050739, 8215.342772578195, 8216.712415065467, 7950.880736788953, 8182.345412366996, 8199.795005124875, 8361.414700970934, 8384.0, 2198.67019947008, 2231.8884055797225, 2244.9887750561224, 2246.7191601049867, 2251.223327951854, 2275.7951784339407, 2310.584094862924, 2319.946847040373, 2339.2397470821966, 2346.3547524430746, 2273.4771002669395, 2298.655201719747, 2307.653851922208, 2312.028947841902, 2319.5360927814504, 2128.8084072433558, 2131.5843410534953, 2144.356692992096, 2155.6550951847707, 2161.470439742265, 2243.9439014024615, 2270.2167752125492, 2272.102519504803, 2277.3851060213815, 2284.931452056441, 8344.41589088764, 8367.8326433471, 8426.073131955542, 8437.156284371515, 8456.154384561494, 5048.495150484959, 5150.896982060338, 5172.301739265189, 5176.964607078562, 5178.456262092502, 3016.3213277012715, 3139.607549056368, 3369.949450758241, 3373.96626033739, 3377.0, 1327.5552689848912, 1372.574501904403, 1383.1424516799648, 1402.8246469191351, 1405.1428628536585, 11037.613683521038, 11043.889561104446, 11044.944775276153, 11078.0, 11085.27945683536, 4193.287141186006, 4491.236489796743, 4500.054988452396, 4590.150822097922, 4624.907501849944, 9794.902050979541, 9802.36284641496, 9834.262430317754, 9847.655332063343, 9870.802583948282, 5188.11801993662, 5220.112580861262, 5221.765020574083, 5222.321098257278, 5222.686638801684, 4213.5154457237195, 4704.1767690654, 4776.546228108324, 4791.448983366958, 4844.685095468783, 3845.65389114981, 3902.6292502212814, 3945.151792364655, 3958.4062390641634, 3959.980200098981, 1270.4727538071597, 1273.0706584193406, 1274.2927675140386, 1283.582835578422, 1287.7038281195378, 988.3970777825521, 992.6426486464867, 1004.1815920025156, 1006.2654262388351, 1011.858339832424, 5515.338159420895, 5532.391436942014, 5570.777168913198, 5648.096304591246, 5713.228714123623, 991.3853410885154, 1021.9386836789816, 1041.1514615588271, 1051.3481641382239, 1066.024587502442, 3707.610700876423, 3758.229562939591, 3775.244951009809, 3800.1639639279315, 3810.6951443884423, 9654.22766178704, 9795.118439340351, 9879.703608891745, 9895.0, 9902.0, 9774.0, 9847.064528869745, 9854.901450985542, 9870.631048548441, 9875.209983201326, 7417.221191774894, 7630.7710768677025, 7737.729179478692, 7867.527948323119, 7872.645730942007, 5560.443955604407, 5576.442355764391, 5620.74706638194, 5645.71771411436, 5875.735591898289, 8773.956130219309, 8954.0, 9003.234725048444, 9073.364864459425, 9180.6786762463, 8989.0, 9033.412828166149, 9033.77415564616, 9080.318976076689, 9082.318826087938, 6960.617166055916, 7152.177499587614, 7209.206987231296, 7215.6031418270395, 7323.597202153933, 7860.6069696513805, 7892.289693927344, 7900.723474678359, 7901.446898717035, 7926.762197134095, 7033.9296607033275, 7138.678759455733, 7216.422686185198, 7233.348998590152, 7263.055802745609, 6828.055247625626, 6894.24163342042, 6916.3429474199875, 7035.437165026888, 7096.148462184571, 6054.243219597551, 6105.84735381619, 6108.11432342299, 6119.84700382494, 6123.265208174869, 4742.66801323904, 4794.544518270759, 4846.127697014571, 4885.487023862585, 4900.705957642553, 4899.093667671492, 4922.532359425849, 4933.407991041098, 5009.77456014473, 5027.64806463544], "value": 4440.807349567962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.62298455575313, 388.6133297369118, 393.4373845401077, 400.51537639456257, 409.29192496980227, 5240.004399164166, 5349.465053494649, 5395.91906121408, 5448.7548060337285, 5466.2781223914535, 5270.288511051017, 5363.785448582052, 5393.139366918407, 5421.295231619883, 5439.5104440600335, 4364.585364390377, 4368.301071828508, 4375.0, 4377.255866502686, 4380.34294855771, 4007.398890166484, 4204.159168166364, 4369.0, 4380.7152535085115, 4396.7361958282445, 4216.283231850577, 4229.217594744967, 4229.407882896382, 4233.74597524148, 4257.7445353278745, 4219.683523735702, 4220.53574106848, 4229.154169166179, 4263.253930562139, 4278.486581610196, 3777.471154038437, 3778.6977041836585, 3784.8864534064023, 3786.545614526247, 3809.6190380961684, 5075.873103172414, 5241.737913104368, 5248.921266181011, 5254.239829657069, 5271.393789714193, 4826.831060912887, 4833.347498087784, 4853.854384368475, 4853.927191092136, 4875.8781030474165, 5517.337919449692, 5704.600677952545, 5746.827595172152, 5759.934412133769, 5778.59549831512, 4090.7750073745933, 4096.528899176603, 4111.938320925188, 4122.855700050513, 4150.522689890671, 6021.09683547467, 6056.152138700585, 6062.211912451397, 6081.726322315506, 6112.755489780404, 4057.2899742544937, 4252.319628859368, 4260.808263628144, 4265.7014009019695, 4280.272353699816, 4236.745795252233, 4247.638950689165, 4256.489221293465, 4256.531781504032, 4271.209826182167, 4821.493743156988, 4843.54693591921, 4862.197737373293, 4868.221084626513, 4874.731889746098, 5521.680894024519, 5765.0, 5765.8558536036935, 5787.392323806024, 5801.970990145022, 1417.7736258136845, 1435.2393231587275, 1440.1431148466645, 1446.3780574352918, 1448.7609544425052, 950.805084957582, 983.1348413396165, 1001.8046480936148, 1015.456730649114, 1019.4596863662271, 5275.788968441296, 5279.894402111936, 5291.470852914755, 5319.787208511693, 5337.226102215157, 5648.85877853057, 5691.146328050825, 5731.369549349568, 5731.398203188689, 5739.942600573941, 5008.574271186917, 5100.29140238017, 5230.660007099526, 5305.0, 5368.812091576854, 3014.3669829336086, 3014.954775678367, 3035.7267845893975, 3042.3571271513133, 3050.176452357851, 5887.322957859901, 5893.233879595625, 5925.614835035709, 5947.256592925884, 5966.672997530966, 5669.489745922887, 5977.323945773405, 6001.549883758736, 6020.277566691937, 6032.0, 6067.96844536421, 6070.726817293233, 6075.422834830684, 6090.33006369299, 6103.664298463627, 5583.989763684989, 5836.416358364129, 5841.1238314253205, 5852.5317974561085, 5882.735276912635, 5785.652860828363, 5787.652740835563, 5813.0, 5851.3961287226775, 5879.354290569347, 5810.273715785527, 6111.236095488064, 6131.417515336036, 6133.294671112879, 6146.446819786241, 4124.741953704149, 4143.274926887722, 4200.957990420056, 4214.220369231702, 4224.218519573888, 5892.587518873809, 5904.498117660047, 5908.509532755051, 5928.666050138684, 5934.258217722785, 5594.608377413542, 5776.682282474504, 5779.797707080232, 5783.479486846204, 5800.578858179773, 5705.942940570541, 5731.598788084794, 5734.455226753452, 5760.942390576208, 5786.566007549366, 5730.512906402836, 5735.225744524602, 5745.798897038583, 5772.278465191851, 5794.391588883106, 5475.4250803665045, 5621.775128994795, 5723.540497173194, 5725.56663418054, 5754.9424505754405, 5599.524040456607, 5611.523020543136, 5613.859653508695, 5622.662640241599, 5662.688552129673], "value": 4372.299576727851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.6475353714058, 777.9844403111941, 822.8765685147227, 883.686291366565, 900.7567956651704, 14084.36620352084, 15275.618109547268, 15315.310811013504, 15338.693226135485, 15434.691306173883, 14052.086614370084, 14287.285635718225, 14295.642608934782, 14299.356528956221, 14330.64173395663, 632.813320070578, 651.3942033908463, 723.0636325957871, 738.0774032459439, 748.4237137404195, 739.8446326271462, 743.9702411903518, 744.7393412305677, 748.7978245873611, 750.4671683105003, 781.5857595474379, 786.3080489169552, 789.0886026639212, 789.1004255149135, 789.159545084486, 775.4106878772118, 780.5238804329355, 783.7648705388418, 785.3167744062645, 788.0110461370972, 574.2477354665401, 574.3567204730687, 574.5145352177403, 574.5145352177403, 575.4935656622188, 15024.399024039025, 15030.549083527512, 15137.667142381231, 15239.61900952474, 15419.074855508705, 14951.700965980619, 15568.299426525833, 15883.444079457164, 15931.840681593152, 16371.263293151836, 12140.635780926586, 12261.0, 12342.506299748, 12388.876111238862, 12526.874731252661, 3773.6792372648356, 3860.7104467164795, 3864.306197227976, 3865.5554611219786, 4007.0, 79477.0, 79829.20170798276, 79952.20047799505, 80947.59526202331, 82307.0, 11242.269252498561, 11310.660680179608, 11464.54141834334, 11471.655850324503, 11598.768024639628, 24249.03003879825, 24325.0, 24435.144769932966, 24441.0, 24621.0, 7656.234376562411, 7784.299413052852, 7808.453408261367, 7907.84184316322, 7985.560794156378, 4326.502452217972, 4337.522872484024, 4442.511323754385, 4471.150481408587, 4511.007578332761, 3610.530631017951, 3686.6866316362875, 3709.9814500927323, 3713.442983552489, 4065.2682517146604, 720.9150228905569, 722.6495149852317, 727.3308556128375, 733.5048842031714, 735.7351353512731, 752.3492179264897, 767.919368466303, 772.8531578999972, 789.8578255913876, 800.3277247112453, 9126.0, 10008.49957502122, 10057.748556286006, 10353.654024976855, 10378.688639340831, 767.666065261613, 789.1595450844832, 792.2117493094293, 793.9523628582303, 810.7040930060485, 4618.376519169936, 4782.928256076161, 5005.18891112313, 5035.843003683355, 5057.165567681292, 78307.0, 80943.59528202322, 81254.0, 81312.0, 83253.58373208095, 57346.42653573494, 61131.38868611346, 69967.65016174989, 71375.2862471379, 71782.0, 61115.6944215285, 62912.68543657252, 62969.37030629726, 63472.365276346645, 63564.0, 9517.857232141385, 9781.902180978099, 9787.46168960714, 9801.16690081351, 9805.215582753506, 42235.0, 42789.7163085108, 43330.13339733251, 43816.90457738454, 45057.09885802331, 51212.74393628008, 51518.0, 53342.0, 54318.0, 54556.0, 12442.191257568229, 12471.438785254504, 12531.436085375997, 12595.87404125947, 13221.272829994443, 12426.130170887951, 12479.438425270702, 12514.18657787241, 12862.742745144858, 12890.033247506288, 11552.768944621228, 11909.642710718692, 11921.582744603897, 12056.397180141134, 12366.134370593973, 11957.581484647995, 12355.567555135527, 12423.254604723745, 12447.128700990843, 12820.0, 11737.589184378507, 11746.823797642872, 11863.940680296544, 12063.155579109378, 12654.050946179257, 9903.994922045475, 10139.949300253451, 10254.179665626583, 10322.948385258025, 10329.793404131726, 8453.450525715809, 8742.825143496968, 9169.203392964942, 9779.853302200616, 9835.606575737176], "value": 7120.251987095245, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 112.0, 111.0, 113.0, 111.0, 112.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 118.0, 164.0, 117.0, 123.0, 119.0, 119.0, 147.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 160.0, 162.0, 166.0, 166.0, 168.0, 161.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 105.0, 80.0, 78.0, 76.0, 76.0, 90.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 97.0, 83.0, 83.0, 83.0, 95.0, 84.0, 85.0, 114.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 150.0, 148.0, 149.0, 146.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 101.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 72.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 68.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 83.0, 83.0, 82.0, 88.0, 82.0, 83.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 137.0, 125.0, 149.0, 126.0, 135.0, 143.0, 175.0, 124.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 172.0, 169.0, 177.0, 175.0, 169.0, 169.0, 167.0, 166.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 66.0, 62.0, 65.0, 61.0], "value": 63.3, "unit": "score"}]}]} 12:09:31 INFO - Return code: 0 12:09:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:09:32 ERROR - # TBPL SUCCESS # 12:09:32 INFO - Running post-action listener: _resource_record_post_action 12:09:32 INFO - [mozharness: 2017-01-09 20:09:32.059832Z] Finished run-tests step (success) 12:09:32 INFO - Running post-run listener: _resource_record_post_run 12:09:32 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 402403328; Read time: 36; Write time: 279992 12:09:32 INFO - TinderboxPrint: CPU usage
13.4% 12:09:32 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 36 12:09:32 INFO - TinderboxPrint: I/O write bytes / time
402,403,328 / 279,992 12:09:32 INFO - TinderboxPrint: CPU idle
8,247.0 (86.6%) 12:09:32 INFO - TinderboxPrint: CPU user
1,220.6 (12.8%) 12:09:32 INFO - TinderboxPrint: Swap in / out
0 / 0 12:09:32 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 106373120; Read time: 0; Write time: 92036 12:09:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295669760; Read time: 28; Write time: 187956 12:09:32 INFO - Running post-run listener: _upload_blobber_files 12:09:32 INFO - Blob upload gear active. 12:09:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:09:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:09:33 INFO - (blobuploader) - INFO - Open directory for files ... 12:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:34 INFO - (blobuploader) - INFO - Done attempting. 12:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:34 INFO - (blobuploader) - INFO - Done attempting. 12:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:35 INFO - (blobuploader) - INFO - Done attempting. 12:09:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:09:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:39 INFO - (blobuploader) - INFO - Done attempting. 12:09:39 INFO - (blobuploader) - INFO - Iteration through files over. 12:09:39 INFO - Return code: 0 12:09:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:09:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:09:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef67c59bac7349d28b660c755c15968bcaeb9a48c40be0ce5503bae0c27bfd00691bbb1b4604b18a6d2ff81ccc6d2f9e3a6c8f084262120dae92c487969da8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c6847131e4a64f7277090cba24d8578602f933331c127bdb950d38bda53cc1520b06cdcdbba5fe568d167b3434a0ca7ebbc19a95105d95a5c798fc8aee5db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54ce57d0256d6b0ef6f40bf2f45af9fce80c02069f4248cdee7916dcfbde66c77ac9d1748e0936f27e5e0018382934315de26dba8183667f775f9c7a6c98db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/211a1141c1eb2da81c7324e2b284bbb1b4d5a07951a624651e68b46f50b581dd9c21aea09d1b501118bf5e845de2a2a5de45977f3263642808893c383b25bc4a"} 12:09:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:09:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:09:39 INFO - Contents: 12:09:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef67c59bac7349d28b660c755c15968bcaeb9a48c40be0ce5503bae0c27bfd00691bbb1b4604b18a6d2ff81ccc6d2f9e3a6c8f084262120dae92c487969da8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c6847131e4a64f7277090cba24d8578602f933331c127bdb950d38bda53cc1520b06cdcdbba5fe568d167b3434a0ca7ebbc19a95105d95a5c798fc8aee5db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54ce57d0256d6b0ef6f40bf2f45af9fce80c02069f4248cdee7916dcfbde66c77ac9d1748e0936f27e5e0018382934315de26dba8183667f775f9c7a6c98db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/211a1141c1eb2da81c7324e2b284bbb1b4d5a07951a624651e68b46f50b581dd9c21aea09d1b501118bf5e845de2a2a5de45977f3263642808893c383b25bc4a"} 12:09:39 INFO - Running post-run listener: copy_logs_to_upload_dir 12:09:39 INFO - Copying logs to upload dir... 12:09:39 INFO - mkdir: /builds/slave/test/build/upload/logs 12:09:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.683270 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-09 12:09:39.271256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:39.274607) ========= 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=db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025 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/ef67c59bac7349d28b660c755c15968bcaeb9a48c40be0ce5503bae0c27bfd00691bbb1b4604b18a6d2ff81ccc6d2f9e3a6c8f084262120dae92c487969da8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c6847131e4a64f7277090cba24d8578602f933331c127bdb950d38bda53cc1520b06cdcdbba5fe568d167b3434a0ca7ebbc19a95105d95a5c798fc8aee5db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54ce57d0256d6b0ef6f40bf2f45af9fce80c02069f4248cdee7916dcfbde66c77ac9d1748e0936f27e5e0018382934315de26dba8183667f775f9c7a6c98db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/211a1141c1eb2da81c7324e2b284bbb1b4d5a07951a624651e68b46f50b581dd9c21aea09d1b501118bf5e845de2a2a5de45977f3263642808893c383b25bc4a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011818 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483983610/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ef67c59bac7349d28b660c755c15968bcaeb9a48c40be0ce5503bae0c27bfd00691bbb1b4604b18a6d2ff81ccc6d2f9e3a6c8f084262120dae92c487969da8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50c6847131e4a64f7277090cba24d8578602f933331c127bdb950d38bda53cc1520b06cdcdbba5fe568d167b3434a0ca7ebbc19a95105d95a5c798fc8aee5db8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c54ce57d0256d6b0ef6f40bf2f45af9fce80c02069f4248cdee7916dcfbde66c77ac9d1748e0936f27e5e0018382934315de26dba8183667f775f9c7a6c98db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/211a1141c1eb2da81c7324e2b284bbb1b4d5a07951a624651e68b46f50b581dd9c21aea09d1b501118bf5e845de2a2a5de45977f3263642808893c383b25bc4a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:39.300973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:39.301317) ========= 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=db7e7c15f3ca076d53731445000001ba-1483991340.11927-1219789025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:09:39.387711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 12:09:39.388061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 12:09:39.388440) ========= ========= Total master_lag: 0.16 =========