builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1483076210.16 results: success (0) buildid: 20161229193855 builduid: e3ec9a0af9094ece90a6c9f35621b334 revision: b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.160529) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.160958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.161250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.177159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.177558) ========= 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=fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 21:36:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-12-29 21:36:51 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.383196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.383508) ========= 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=fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014576 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:50.433609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-29 21:36:50.434007) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23 --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 b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23 --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=fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 21:36:51,243 truncating revision to first 12 chars 2016-12-29 21:36:51,243 Setting DEBUG logging. 2016-12-29 21:36:51,244 attempt 1/10 2016-12-29 21:36:51,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b0b87b3bc2dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 21:36:52,157 unpacking tar archive at: mozilla-inbound-b0b87b3bc2dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274529 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-29 21:36:51.722748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:51.723071) ========= script_repo_revision: b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:51.723452) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:51.723732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 21:36:51.734643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-29 21:36:51.735028) ========= /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=fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:36:52 INFO - MultiFileLogger online at 20161229 21:36:52 in /builds/slave/test 21:36:52 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 21:36:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:36:52 INFO - {'append_to_log': False, 21:36:52 INFO - 'base_work_dir': '/builds/slave/test', 21:36:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:36:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:36:52 INFO - 'branch': 'Mozilla-Inbound', 21:36:52 INFO - 'buildbot_json_path': 'buildprops.json', 21:36:52 INFO - 'config_files': ('talos/linux_config.py',), 21:36:52 INFO - 'default_actions': ('clobber', 21:36:52 INFO - 'read-buildbot-config', 21:36:52 INFO - 'download-and-extract', 21:36:52 INFO - 'populate-webroot', 21:36:52 INFO - 'create-virtualenv', 21:36:52 INFO - 'install', 21:36:52 INFO - 'run-tests'), 21:36:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:36:52 INFO - 'download_minidump_stackwalk': True, 21:36:52 INFO - 'download_symbols': 'ondemand', 21:36:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:36:52 INFO - 'tooltool.py': '/tools/tooltool.py', 21:36:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:36:52 INFO - '/tools/misc-python/virtualenv.py')}, 21:36:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:36:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:36:52 INFO - 'installer_path': 'installer.exe', 21:36:52 INFO - 'log_level': 'info', 21:36:52 INFO - 'log_name': 'talos', 21:36:52 INFO - 'log_to_console': True, 21:36:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:36:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:36:52 INFO - 'opt_config_files': (), 21:36:52 INFO - 'pip_index': False, 21:36:52 INFO - 'sps_profile': False, 21:36:52 INFO - 'sps_profile_interval': 0, 21:36:52 INFO - 'suite': 'dromaeojs-e10s', 21:36:52 INFO - 'system_bits': '32', 21:36:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:36:52 INFO - 'title': 'talos-linux64-ix-048', 21:36:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:36:52 INFO - 'use_talos_json': True, 21:36:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:36:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:36:52 INFO - 'work_dir': 'build'} 21:36:52 INFO - [mozharness: 2016-12-30 05:36:52.633250Z] Running clobber step. 21:36:52 INFO - Running pre-action listener: _resource_record_pre_action 21:36:52 INFO - Running main action method: clobber 21:36:52 INFO - rmtree: /builds/slave/test/build 21:36:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:36:53 INFO - Running post-action listener: _resource_record_post_action 21:36:53 INFO - [mozharness: 2016-12-30 05:36:53.147143Z] Finished clobber step (success) 21:36:53 INFO - [mozharness: 2016-12-30 05:36:53.147242Z] Running read-buildbot-config step. 21:36:53 INFO - Running pre-action listener: _resource_record_pre_action 21:36:53 INFO - Running main action method: read_buildbot_config 21:36:53 INFO - Using buildbot properties: 21:36:53 INFO - { 21:36:53 INFO - "project": "", 21:36:53 INFO - "product": "firefox", 21:36:53 INFO - "script_repo_revision": "production", 21:36:53 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:36:53 INFO - "repository": "", 21:36:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:36:53 INFO - "buildid": "20161229193855", 21:36:53 INFO - "stage_platform": "linux64-pgo", 21:36:53 INFO - "basedir": "/builds/slave/test", 21:36:53 INFO - "buildnumber": 1850, 21:36:53 INFO - "platform": "ubuntu64_hw", 21:36:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:36:53 INFO - "slavebuilddir": "test", 21:36:53 INFO - "branch": "mozilla-inbound", 21:36:53 INFO - "revision": "b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23", 21:36:53 INFO - "slavename": "talos-linux64-ix-048", 21:36:53 INFO - "builduid": "e3ec9a0af9094ece90a6c9f35621b334", 21:36:53 INFO - "repo_path": "integration/mozilla-inbound" 21:36:53 INFO - } 21:36:53 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:36:53 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 21:36:53 INFO - Running post-action listener: _resource_record_post_action 21:36:53 INFO - [mozharness: 2016-12-30 05:36:53.149618Z] Finished read-buildbot-config step (success) 21:36:53 INFO - [mozharness: 2016-12-30 05:36:53.149708Z] Running download-and-extract step. 21:36:53 INFO - Running pre-action listener: _resource_record_pre_action 21:36:53 INFO - Running main action method: download_and_extract 21:36:53 INFO - mkdir: /builds/slave/test/build/tests 21:36:53 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')]} 21:36:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:36:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/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 21:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/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 21:36:53 INFO - Downloaded 1361 bytes. 21:36:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:36:53 INFO - Using the following test package requirements: 21:36:53 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:36:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:36:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:36:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'jsshell-linux-x86_64.zip'], 21:36:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:36:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:36:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:36:53 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:36:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:36:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:36:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:36:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:36:53 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/1483062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:36:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:36:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:36:53 INFO - Expected file size: 21835627 21:36:53 INFO - Obtained file size: 21835627 21:36:57 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 21:36:57 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/1483062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:36:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:36:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:36:57 INFO - Expected file size: 21835627 21:36:57 INFO - Obtained file size: 21835627 21:37:02 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/1483062604/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:37:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:37:02 INFO - Expected file size: 14409776 21:37:02 INFO - Obtained file size: 14409776 21:37:02 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')]} 21:37:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:37:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/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 21:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/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 21:37:03 INFO - Downloaded 61363352 bytes. 21:37:03 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:37:03 INFO - mkdir: /builds/slave/test/properties 21:37:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:37:03 INFO - Writing to file /builds/slave/test/properties/build_url 21:37:03 INFO - Contents: 21:37:03 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:37:03 INFO - Running post-action listener: _resource_record_post_action 21:37:03 INFO - Running post-action listener: set_extra_try_arguments 21:37:03 INFO - [mozharness: 2016-12-30 05:37:03.526679Z] Finished download-and-extract step (success) 21:37:03 INFO - [mozharness: 2016-12-30 05:37:03.526908Z] Running populate-webroot step. 21:37:03 INFO - Running pre-action listener: _resource_record_pre_action 21:37:03 INFO - Running main action method: populate_webroot 21:37:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:37:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:37:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:37:03 INFO - '--tppagecycles', 21:37:03 INFO - '7'], 21:37:03 INFO - 'tests': ['tsvgm']}}, 21:37:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:37:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:37:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:37:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:37:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['damp', 'tps']}, 21:37:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'tests': ['damp', 'tps']}, 21:37:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['dromaeo_dom']}, 21:37:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:37:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['basic_compositor_video']}, 21:37:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:37:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['a11yr', 21:37:03 INFO - 'ts_paint', 21:37:03 INFO - 'tpaint', 21:37:03 INFO - 'sessionrestore', 21:37:03 INFO - 'sessionrestore_no_auto_restore', 21:37:03 INFO - 'tabpaint']}, 21:37:03 INFO - 'other-e10s': {'tests': ['a11yr', 21:37:03 INFO - 'ts_paint', 21:37:03 INFO - 'tpaint', 21:37:03 INFO - 'sessionrestore', 21:37:03 INFO - 'sessionrestore_no_auto_restore', 21:37:03 INFO - 'tabpaint']}, 21:37:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:37:03 INFO - 'ts_paint', 21:37:03 INFO - 'tpaint', 21:37:03 INFO - 'sessionrestore', 21:37:03 INFO - 'sessionrestore_no_auto_restore', 21:37:03 INFO - 'tabpaint']}, 21:37:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:37:03 INFO - 'ts_paint', 21:37:03 INFO - 'tpaint', 21:37:03 INFO - 'sessionrestore', 21:37:03 INFO - 'sessionrestore_no_auto_restore', 21:37:03 INFO - 'tabpaint']}, 21:37:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['a11yr', 21:37:03 INFO - 'ts_paint', 21:37:03 INFO - 'tpaint', 21:37:03 INFO - 'sessionrestore', 21:37:03 INFO - 'sessionrestore_no_auto_restore', 21:37:03 INFO - 'tabpaint']}, 21:37:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['a11yr', 21:37:03 INFO - 'ts_paint', 21:37:03 INFO - 'tpaint', 21:37:03 INFO - 'sessionrestore', 21:37:03 INFO - 'sessionrestore_no_auto_restore', 21:37:03 INFO - 'tabpaint']}, 21:37:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['tsvgx', 21:37:03 INFO - 'tsvgr_opacity', 21:37:03 INFO - 'tart', 21:37:03 INFO - 'tscrollx', 21:37:03 INFO - 'cart', 21:37:03 INFO - 'tsvg_static']}, 21:37:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:37:03 INFO - 'tsvgr_opacity', 21:37:03 INFO - 'tart', 21:37:03 INFO - 'tscrollx', 21:37:03 INFO - 'cart', 21:37:03 INFO - 'tsvg_static']}, 21:37:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'talos_options': ['--disable-e10s'], 21:37:03 INFO - 'tests': ['tp5o']}, 21:37:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:37:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'talos_options': ['--disable-e10s', 21:37:03 INFO - '--xperf_path', 21:37:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:03 INFO - 'tests': ['tp5n']}, 21:37:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:37:03 INFO - 'talos_options': ['--xperf_path', 21:37:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:03 INFO - 'tests': ['tp5n']}}, 21:37:03 INFO - 'talos.zip': {'path': '', 21:37:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:37:03 INFO - Running post-action listener: _resource_record_post_action 21:37:03 INFO - [mozharness: 2016-12-30 05:37:03.546814Z] Finished populate-webroot step (success) 21:37:03 INFO - [mozharness: 2016-12-30 05:37:03.546903Z] Running create-virtualenv step. 21:37:03 INFO - Running pre-action listener: _resource_record_pre_action 21:37:03 INFO - Running main action method: create_virtualenv 21:37:03 INFO - Creating virtualenv /builds/slave/test/build/venv 21:37:03 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 21:37:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:37:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:37:03 INFO - Using real prefix '/usr' 21:37:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:37:04 INFO - Installing distribute.............................................................................................................................................................................................done. 21:37:06 INFO - Installing pip.................done. 21:37:06 INFO - Return code: 0 21:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:37:06 INFO - Reading from file tmpfile_stdout 21:37:06 INFO - Output received: 21:37:06 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) 21:37:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:06 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:06 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 21:37:06 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 21:37:06 INFO - Using env: {'DISPLAY': ':0', 21:37:06 INFO - 'HOME': '/home/cltbld', 21:37:06 INFO - 'LANG': 'en_US.UTF-8', 21:37:06 INFO - 'LANGUAGE': 'en_US:en', 21:37:06 INFO - 'LOGNAME': 'cltbld', 21:37:06 INFO - 'MAIL': '/var/mail/cltbld', 21:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:06 INFO - 'MOZ_NO_REMOTE': '1', 21:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:06 INFO - 'NO_EM_RESTART': '1', 21:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:06 INFO - 'PWD': '/builds/slave/test', 21:37:06 INFO - 'SHELL': '/bin/bash', 21:37:06 INFO - 'SHLVL': '1', 21:37:06 INFO - 'TERM': 'linux', 21:37:06 INFO - 'TMOUT': '86400', 21:37:06 INFO - 'USER': 'cltbld', 21:37:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:06 INFO - '_': '/tools/buildbot/bin/python'} 21:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:06 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 21:37:06 INFO - Cleaning up... 21:37:06 INFO - Return code: 0 21:37:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:06 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:06 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 21:37:06 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 21:37:06 INFO - Using env: {'DISPLAY': ':0', 21:37:06 INFO - 'HOME': '/home/cltbld', 21:37:06 INFO - 'LANG': 'en_US.UTF-8', 21:37:06 INFO - 'LANGUAGE': 'en_US:en', 21:37:06 INFO - 'LOGNAME': 'cltbld', 21:37:06 INFO - 'MAIL': '/var/mail/cltbld', 21:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:06 INFO - 'MOZ_NO_REMOTE': '1', 21:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:06 INFO - 'NO_EM_RESTART': '1', 21:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:06 INFO - 'PWD': '/builds/slave/test', 21:37:06 INFO - 'SHELL': '/bin/bash', 21:37:06 INFO - 'SHLVL': '1', 21:37:06 INFO - 'TERM': 'linux', 21:37:06 INFO - 'TMOUT': '86400', 21:37:06 INFO - 'USER': 'cltbld', 21:37:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:06 INFO - '_': '/tools/buildbot/bin/python'} 21:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:06 INFO - Downloading/unpacking psutil>=3.1.1 21:37:06 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 21:37:06 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 21:37:06 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 21:37:06 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 21:37:06 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 21:37:06 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 21:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:37:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:08 INFO - Installing collected packages: psutil 21:37:08 INFO - Running setup.py install for psutil 21:37:08 INFO - building 'psutil._psutil_linux' extension 21:37:08 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 21:37:09 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 21:37:09 INFO - building 'psutil._psutil_posix' extension 21:37:09 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 21:37:09 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 21:37:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:09 INFO - Successfully installed psutil 21:37:09 INFO - Cleaning up... 21:37:09 INFO - Return code: 0 21:37:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:37:09 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')]} 21:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:09 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')]} 21:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:09 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:09 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 21:37:09 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 21:37:09 INFO - Using env: {'DISPLAY': ':0', 21:37:09 INFO - 'HOME': '/home/cltbld', 21:37:09 INFO - 'LANG': 'en_US.UTF-8', 21:37:09 INFO - 'LANGUAGE': 'en_US:en', 21:37:09 INFO - 'LOGNAME': 'cltbld', 21:37:09 INFO - 'MAIL': '/var/mail/cltbld', 21:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:09 INFO - 'MOZ_NO_REMOTE': '1', 21:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:09 INFO - 'NO_EM_RESTART': '1', 21:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:09 INFO - 'PWD': '/builds/slave/test', 21:37:09 INFO - 'SHELL': '/bin/bash', 21:37:09 INFO - 'SHLVL': '1', 21:37:09 INFO - 'TERM': 'linux', 21:37:09 INFO - 'TMOUT': '86400', 21:37:09 INFO - 'USER': 'cltbld', 21:37:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:09 INFO - '_': '/tools/buildbot/bin/python'} 21:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:37:09 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 21:37:09 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 21:37:09 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 21:37:09 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 21:37:09 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 21:37:09 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 21:37:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:37:11 INFO - Installing collected packages: mozsystemmonitor 21:37:11 INFO - Running setup.py install for mozsystemmonitor 21:37:11 INFO - Successfully installed mozsystemmonitor 21:37:11 INFO - Cleaning up... 21:37:11 INFO - Return code: 0 21:37:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:37:11 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')]} 21:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:11 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')]} 21:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:11 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:11 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 21:37:11 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 21:37:11 INFO - Using env: {'DISPLAY': ':0', 21:37:11 INFO - 'HOME': '/home/cltbld', 21:37:11 INFO - 'LANG': 'en_US.UTF-8', 21:37:11 INFO - 'LANGUAGE': 'en_US:en', 21:37:11 INFO - 'LOGNAME': 'cltbld', 21:37:11 INFO - 'MAIL': '/var/mail/cltbld', 21:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:11 INFO - 'MOZ_NO_REMOTE': '1', 21:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:11 INFO - 'NO_EM_RESTART': '1', 21:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:11 INFO - 'PWD': '/builds/slave/test', 21:37:11 INFO - 'SHELL': '/bin/bash', 21:37:11 INFO - 'SHLVL': '1', 21:37:11 INFO - 'TERM': 'linux', 21:37:11 INFO - 'TMOUT': '86400', 21:37:11 INFO - 'USER': 'cltbld', 21:37:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:11 INFO - '_': '/tools/buildbot/bin/python'} 21:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:12 INFO - Downloading/unpacking jsonschema==2.5.1 21:37:12 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 21:37:12 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 21:37:12 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 21:37:12 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 21:37:12 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 21:37:12 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 21:37:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:37:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:37:14 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 21:37:14 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 21:37:14 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 21:37:14 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 21:37:14 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 21:37:14 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 21:37:14 INFO - Downloading functools32-3.2.3-2.tar.gz 21:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:37:14 INFO - warning: no files found matching '*.txt' 21:37:14 INFO - no previously-included directories found matching 'build' 21:37:14 INFO - no previously-included directories found matching 'dist' 21:37:14 INFO - no previously-included directories found matching '.git*' 21:37:14 INFO - Installing collected packages: jsonschema, functools32 21:37:14 INFO - Running setup.py install for functools32 21:37:14 INFO - warning: no files found matching '*.txt' 21:37:14 INFO - no previously-included directories found matching 'build' 21:37:14 INFO - no previously-included directories found matching 'dist' 21:37:14 INFO - no previously-included directories found matching '.git*' 21:37:14 INFO - Successfully installed jsonschema functools32 21:37:14 INFO - Cleaning up... 21:37:14 INFO - Return code: 0 21:37:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:14 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:14 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 21:37:14 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 21:37:14 INFO - Using env: {'DISPLAY': ':0', 21:37:14 INFO - 'HOME': '/home/cltbld', 21:37:14 INFO - 'LANG': 'en_US.UTF-8', 21:37:14 INFO - 'LANGUAGE': 'en_US:en', 21:37:14 INFO - 'LOGNAME': 'cltbld', 21:37:14 INFO - 'MAIL': '/var/mail/cltbld', 21:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:14 INFO - 'MOZ_NO_REMOTE': '1', 21:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:14 INFO - 'NO_EM_RESTART': '1', 21:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:14 INFO - 'PWD': '/builds/slave/test', 21:37:14 INFO - 'SHELL': '/bin/bash', 21:37:14 INFO - 'SHLVL': '1', 21:37:14 INFO - 'TERM': 'linux', 21:37:14 INFO - 'TMOUT': '86400', 21:37:14 INFO - 'USER': 'cltbld', 21:37:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:14 INFO - '_': '/tools/buildbot/bin/python'} 21:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:37:14 INFO - Cleaning up... 21:37:14 INFO - Return code: 0 21:37:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:14 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:14 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 21:37:14 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 21:37:14 INFO - Using env: {'DISPLAY': ':0', 21:37:14 INFO - 'HOME': '/home/cltbld', 21:37:14 INFO - 'LANG': 'en_US.UTF-8', 21:37:14 INFO - 'LANGUAGE': 'en_US:en', 21:37:14 INFO - 'LOGNAME': 'cltbld', 21:37:14 INFO - 'MAIL': '/var/mail/cltbld', 21:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:14 INFO - 'MOZ_NO_REMOTE': '1', 21:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:14 INFO - 'NO_EM_RESTART': '1', 21:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:14 INFO - 'PWD': '/builds/slave/test', 21:37:14 INFO - 'SHELL': '/bin/bash', 21:37:14 INFO - 'SHLVL': '1', 21:37:14 INFO - 'TERM': 'linux', 21:37:14 INFO - 'TMOUT': '86400', 21:37:14 INFO - 'USER': 'cltbld', 21:37:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:14 INFO - '_': '/tools/buildbot/bin/python'} 21:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:15 INFO - Downloading/unpacking blobuploader==1.2.4 21:37:15 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 21:37:15 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 21:37:15 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 21:37:15 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 21:37:15 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 21:37:15 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 21:37:17 INFO - Downloading blobuploader-1.2.4.tar.gz 21:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:37:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:37:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37:17 INFO - Downloading docopt-0.6.1.tar.gz 21:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:37:17 INFO - Installing collected packages: blobuploader, requests, docopt 21:37:17 INFO - Running setup.py install for blobuploader 21:37:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:37:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:37:18 INFO - Running setup.py install for requests 21:37:18 INFO - Running setup.py install for docopt 21:37:18 INFO - Successfully installed blobuploader requests docopt 21:37:18 INFO - Cleaning up... 21:37:18 INFO - Return code: 0 21:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:18 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:18 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 21:37:18 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 21:37:18 INFO - Using env: {'DISPLAY': ':0', 21:37:18 INFO - 'HOME': '/home/cltbld', 21:37:18 INFO - 'LANG': 'en_US.UTF-8', 21:37:18 INFO - 'LANGUAGE': 'en_US:en', 21:37:18 INFO - 'LOGNAME': 'cltbld', 21:37:18 INFO - 'MAIL': '/var/mail/cltbld', 21:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:18 INFO - 'MOZ_NO_REMOTE': '1', 21:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:18 INFO - 'NO_EM_RESTART': '1', 21:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:18 INFO - 'PWD': '/builds/slave/test', 21:37:18 INFO - 'SHELL': '/bin/bash', 21:37:18 INFO - 'SHLVL': '1', 21:37:18 INFO - 'TERM': 'linux', 21:37:18 INFO - 'TMOUT': '86400', 21:37:18 INFO - 'USER': 'cltbld', 21:37:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:18 INFO - '_': '/tools/buildbot/bin/python'} 21:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:37:18 INFO - Running setup.py (path:/tmp/pip-IaLheo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:37:18 INFO - Running setup.py (path:/tmp/pip-o3HUgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:37:18 INFO - Running setup.py (path:/tmp/pip-JFLGa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:37:18 INFO - Running setup.py (path:/tmp/pip-w8YMgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:37:19 INFO - Running setup.py (path:/tmp/pip-mY78WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:37:19 INFO - Running setup.py (path:/tmp/pip-OJNk2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:37:19 INFO - Running setup.py (path:/tmp/pip-NX7mAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:37:19 INFO - Running setup.py (path:/tmp/pip-6wHy4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:37:19 INFO - Running setup.py (path:/tmp/pip-0WJg4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:37:19 INFO - Running setup.py (path:/tmp/pip-06dU54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:37:19 INFO - Running setup.py (path:/tmp/pip-Sj_y14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:37:19 INFO - Running setup.py (path:/tmp/pip-59AKDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:37:19 INFO - Running setup.py (path:/tmp/pip-OxBi1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:37:19 INFO - Running setup.py (path:/tmp/pip-a0i9TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:37:19 INFO - Running setup.py (path:/tmp/pip-38lhun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:37:19 INFO - Running setup.py (path:/tmp/pip-4yP31W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:37:19 INFO - Running setup.py (path:/tmp/pip-B9NF7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:37:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:37:19 INFO - Running setup.py install for manifestparser 21:37:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Running setup.py install for mozcrash 21:37:20 INFO - Running setup.py install for mozdebug 21:37:20 INFO - Running setup.py install for mozdevice 21:37:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Running setup.py install for mozfile 21:37:20 INFO - Running setup.py install for mozhttpd 21:37:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Running setup.py install for mozinfo 21:37:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Running setup.py install for mozInstall 21:37:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:37:20 INFO - Running setup.py install for mozleak 21:37:20 INFO - Running setup.py install for mozlog 21:37:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Running setup.py install for moznetwork 21:37:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Running setup.py install for mozprocess 21:37:21 INFO - Running setup.py install for mozprofile 21:37:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Running setup.py install for mozrunner 21:37:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Running setup.py install for mozscreenshot 21:37:21 INFO - Running setup.py install for moztest 21:37:21 INFO - Running setup.py install for mozversion 21:37:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:37:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:37:21 INFO - Cleaning up... 21:37:21 INFO - Return code: 0 21:37:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:21 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:21 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 21:37:21 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 21:37:21 INFO - Using env: {'DISPLAY': ':0', 21:37:21 INFO - 'HOME': '/home/cltbld', 21:37:21 INFO - 'LANG': 'en_US.UTF-8', 21:37:21 INFO - 'LANGUAGE': 'en_US:en', 21:37:21 INFO - 'LOGNAME': 'cltbld', 21:37:21 INFO - 'MAIL': '/var/mail/cltbld', 21:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:21 INFO - 'MOZ_NO_REMOTE': '1', 21:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:21 INFO - 'NO_EM_RESTART': '1', 21:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:21 INFO - 'PWD': '/builds/slave/test', 21:37:21 INFO - 'SHELL': '/bin/bash', 21:37:21 INFO - 'SHLVL': '1', 21:37:21 INFO - 'TERM': 'linux', 21:37:21 INFO - 'TMOUT': '86400', 21:37:21 INFO - 'USER': 'cltbld', 21:37:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:21 INFO - '_': '/tools/buildbot/bin/python'} 21:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:37:22 INFO - Running setup.py (path:/tmp/pip-4PxU9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:37:22 INFO - Running setup.py (path:/tmp/pip-3Oc0zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:37:22 INFO - Running setup.py (path:/tmp/pip-HBsC7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:37:22 INFO - Running setup.py (path:/tmp/pip-YREaDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:37:22 INFO - Running setup.py (path:/tmp/pip-WZ5dU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:37:22 INFO - Running setup.py (path:/tmp/pip-v1AWDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:37:22 INFO - Running setup.py (path:/tmp/pip-LHLuz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:37:22 INFO - Running setup.py (path:/tmp/pip-VvrKwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:37:22 INFO - Running setup.py (path:/tmp/pip-q4kAbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:37:22 INFO - Running setup.py (path:/tmp/pip-H5JSTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:37:22 INFO - Running setup.py (path:/tmp/pip-TDcxYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:37:22 INFO - Running setup.py (path:/tmp/pip-OcE3s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:37:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:37:22 INFO - Running setup.py (path:/tmp/pip-1pU2TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:37:22 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)) 21:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:37:22 INFO - Running setup.py (path:/tmp/pip-uBU3VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:37:23 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)) 21:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:37:23 INFO - Running setup.py (path:/tmp/pip-hkajyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:37:23 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)) 21:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:37:23 INFO - Running setup.py (path:/tmp/pip-fz_pLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:37:23 INFO - Running setup.py (path:/tmp/pip-g1vdYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:37:23 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)) 21:37:23 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)) 21:37:23 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)) 21:37:23 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)) 21:37:23 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)) 21:37:23 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)) 21:37:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:25 INFO - Downloading blessings-1.6.tar.gz 21:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:37:25 INFO - Installing collected packages: blessings 21:37:25 INFO - Running setup.py install for blessings 21:37:25 INFO - Successfully installed blessings 21:37:25 INFO - Cleaning up... 21:37:25 INFO - Return code: 0 21:37:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:37:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:37:25 INFO - Reading from file tmpfile_stdout 21:37:25 INFO - Current package versions: 21:37:25 INFO - argparse == 1.2.1 21:37:25 INFO - blessings == 1.6 21:37:25 INFO - blobuploader == 1.2.4 21:37:25 INFO - docopt == 0.6.1 21:37:25 INFO - functools32 == 3.2.3-2 21:37:25 INFO - jsonschema == 2.5.1 21:37:25 INFO - manifestparser == 1.1 21:37:25 INFO - mozInstall == 1.12 21:37:25 INFO - mozcrash == 1.0 21:37:25 INFO - mozdebug == 0.1 21:37:25 INFO - mozdevice == 0.49 21:37:25 INFO - mozfile == 1.2 21:37:25 INFO - mozhttpd == 0.7 21:37:25 INFO - mozinfo == 0.9 21:37:25 INFO - mozleak == 0.1 21:37:25 INFO - mozlog == 3.4 21:37:25 INFO - moznetwork == 0.27 21:37:25 INFO - mozprocess == 0.23 21:37:25 INFO - mozprofile == 0.28 21:37:25 INFO - mozrunner == 6.13 21:37:25 INFO - mozscreenshot == 0.1 21:37:25 INFO - mozsystemmonitor == 0.3 21:37:25 INFO - moztest == 0.7 21:37:25 INFO - mozversion == 1.4 21:37:25 INFO - psutil == 3.1.1 21:37:25 INFO - requests == 1.2.3 21:37:25 INFO - wsgiref == 0.1.2 21:37:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:25 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 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:25 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 21:37:25 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 21:37:25 INFO - Using env: {'DISPLAY': ':0', 21:37:25 INFO - 'HOME': '/home/cltbld', 21:37:25 INFO - 'LANG': 'en_US.UTF-8', 21:37:25 INFO - 'LANGUAGE': 'en_US:en', 21:37:25 INFO - 'LOGNAME': 'cltbld', 21:37:25 INFO - 'MAIL': '/var/mail/cltbld', 21:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:25 INFO - 'MOZ_NO_REMOTE': '1', 21:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:25 INFO - 'NO_EM_RESTART': '1', 21:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:25 INFO - 'PWD': '/builds/slave/test', 21:37:25 INFO - 'SHELL': '/bin/bash', 21:37:25 INFO - 'SHLVL': '1', 21:37:25 INFO - 'TERM': 'linux', 21:37:25 INFO - 'TMOUT': '86400', 21:37:25 INFO - 'USER': 'cltbld', 21:37:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:25 INFO - '_': '/tools/buildbot/bin/python'} 21:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 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)) 21:37:25 INFO - Cleaning up... 21:37:25 INFO - Return code: 0 21:37:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf43480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, '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': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', '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 21:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:37:26 INFO - Using env: {'DISPLAY': ':0', 21:37:26 INFO - 'HOME': '/home/cltbld', 21:37:26 INFO - 'LANG': 'en_US.UTF-8', 21:37:26 INFO - 'LANGUAGE': 'en_US:en', 21:37:26 INFO - 'LOGNAME': 'cltbld', 21:37:26 INFO - 'MAIL': '/var/mail/cltbld', 21:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:26 INFO - 'MOZ_NO_REMOTE': '1', 21:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:26 INFO - 'NO_EM_RESTART': '1', 21:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:26 INFO - 'PWD': '/builds/slave/test', 21:37:26 INFO - 'SHELL': '/bin/bash', 21:37:26 INFO - 'SHLVL': '1', 21:37:26 INFO - 'TERM': 'linux', 21:37:26 INFO - 'TMOUT': '86400', 21:37:26 INFO - 'USER': 'cltbld', 21:37:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:26 INFO - '_': '/tools/buildbot/bin/python'} 21:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:37:26 INFO - Cleaning up... 21:37:26 INFO - Return code: 0 21:37:26 INFO - Running post-action listener: _resource_record_post_action 21:37:26 INFO - Running post-action listener: _start_resource_monitoring 21:37:26 INFO - Starting resource monitoring. 21:37:26 INFO - [mozharness: 2016-12-30 05:37:26.260191Z] Finished create-virtualenv step (success) 21:37:26 INFO - [mozharness: 2016-12-30 05:37:26.260663Z] Running install step. 21:37:26 INFO - Running pre-action listener: _resource_record_pre_action 21:37:26 INFO - Running main action method: install 21:37:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:37:26 INFO - Reading from file tmpfile_stdout 21:37:26 INFO - Detecting whether we're running mozinstall >=1.0... 21:37:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:37:26 INFO - Reading from file tmpfile_stdout 21:37:26 INFO - Output received: 21:37:26 INFO - Usage: mozinstall [options] installer 21:37:26 INFO - Options: 21:37:26 INFO - -h, --help show this help message and exit 21:37:26 INFO - -d DEST, --destination=DEST 21:37:26 INFO - Directory to install application into. [default: 21:37:26 INFO - "/builds/slave/test"] 21:37:26 INFO - --app=APP Application being installed. [default: firefox] 21:37:26 INFO - mkdir: /builds/slave/test/build/application 21:37:26 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'] 21:37:26 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 21:37:43 INFO - Reading from file tmpfile_stdout 21:37:43 INFO - Output received: 21:37:43 INFO - /builds/slave/test/build/application/firefox/firefox 21:37:43 INFO - Running post-action listener: _resource_record_post_action 21:37:43 INFO - [mozharness: 2016-12-30 05:37:43.905714Z] Finished install step (success) 21:37:43 INFO - [mozharness: 2016-12-30 05:37:43.906046Z] Running run-tests step. 21:37:43 INFO - Running pre-action listener: _resource_record_pre_action 21:37:43 INFO - Running main action method: run_tests 21:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:37:43 INFO - Python 2.7.3 21:37:43 INFO - Return code: 0 21:37:43 INFO - grabbing minidump binary from tooltool 21:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:43 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 0xf40820>, '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 0xf41520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf419b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:37:43 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 21:37:43 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 21:37:43 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 21:37:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:37:43 INFO - Return code: 0 21:37:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:37:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:37:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:37:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:37:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:37:43 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/1483062604/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 21:37:43 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/1483062604/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 21:37:43 INFO - Using env: {'DISPLAY': ':0', 21:37:43 INFO - 'HOME': '/home/cltbld', 21:37:43 INFO - 'LANG': 'en_US.UTF-8', 21:37:43 INFO - 'LANGUAGE': 'en_US:en', 21:37:43 INFO - 'LOGNAME': 'cltbld', 21:37:43 INFO - 'MAIL': '/var/mail/cltbld', 21:37:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:37:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:43 INFO - 'MOZ_NO_REMOTE': '1', 21:37:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:37:43 INFO - 'NO_EM_RESTART': '1', 21:37:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:43 INFO - 'PWD': '/builds/slave/test', 21:37:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:37:43 INFO - 'SHELL': '/bin/bash', 21:37:43 INFO - 'SHLVL': '1', 21:37:43 INFO - 'TERM': 'linux', 21:37:43 INFO - 'TMOUT': '86400', 21:37:43 INFO - 'USER': 'cltbld', 21:37:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366', 21:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:43 INFO - '_': '/tools/buildbot/bin/python'} 21:37:43 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/1483062604/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 21:37:44 INFO - mozversion application_buildid: 20161229175004 21:37:44 INFO - mozversion application_changeset: b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23 21:37:44 INFO - mozversion application_display_name: Nightly 21:37:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:37:44 INFO - mozversion application_name: Firefox 21:37:44 INFO - mozversion application_remotingname: firefox 21:37:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:37:44 INFO - mozversion application_vendor: Mozilla 21:37:44 INFO - mozversion application_version: 53.0a1 21:37:44 INFO - mozversion platform_buildid: 20161229175004 21:37:44 INFO - mozversion platform_changeset: b0b87b3bc2dcfe0561f05d7ac780b023ea54ac23 21:37:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:37:44 INFO - mozversion platform_version: 53.0a1 21:37:44 INFO - using testdate: 1483076264 21:37:44 INFO - actual date: 1483076264 21:37:44 INFO - starting webserver on 'localhost:40580' 21:37:44 INFO - SUITE-START | Running 2 tests 21:37:44 INFO - TEST-START | dromaeo_css 21:37:44 INFO - operating with platform_type : linux_ 21:37:44 INFO - Initialising browser for dromaeo_css test... 21:37:44 INFO - TEST-INFO | started process 1392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQGryB/profile http://localhost:40580/getInfo.html) 21:37:44 INFO - PROCESS | 1392 | 1483076264672 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 21:37:48 INFO - PROCESS | 1392 | __metrics Screen width/height:1600/1200 21:37:48 INFO - PROCESS | 1392 | colorDepth:24 21:37:48 INFO - PROCESS | 1392 | Browser inner width/height: 1024/697 21:37:48 INFO - PROCESS | 1392 | __metrics 21:37:49 ERROR - PROCESS | 1392 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 21:37:50 INFO - TEST-INFO | 1392: exit 0 21:37:50 INFO - Browser initialized. 21:37:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:37:50 INFO - TEST-INFO | started process 1518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQGryB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:38:01 INFO - PROCESS | 1518 | RSS: Main: 154693632 21:38:01 INFO - PROCESS | 1518 | 21:41:02 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40580/tests/dromaeo/cssquery-ext.html) 21:41:03 INFO - PROCESS | 1518 | RSS: Main: 164503552 21:41:03 INFO - PROCESS | 1518 | 21:42:50 INFO - PROCESS | 1518 | ************************* 21:42:50 INFO - PROCESS | 1518 | A coding exception was thrown and uncaught in a Task. 21:42:50 INFO - PROCESS | 1518 | 21:42:50 INFO - PROCESS | 1518 | Full message: ReferenceError: fetch is not defined 21:42:50 INFO - PROCESS | 1518 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 21:42:50 INFO - PROCESS | 1518 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 21:42:50 INFO - PROCESS | 1518 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 21:42:50 INFO - PROCESS | 1518 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 21:42:50 INFO - PROCESS | 1518 | TaskImpl@resource://gre/modules/Task.jsm:277:3 21:42:50 INFO - PROCESS | 1518 | asyncFunction@resource://gre/modules/Task.jsm:252:14 21:42:50 INFO - PROCESS | 1518 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 21:42:50 INFO - PROCESS | 1518 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 21:42:50 INFO - PROCESS | 1518 | TaskImpl@resource://gre/modules/Task.jsm:277:3 21:42:50 INFO - PROCESS | 1518 | asyncFunction@resource://gre/modules/Task.jsm:252:14 21:42:50 INFO - PROCESS | 1518 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 21:42:50 INFO - PROCESS | 1518 | 21:42:50 INFO - PROCESS | 1518 | ************************* 21:44:05 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-ext.html (next: http://localhost:40580/tests/dromaeo/cssquery-jquery.html) 21:44:06 INFO - PROCESS | 1518 | RSS: Main: 161689600 21:44:06 INFO - PROCESS | 1518 | 21:47:08 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40580/tests/dromaeo/cssquery-mootools.html) 21:47:09 INFO - PROCESS | 1518 | RSS: Main: 165302272 21:47:09 INFO - PROCESS | 1518 | 21:50:11 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40580/tests/dromaeo/cssquery-prototype.html) 21:50:11 INFO - PROCESS | 1518 | RSS: Main: 160063488 21:50:11 INFO - PROCESS | 1518 | 21:53:14 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40580/tests/dromaeo/cssquery-yui.html) 21:53:14 INFO - PROCESS | 1518 | RSS: Main: 165769216 21:53:14 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-yui.html (next: http://localhost:40580/tests/dromaeo/cssquery-dojo.html) 21:56:17 INFO - PROCESS | 1518 | RSS: Main: 163958784 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | __start_tp_report 21:56:17 INFO - PROCESS | 1518 | _x_x_mozilla_page_load 21:56:17 INFO - PROCESS | 1518 | _x_x_mozilla_page_load_details 21:56:17 INFO - PROCESS | 1518 | |i|pagename|runs| 21:56:17 INFO - PROCESS | 1518 | |0;dojo.html;3190.1067701043703;3213.2127628730964;3234.900133954455;3240.740740740741;3245.350929814038;5332.600054995881;5459.372172200198;5480.397156312807;5539.695316757582;5552.611317207797;5365.302510673617;5392.892142157155;5440.347158341005;5440.510354068133;5547.77808887645;4894.8776280593;4930.186519224341;4956.950430495685;5046.621503387242;5065.468125846788;4857.805687772502;4983.302337672729;5068.290439338495;5092.643514953955;5092.719900405476;4848.200046992242;5032.0690672225755;5050.242463630448;5075.720835354054;5088.414832294259;4879.82920597781;4954.826581069645;4986.850394488171;5018.924716129261;5074.416442109168;4972.726500042496;4975.4029516457895;4985.227289770091;4992.650514463989;5014.548690617826;5440.319960004999;5490.862728431821;5521.696306703129;5526.419725928759;5576.163575463673;5716.228309178249;5753.194552762617;5757.769689212427;5778.797742079049;5787.218725472049;5777.913331300034;5787.334456537468;5788;5843.357230704619;5846.736896839652;5424.1321388577635;5432.158015507603;5439.83680489582;5441.102218133963;5450.700211488406;5834.241548598655;5871.735771890275;5902.1441890926435;5923.08192230205;5945.316288626863;5707.6575405475805;5744.425557444222;5773.018586840247;5799.5650326225705;5824.854378640568;5808.94191058084;5812.157237200667;5822.796202132905;5846.239988801429;5874.089516125007;5584.748686309044;5619.831405057855;5793.768249270066;5826.300843898759;5844.386339434383;5869.765209391662;5875.265591801025;5875.383084776123;5888.852778680567;5925.762969481259;4439.089986552749;4447.510773814878;4448;4467.218236808546;4485.48416932057;3882.8446862125197;3885.4560361549406;3889.3193691103943;3947.9932617182435;3960.0693836948294;5616.241807355955;5645.633033852787;5646.661200327993;5711.771529138871;5722.484976352148;5898;5902.61632993854;5964.970175149183;5970.791022314285;5980.461758441761;5407.134858422633;5428.294321738149;5554.666719996813;5648.887022259614;5668.121441176624;4893.559579637849;4913.434954980152;4914.410270767531;4935.629827762932;4957.405111386656;6140.600860944024;6156.138140660311;6167.814965551041;6190.969045154836;6191.783287585003;5695.7436915338085;5747.08046712524;5916.05343145112;5917.289925209003;5926.585139040226;6086.1175129606845;6090.330063693079;6133.294671112879;6169.043798211284;6183.443490085734;5801.76792928295;5851.561132915133;5854.0048191806645;5856.882862342644;5894.528437725057;5754;5794.942050579441;5932.733027013881;5952.107183922446;5959.255093113361;5654.40628733977;5724.65652060861;5726.455986681425;5735.8566035849435;5748.597598168088;5654.745536450787;5724.8282551523525;5725.570582206268;5744.023516002206;5770.596058275881;5561.5272701820795;5569;5751;5754;5777.942220577908;5698.515626171822;5854.2389489366105;5866;5872.882542349043;5875.794347197828;5504.339479262514;5726.112452569859;5736.139579063174;5740;5745.080787074048 21:56:17 INFO - PROCESS | 1518 | |1;ext.html;551.0686939072967;563.6195567991607;574.5891687443477;574.7729646789518;581.3982528083435;40282;41563.79218103909;41599;44815.32777008347;45042.32436513455;43466.34800477987;44065.77967110168;44253.55746442534;44285.33571996423;44441.55558444415;8719.912800872005;9007.594658240361;9016.594253258587;10091.394516329006;10388.688339349794;10342.793144137113;10423.374597524135;10428.582856685762;10435.686929392092;10485.58057677692;10359.171266298716;10392.064714175724;10424.843627345595;10452.111570516516;10519.789604207912;10403.063724264777;10405;10467.057964783167;10491.63279285229;10530.631427900025;10332.225083118796;10366.067053965104;10404.479776011169;10440.060394564525;10484.947575262075;33382.332353352795;33816.6618333816;33915.15212119717;34137.487937680955;34378.14054648629;3858.2862170498547;3951.8024098794945;3993.6206060424215;4011.959880401188;4039.575844536311;28745;29001.709982900324;29054;29163.854180729173;29833.552496712568;3976.6619837313865;3995.7402768820225;4019.196160767858;4029.37544680575;4063.6749060075417;325448;327549;328521;328720.3563982189;329045;50407.49592504028;51058.489415106116;51150;51172.48827511752;51201.92788432706;53123;53292.604887413756;53395.466045339046;53486.465135348146;53507.197392039154;14810.555683329518;15392.461263855712;15398.615034624;15398.692026159413;15414.614634634;11624.476898539586;11871.109666775026;12001.63995080149;12283.201591896499;12335.876641233473;17044.14779261032;17072.91463542699;17076.487705368858;17084.48746537606;17163;6794.694238759268;6857.622830744257;6881.862362752717;6973.825654358681;7000.404965577983;885.2696525366598;890.3945317184248;897.6319708919442;902.4495058014605;913.5432283858071;29695.406091878474;29970.02204989727;30001.399972000876;30276.848615757222;30544.54183187254;1006.8338724110587;1068.4924660786064;1083.2417307884512;1102.399192440122;1111.5664890692635;15489.612759680873;15709.371625135094;16014.279357428944;16050.592411138188;16054.759178612096;542941;543419;545389;547954;550174;57129.714351427974;57568;57670.71164644234;57692.711536442046;57739.13391299134;1355.5594431809702;1389.4997800791707;1391.1513976474344;1396.9022168448314;1407.2893188939724;28560.85719571389;28661.713382865906;29142.27144321409;29298;30357.69642303637;48765;49005.50994490152;49518.50481495139;49519;49538.75230623824;409357;409512.7146185619;409571;409837;411095;25563.6165457522;25603.87198063998;25824.8708756455;26728.198154055408;26916;41204.175916482105;41213.58786412217;41249.1750165001;41886.371704425066;42202.788986056104;34884.30231395409;34906.48086131621;35054.29891402209;35433.291334173686;35900.10249743777;34591.654083458845;34614.82692586521;34776.82611586926;34831.30337393289;34973;34599.65400345964;34792.82603586966;34874.65125348714;35126.64873351234;35790.46314305235;29533.85233073821;31509.369812604076;31825.363492729553;31924.201894952814;32159.19602009875;24286.8068642495;24418.51162976695;24544.263672089866;24686;25061.373465663506 21:56:17 INFO - PROCESS | 1518 | |2;jquery.html;403.02468027373754;407.741084411399;408.7731309123436;412.0892826852656;428.21850123524575;15637.296321665524;16419.261133249;17657;19238.807611923894;19259.903700481496;12174.086943479253;12356.196847204925;12713.491460341598;16738.916305418486;18130;5246.554042906348;5398.946010539884;5444.428335024825;5447.891042179154;5451.64564303321;5609.747561359749;5793.391693872146;5826.766929322822;5828.47543721065;5840.678762668052;5603.831885043455;5803.100519419497;5883.176355310238;5922.31893332268;5986.850328741794;5930.673812940287;5942.524598032169;5986.431289027535;6004.849878753044;6098.695065246764;5775.325155704841;5821.767129314822;5831.737571809279;5836.212111364954;5837.620554663933;22192;22295.88520573981;22396.552068958692;22546.661800073012;22694.54610907789;2802.7617652499357;3004.3690824926794;3049.845760664492;3055.144559523337;3077.5537547055774;10202.846957295647;10252;10318.638847640372;10490.370577765283;10757.139428845674;1936.1896626654122;1977.1794705197326;1987.9801201987939;2006.237629700719;2013.7180794688754;62104;78410;78817;79243;79567.99999999942;10925.289856159325;11054.778904422028;11093.83359249612;11126.61056863006;11176.161787865942;15424.768628470581;15536.766948495782;15565.766513502307;15581.610459738597;15596.84403155954;7767.990161278997;8110.716124935717;8213.589320533949;8249.216324449168;8270.131636178236;7636.465447418627;7653.540787552764;7937.087234968052;7951.403644726669;7953.522788632585;4709.434867815884;4714.6464015199;4741.976290118596;4783.449903261169;4896.755162241945;1999.1703443070962;2043.6832290994919;2045.5704302096726;2073.2743539761263;2077.6987336836073;889.4440974391006;909.6907051602487;913.7943962608493;916.2029034739686;939.3283802081407;17427.82572174262;17504.82495175032;18336.449906502825;18708.81291187098;18736.53158671044;914.7484441778564;923.196818767663;924.2098006204733;934.1685899549407;946.7065209784851;9427.528623568795;10258;10294.536745846455;10398.511798177495;10533.262671612914;407868.63050587795;413757;416098;416225;422109;50175.74912125416;53180.73409632927;77194.6140269295;79791;79893.60053199697;972.7324985629009;987.2299606307092;988.19462138357;988.5255077562666;1003.5032658833924;16411.681502621814;16580.336786528405;16705.74941375856;16725.163741813103;16939.15304234808;32072.67927320697;33779.4933076009;38005.04987375338;40899.773006809846;41059.58940410558;55808.72095639496;55951;56693.43306566882;57086.714566426905;57949.71025145016;8244.216799404046;8277.793055173668;8560;8682.565871706516;8693.347998900234;12452.31512266834;12551.246925184518;12647.798459146366;12692.682682932631;12936.800743873377;10930.234883558074;11135.72160695989;11163.609273675382;11459.255148415326;11471.713207169887;10757.386392041257;10776.976187262198;10897.891021090005;10967.616133435291;11016.17378696585;10935.125189984941;11022.03206845551;11135.610253641084;11226.101911847196;11430.942845285721;8451.830963380575;8553.588657871382;8566.100559441418;8609.182127697859;8627.137286271323;8900.73297801067;10630.73423164427;11024.889751102386;11167.72080697989;11604.6518604442 21:56:17 INFO - PROCESS | 1518 | |3;mootools.html;1362.5980335800944;1363.0662995847838;1367.6102310841409;1380.1374141161773;1386.2999185411365;7419.703211871519;7626.771196864089;8049.235322644354;8444.788880277996;8521.360897932664;8019.198080191978;8200.7949801255;8294;8445.957770211156;8458.95770521148;2299.6665483504926;2339.146211632759;2346.9178578749747;2350.4711439925964;2353.776391242829;2314.849534780234;2317.6639387288833;2366.8461549999283;2368.928932132039;2372.1697405907967;2333.614953532665;2362.621980483123;2368.5854975379325;2368.9813380246487;2370.134900761227;2234.9664755028607;2264.241479104502;2265.060000099965;2268.6143355629583;2272.136588096521;2161.1571487119877;2177.618916689589;2177.738671359431;2195.4291884110085;2200.922967696123;8289.502629842229;8453.154684531559;8463.322934165251;8469.618867150994;8476.406651534395;5169;5282.603804714662;5289.920651190235;5291.682499050069;5296.311479507639;3168.1446009577285;3334.299797042624;3362.899113026613;3374;3438.621751607321;1337.9331033448289;1396.6717821311984;1402.6773842016291;1428.243031193469;1476.313514215884;11261.943690281496;11367.943160284229;11427.60003399877;11515.59695410665;11543.595974140948;4270.252705776476;4422.049259409242;4474.843380481668;4536.865783554112;4544.88637784058;9061.456312621263;9086.863697044417;9185.494797786052;9207.355485115977;9213.355065145375;5176.197689358156;5185.455527169668;5186.844394668166;5198.70032491877;5207.895842083213;4749.382580264612;4763.499832517605;4783.425988881357;4800.159972004955;4863.975680121647;3519.8240087995496;3561.4479755637917;3579.6062433132333;3612.8554857805393;3772.396416573335;1057.3602970202917;1181.1141643767176;1206.9094817888692;1207.2032458577296;1220.1398014399826;911.7538264668502;935.7473482159779;936.4474959773767;936.9859452108224;943.099340130174;5399.434780878089;5692.943070569241;5756;5847.502962248172;5867.061270196748;925.9398139120935;954.6849539651898;968.4625033106694;970.4080510888352;988.8071825993862;3788.431735239681;3908.4528166056775;3964.0684439156776;4096.221717873595;4113.300738874339;10088.596456141671;10125.240606954361;10273.229507786946;10296;10333.586656533806;9989.750256243651;10208.336458130198;10218.591256349811;10220.335678180894;10248.795024099476;7741.535507869546;7852.450328476952;7918;7933.603319833986;7949.403794715419;5652.850024095966;5723.084306510938;5814.680192589448;5860.765569377178;5874.5887787854435;9213.355065145644;9291.953540232256;9330.486823224788;9339.159475647224;9414.340996130479;9360.578773955325;9367;9455.14903658674;9484.336096473457;9733.61065557398;7065;7165.856682866418;7285.453590980592;7298.56208627484;7309.853802924018;8030.397720170894;8083;8143.104258531675;8179.836403271782;8186.426950113435;7275.126984761862;7422.628868556442;7455.254474552501;7507.249275072449;7511.098668159637;7189.209186989531;7209.211826100823;7216.96391518039;7249.202587715242;7395.741149059757;6566.113574667359;6663.433608143362;6730.687515934345;6732.764353247613;6748.831279218059;4892.217245240744;4913.508649135201;5015.874603134951;5056.469070747518;5115.053715062725;4709.835155769531;4794.616430685606;4807.182778927521;4911;4982.427020892499 21:56:17 INFO - PROCESS | 1518 | |4;prototype.html;383.3157813303254;399.8980260033691;404.60550962811254;405.557941843391;407.9082206503539;5331.546818520425;5414.8917021659645;5416;5456.972715136429;5474.003977096721;5383.012428102402;5398.16462402783;5398.946010539893;5414.1321244170795;5415.756290966906;4162.438070860433;4272.0562144224305;4289.957100428987;4324.783760811963;4327.913441731163;4301.849435269766;4309.612134907858;4315.892102697442;4335.219660461115;4346.6739994500385;4296.162248361571;4345;4349.717268377562;4369.279068953619;4369.8419918721565;4253;4279.33670281107;4287.764172970486;4304.440422745054;4368.934465983013;3893.6495715385468;3893.7079719020903;3898.902527436837;3903.473031140788;3909.7263191576603;5313.628046036779;5316.601254905898;5320.441353657849;5334.333208348957;5342.626016178869;4864.148773964542;4972.975135124338;5003.5246651568405;5011.699298042129;5032.84901452957;5657.57568182388;5688.402717714622;5711.286089238845;5726.5705072119345;5728.455796699307;4245.150969806051;4355.716878402894;4362.934555981663;4382.561743825624;4384.583464570861;5858.47273745365;5864.560157988125;5875.706214689249;5900.793472228452;6009.369016253318;4486.551344865553;4492.415985921874;4503;4506.436695413074;4507.143642707875;4539.477960034572;4566.703164294377;4576.290674945389;4577.8397756078375;4581.541845815392;4862.5380588844;4915.95084049155;4961.2558116282125;4991.5258050485145;5059.696418214919;5656.43435656431;5690.573207009491;5692.829215123553;5715.857103572361;5777.797777077866;1508.6077619818925;1509.7056074065672;1512.7277090123664;1529.1360381384482;1533.4479587348546;939.915407613318;993.4933184076028;994.2394068537575;1010.2877471382658;1113.3932007056173;5246.632735708464;5252.264682944391;5270.420253772082;5302.363716353985;5305.681659100466;5486.945130548644;5543.944560554342;5571.498565129158;5647.887042259214;5698.686572238566;4999.65002449825;5120.92318615221;5201.453847345974;5204.76578553966;5259.737013149327;2931.853407329625;2943.543750718642;2947.60207372002;2957.9112626621236;2986.9551956720666;5757.86196522896;5782.392848750821;5783.652980821164;5784.71076446176;5820.417958204146;5876.529877609781;5951.880962380728;5997.940020599825;6008.24896887889;6045.183900173508;6080.179175811298;6128.846778830476;6148.78479253224;6158.7228574714245;6168.550390658192;5881.5000724937145;5896.528277737856;5896.882062358814;5924.555658325729;5928.644281343133;5564.137558678412;5797.942020579909;5832.12518122285;5844.47399734026;5854.443827836349;6177.598456100339;6177.62934223948;6183.628982261079;6190.721417536131;6191.566590338633;3996.7610040887416;4132.566080561498;4147.688923330823;4151.584841515824;4155.210510003089;5901.734421950937;5904.261967254093;5905.822825315247;5910.881782364415;5913.231279933581;5761.164631128547;5770.2498675171955;5803.7968671098;5805.390434004369;5826.912596311144;5457.918131227955;5721.742521586455;5744.32363287488;5773.018586840331;5806.8096040312475;5745.2818397700285;5753.734178480728;5763.971180144073;5780.884382312414;5784.190213370216;5628.915566266427;5766.538676905753;5789;5798.710064496842;5809.390014048464;5617.8033768817895;5630.915536266877;5643.943560564506;5654.321481422091;5671.489565939085 21:56:17 INFO - PROCESS | 1518 | |5;yui.html;676.3844901139961;745.8284594543255;784.7214238945176;791.5013541468876;798.3533337996228;14935.701285974274;15745.212739363044;15865.127417992006;15878;15879.047257164579;15315.387384504607;15425.15161666108;15461.30424130914;15564.37742490299;15587.14270715113;667.4526887951881;690.1855810144028;748.2554857916381;768.0591275687294;791.0349373764013;814.8207394373228;816.4488969945293;818.3167055508658;822;827.0117209934131;860.5783166248524;861.9784505387385;862.4135587800293;874.9475031498099;876.6843936182969;851.4805968359295;852.6972924611766;862.0732712334235;864.9351298652564;867.5315329721942;627.1157667688583;633.2306247908767;635.5900444213503;636.5067073018402;636.5607730665826;15025.525913271493;15153.393864245418;15170.544883653509;15889.36442542297;16148.59628509285;14920.62698432537;15040.774388384183;15163.696726065527;15398.153101579408;15400.537983860502;12414.255144691348;12662.746745065047;12771.425285862158;12808.10343275971;12866.806997895039;3437.364087643794;3497.3879571075213;3539.6460353964653;3573.749837511375;3644.2893635741043;77245.8413123798;77356.61321693411;77756.22243777546;79029.20970790334;79559.20440795633;11586.652400428;11730.178887477965;11929.58246461387;12315.876841231653;12436.875631243753;22190.112395504322;22650.66024009641;22684;22695.319140425814;22714.659280110813;8347.165283471604;8389.916100839035;8518.105598912149;8586.65653373858;8618.78453038679;4490.326451032306;4520.021287072114;4598.954010459853;4609.285560738091;4640.373549570832;3491.2144767427126;3562.5546806649168;3579.982100089535;3583.2475180212446;3613.33153366628;610.856448734547;613.2212090644856;613.8035828534915;625.5277265664486;629.9825781363157;738.9371903388272;752.420636110192;766.3371183925975;775.902098530573;799.9000124984377;8777.517236551923;9402.576884040234;9958.900410995942;10217.591296348211;10512.684619461428;614.2628845385556;622.7602373086395;623.3579413204316;626.5269721360344;628.2837565175703;4622.560856718674;4685.484596694361;4758.333833263346;4793.640476964241;4854.320395144682;64511;78479.60760196163;79804.60097699474;81451.18548814555;82229.17770822335;60958.085628715606;61104;69512;69723.3027669727;71045.64477177581;61150.38849611447;61472.692636537424;61567.38432615706;63024;63656.36343636597;9204.401713888576;9323.673671421468;9517.2862035349;9518.666846660612;9560.522750816675;36442.45336319904;37294;38207.61792382152;40384.3942340871;41050.58949410468;50020;50406.49593504018;50760;55133;55419.722901385234;12064.93967530192;12188.695282618006;12218.20581662189;12397;12851.238027105412;14286.85713142897;14398.136111833324;14631.341589628706;14683.265836708335;14937.551873443814;13632.795508067189;13723.725525489235;13765.174089554259;14385.058017167548;14813.274309991111;13876.23680697531;14212;14262.215578143301;14364.928175359057;14384.352704128549;13453.596392108253;14305.21321327337;14409.42362305496;14413.927930360282;14450.132992020512;11558.306501609593;11739.941300293443;12165.148439609142;12572.182808117443;12619;10833.51249193804;11356.54573817038;11405.828912566483;11502.137339699724;11606 21:56:17 INFO - PROCESS | 1518 | __end_tp_report 21:56:17 INFO - PROCESS | 1518 | __start_cc_report 21:56:17 INFO - PROCESS | 1518 | _x_x_mozilla_cycle_collect,310 21:56:17 INFO - PROCESS | 1518 | __end_cc_report 21:56:17 INFO - PROCESS | 1518 | __startTimestamp1483077377876__endTimestamp 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | ------- Summary: start ------- 21:56:17 INFO - PROCESS | 1518 | Number of tests: 6 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | [#0] dojo.html Cycles:165 Average:5446.24 Median:5707.66 stddev:625.94 (11.0%) stddev-sans-first:602.31 21:56:17 INFO - PROCESS | 1518 | Values: 3190.1 3213.2 3234.9 3240.7 3245.4 5332.6 5459.4 5480.4 5539.7 5552.6 5365.3 5392.9 5440.3 5440.5 5547.8 4894.9 4930.2 4957.0 5046.6 5065.5 4857.8 4983.3 5068.3 5092.6 5092.7 4848.2 5032.1 5050.2 5075.7 5088.4 4879.8 4954.8 4986.9 5018.9 5074.4 4972.7 4975.4 4985.2 4992.7 5014.5 5440.3 5490.9 5521.7 5526.4 5576.2 5716.2 5753.2 5757.8 5778.8 5787.2 5777.9 5787.3 5788.0 5843.4 5846.7 5424.1 5432.2 5439.8 5441.1 5450.7 5834.2 5871.7 5902.1 5923.1 5945.3 5707.7 5744.4 5773.0 5799.6 5824.9 5808.9 5812.2 5822.8 5846.2 5874.1 5584.7 5619.8 5793.8 5826.3 5844.4 5869.8 5875.3 5875.4 5888.9 5925.8 4439.1 4447.5 4448.0 4467.2 4485.5 3882.8 3885.5 3889.3 3948.0 3960.1 5616.2 5645.6 5646.7 5711.8 5722.5 5898.0 5902.6 5965.0 5970.8 5980.5 5407.1 5428.3 5554.7 5648.9 5668.1 4893.6 4913.4 4914.4 4935.6 4957.4 6140.6 6156.1 6167.8 6191.0 6191.8 5695.7 5747.1 5916.1 5917.3 5926.6 6086.1 6090.3 6133.3 6169.0 6183.4 5801.8 5851.6 5854.0 5856.9 5894.5 5754.0 5794.9 5932.7 5952.1 5959.3 5654.4 5724.7 5726.5 5735.9 5748.6 5654.7 5724.8 5725.6 5744.0 5770.6 5561.5 5569.0 5751.0 5754.0 5777.9 5698.5 5854.2 5866.0 5872.9 5875.8 5504.3 5726.1 5736.1 5740.0 5745.1 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | [#1] ext.html Cycles:180 Average:57305.11 Median:34257.81 stddev:116188.79 (339.2%) stddev-sans-first:116436.59 21:56:17 INFO - PROCESS | 1518 | Values: 551.1 563.6 574.6 574.8 581.4 40282.0 41563.8 41599.0 44815.3 45042.3 43466.3 44065.8 44253.6 44285.3 44441.6 8719.9 9007.6 9016.6 10091.4 10388.7 10342.8 10423.4 10428.6 10435.7 10485.6 10359.2 10392.1 10424.8 10452.1 10519.8 10403.1 10405.0 10467.1 10491.6 10530.6 10332.2 10366.1 10404.5 10440.1 10484.9 33382.3 33816.7 33915.2 34137.5 34378.1 3858.3 3951.8 3993.6 4012.0 4039.6 28745.0 29001.7 29054.0 29163.9 29833.6 3976.7 3995.7 4019.2 4029.4 4063.7 325448.0 327549.0 328521.0 328720.4 329045.0 50407.5 51058.5 51150.0 51172.5 51201.9 53123.0 53292.6 53395.5 53486.5 53507.2 14810.6 15392.5 15398.6 15398.7 15414.6 11624.5 11871.1 12001.6 12283.2 12335.9 17044.1 17072.9 17076.5 17084.5 17163.0 6794.7 6857.6 6881.9 6973.8 7000.4 885.3 890.4 897.6 902.4 913.5 29695.4 29970.0 30001.4 30276.8 30544.5 1006.8 1068.5 1083.2 1102.4 1111.6 15489.6 15709.4 16014.3 16050.6 16054.8 542941.0 543419.0 545389.0 547954.0 550174.0 57129.7 57568.0 57670.7 57692.7 57739.1 1355.6 1389.5 1391.2 1396.9 1407.3 28560.9 28661.7 29142.3 29298.0 30357.7 48765.0 49005.5 49518.5 49519.0 49538.8 409357.0 409512.7 409571.0 409837.0 411095.0 25563.6 25603.9 25824.9 26728.2 26916.0 41204.2 41213.6 41249.2 41886.4 42202.8 34884.3 34906.5 35054.3 35433.3 35900.1 34591.7 34614.8 34776.8 34831.3 34973.0 34599.7 34792.8 34874.7 35126.6 35790.5 29533.9 31509.4 31825.4 31924.2 32159.2 24286.8 24418.5 24544.3 24686.0 25061.4 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | [#2] jquery.html Cycles:180 Average:25631.06 Median:20654.27 stddev:68360.26 (331.0%) stddev-sans-first:68525.78 21:56:17 INFO - PROCESS | 1518 | Values: 403.0 407.7 408.8 412.1 428.2 15637.3 16419.3 17657.0 19238.8 19259.9 12174.1 12356.2 12713.5 16738.9 18130.0 5246.6 5398.9 5444.4 5447.9 5451.6 5609.7 5793.4 5826.8 5828.5 5840.7 5603.8 5803.1 5883.2 5922.3 5986.9 5930.7 5942.5 5986.4 6004.8 6098.7 5775.3 5821.8 5831.7 5836.2 5837.6 22192.0 22295.9 22396.6 22546.7 22694.5 2802.8 3004.4 3049.8 3055.1 3077.6 10202.8 10252.0 10318.6 10490.4 10757.1 1936.2 1977.2 1988.0 2006.2 2013.7 62104.0 78410.0 78817.0 79243.0 79568.0 10925.3 11054.8 11093.8 11126.6 11176.2 15424.8 15536.8 15565.8 15581.6 15596.8 7768.0 8110.7 8213.6 8249.2 8270.1 7636.5 7653.5 7937.1 7951.4 7953.5 4709.4 4714.6 4742.0 4783.4 4896.8 1999.2 2043.7 2045.6 2073.3 2077.7 889.4 909.7 913.8 916.2 939.3 17427.8 17504.8 18336.4 18708.8 18736.5 914.7 923.2 924.2 934.2 946.7 9427.5 10258.0 10294.5 10398.5 10533.3 407868.6 413757.0 416098.0 416225.0 422109.0 50175.7 53180.7 77194.6 79791.0 79893.6 972.7 987.2 988.2 988.5 1003.5 16411.7 16580.3 16705.7 16725.2 16939.2 32072.7 33779.5 38005.0 40899.8 41059.6 55808.7 55951.0 56693.4 57086.7 57949.7 8244.2 8277.8 8560.0 8682.6 8693.3 12452.3 12551.2 12647.8 12692.7 12936.8 10930.2 11135.7 11163.6 11459.3 11471.7 10757.4 10777.0 10897.9 10967.6 11016.2 10935.1 11022.0 11135.6 11226.1 11430.9 8451.8 8553.6 8566.1 8609.2 8627.1 8900.7 10630.7 11024.9 11167.7 11604.7 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | [#3] mootools.html Cycles:180 Average:5511.04 Median:5180.83 stddev:3027.86 (58.4%) stddev-sans-first:3020.30 21:56:17 INFO - PROCESS | 1518 | Values: 1362.6 1363.1 1367.6 1380.1 1386.3 7419.7 7626.8 8049.2 8444.8 8521.4 8019.2 8200.8 8294.0 8446.0 8459.0 2299.7 2339.1 2346.9 2350.5 2353.8 2314.8 2317.7 2366.8 2368.9 2372.2 2333.6 2362.6 2368.6 2369.0 2370.1 2235.0 2264.2 2265.1 2268.6 2272.1 2161.2 2177.6 2177.7 2195.4 2200.9 8289.5 8453.2 8463.3 8469.6 8476.4 5169.0 5282.6 5289.9 5291.7 5296.3 3168.1 3334.3 3362.9 3374.0 3438.6 1337.9 1396.7 1402.7 1428.2 1476.3 11261.9 11367.9 11427.6 11515.6 11543.6 4270.3 4422.0 4474.8 4536.9 4544.9 9061.5 9086.9 9185.5 9207.4 9213.4 5176.2 5185.5 5186.8 5198.7 5207.9 4749.4 4763.5 4783.4 4800.2 4864.0 3519.8 3561.4 3579.6 3612.9 3772.4 1057.4 1181.1 1206.9 1207.2 1220.1 911.8 935.7 936.4 937.0 943.1 5399.4 5692.9 5756.0 5847.5 5867.1 925.9 954.7 968.5 970.4 988.8 3788.4 3908.5 3964.1 4096.2 4113.3 10088.6 10125.2 10273.2 10296.0 10333.6 9989.8 10208.3 10218.6 10220.3 10248.8 7741.5 7852.5 7918.0 7933.6 7949.4 5652.9 5723.1 5814.7 5860.8 5874.6 9213.4 9292.0 9330.5 9339.2 9414.3 9360.6 9367.0 9455.1 9484.3 9733.6 7065.0 7165.9 7285.5 7298.6 7309.9 8030.4 8083.0 8143.1 8179.8 8186.4 7275.1 7422.6 7455.3 7507.2 7511.1 7189.2 7209.2 7217.0 7249.2 7395.7 6566.1 6663.4 6730.7 6732.8 6748.8 4892.2 4913.5 5015.9 5056.5 5115.1 4709.8 4794.6 4807.2 4911.0 4982.4 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | [#4] prototype.html Cycles:180 Average:4841.85 Median:5406.54 stddev:1390.69 (25.7%) stddev-sans-first:1353.73 21:56:17 INFO - PROCESS | 1518 | Values: 383.3 399.9 404.6 405.6 407.9 5331.5 5414.9 5416.0 5457.0 5474.0 5383.0 5398.2 5398.9 5414.1 5415.8 4162.4 4272.1 4290.0 4324.8 4327.9 4301.8 4309.6 4315.9 4335.2 4346.7 4296.2 4345.0 4349.7 4369.3 4369.8 4253.0 4279.3 4287.8 4304.4 4368.9 3893.6 3893.7 3898.9 3903.5 3909.7 5313.6 5316.6 5320.4 5334.3 5342.6 4864.1 4973.0 5003.5 5011.7 5032.8 5657.6 5688.4 5711.3 5726.6 5728.5 4245.2 4355.7 4362.9 4382.6 4384.6 5858.5 5864.6 5875.7 5900.8 6009.4 4486.6 4492.4 4503.0 4506.4 4507.1 4539.5 4566.7 4576.3 4577.8 4581.5 4862.5 4916.0 4961.3 4991.5 5059.7 5656.4 5690.6 5692.8 5715.9 5777.8 1508.6 1509.7 1512.7 1529.1 1533.4 939.9 993.5 994.2 1010.3 1113.4 5246.6 5252.3 5270.4 5302.4 5305.7 5486.9 5543.9 5571.5 5647.9 5698.7 4999.7 5120.9 5201.5 5204.8 5259.7 2931.9 2943.5 2947.6 2957.9 2987.0 5757.9 5782.4 5783.7 5784.7 5820.4 5876.5 5951.9 5997.9 6008.2 6045.2 6080.2 6128.8 6148.8 6158.7 6168.6 5881.5 5896.5 5896.9 5924.6 5928.6 5564.1 5797.9 5832.1 5844.5 5854.4 6177.6 6177.6 6183.6 6190.7 6191.6 3996.8 4132.6 4147.7 4151.6 4155.2 5901.7 5904.3 5905.8 5910.9 5913.2 5761.2 5770.2 5803.8 5805.4 5826.9 5457.9 5721.7 5744.3 5773.0 5806.8 5745.3 5753.7 5764.0 5780.9 5784.2 5628.9 5766.5 5789.0 5798.7 5809.4 5617.8 5630.9 5643.9 5654.3 5671.5 21:56:17 INFO - PROCESS | 1518 | 21:56:17 INFO - PROCESS | 1518 | [#5] yui.html Cycles:180 Average:17442.25 Median:4615.92 stddev:21838.57 (473.1%) stddev-sans-first:21863.54 21:56:17 INFO - PROCESS | 1518 | Values: 676.4 745.8 784.7 791.5 798.4 14935.7 15745.2 15865.1 15878.0 15879.0 15315.4 15425.2 15461.3 15564.4 15587.1 667.5 690.2 748.3 768.1 791.0 814.8 816.4 818.3 822.0 827.0 860.6 862.0 862.4 874.9 876.7 851.5 852.7 862.1 864.9 867.5 627.1 633.2 635.6 636.5 636.6 15025.5 15153.4 15170.5 15889.4 16148.6 14920.6 15040.8 15163.7 15398.2 15400.5 12414.3 12662.7 12771.4 12808.1 12866.8 3437.4 3497.4 3539.6 3573.7 3644.3 77245.8 77356.6 77756.2 79029.2 79559.2 11586.7 11730.2 11929.6 12315.9 12436.9 22190.1 22650.7 22684.0 22695.3 22714.7 8347.2 8389.9 8518.1 8586.7 8618.8 4490.3 4520.0 4599.0 4609.3 4640.4 3491.2 3562.6 3580.0 3583.2 3613.3 610.9 613.2 613.8 625.5 630.0 738.9 752.4 766.3 775.9 799.9 8777.5 9402.6 9958.9 10217.6 10512.7 614.3 622.8 623.4 626.5 628.3 4622.6 4685.5 4758.3 4793.6 4854.3 64511.0 78479.6 79804.6 81451.2 82229.2 60958.1 61104.0 69512.0 69723.3 71045.6 61150.4 61472.7 61567.4 63024.0 63656.4 9204.4 9323.7 9517.3 9518.7 9560.5 36442.5 37294.0 38207.6 40384.4 41050.6 50020.0 50406.5 50760.0 55133.0 55419.7 12064.9 12188.7 12218.2 12397.0 12851.2 14286.9 14398.1 14631.3 14683.3 14937.6 13632.8 13723.7 13765.2 14385.1 14813.3 13876.2 14212.0 14262.2 14364.9 14384.4 13453.6 14305.2 14409.4 14413.9 14450.1 11558.3 11739.9 12165.1 12572.2 12619.0 10833.5 11356.5 11405.8 11502.1 11606.0 21:56:17 INFO - PROCESS | 1518 | -------- Summary: end -------- 21:56:17 INFO - PROCESS | 1518 | 21:56:18 INFO - TEST-INFO | 1518: exit 0 21:56:18 INFO - TEST-OK | dromaeo_css | took 1114489ms 21:56:18 INFO - TEST-START | kraken 21:56:18 INFO - operating with platform_type : linux_ 21:56:18 INFO - Initialising browser for kraken test... 21:56:18 INFO - TEST-INFO | started process 1878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqB89A0/profile http://localhost:40580/getInfo.html) 21:56:19 INFO - PROCESS | 1878 | 1483077379128 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 21:56:23 INFO - PROCESS | 1878 | __metrics Screen width/height:1600/1200 21:56:23 INFO - PROCESS | 1878 | colorDepth:24 21:56:23 INFO - PROCESS | 1878 | Browser inner width/height: 1024/697 21:56:23 INFO - PROCESS | 1878 | __metrics 21:56:23 ERROR - PROCESS | 1878 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 21:56:24 INFO - TEST-INFO | 1878: exit 0 21:56:24 INFO - Browser initialized. 21:56:24 INFO - Running cycle 1/1 for kraken test... 21:56:24 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqB89A0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:36 INFO - PROCESS | 2004 | RSS: Main: 153960448 21:56:36 INFO - PROCESS | 2004 | 21:56:39 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-beat-detection) 21:56:40 INFO - PROCESS | 2004 | RSS: Main: 159612928 21:56:40 INFO - PROCESS | 2004 | 21:56:42 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-dft) 21:56:43 INFO - PROCESS | 2004 | RSS: Main: 159211520 21:56:43 INFO - PROCESS | 2004 | 21:56:46 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-fft) 21:56:46 INFO - PROCESS | 2004 | RSS: Main: 155828224 21:56:46 INFO - PROCESS | 2004 | 21:56:48 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-oscillator) 21:56:49 INFO - PROCESS | 2004 | RSS: Main: 156692480 21:56:49 INFO - PROCESS | 2004 | 21:56:51 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:56:52 INFO - PROCESS | 2004 | RSS: Main: 157024256 21:56:52 INFO - PROCESS | 2004 | 21:56:55 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40580/tests/kraken/driver.html?testName=imaging-darkroom) 21:56:56 INFO - PROCESS | 2004 | RSS: Main: 160731136 21:56:56 INFO - PROCESS | 2004 | 21:56:59 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40580/tests/kraken/driver.html?testName=imaging-desaturate) 21:57:00 INFO - PROCESS | 2004 | RSS: Main: 161513472 21:57:00 INFO - PROCESS | 2004 | 21:57:02 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40580/tests/kraken/driver.html?testName=json-parse-financial) 21:57:03 INFO - PROCESS | 2004 | RSS: Main: 160419840 21:57:03 INFO - PROCESS | 2004 | 21:57:05 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:57:05 INFO - PROCESS | 2004 | RSS: Main: 160546816 21:57:05 INFO - PROCESS | 2004 | 21:57:07 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:57:08 INFO - PROCESS | 2004 | RSS: Main: 160280576 21:57:08 INFO - PROCESS | 2004 | 21:57:10 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:57:11 INFO - PROCESS | 2004 | RSS: Main: 161071104 21:57:11 INFO - PROCESS | 2004 | 21:57:13 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:57:14 INFO - PROCESS | 2004 | RSS: Main: 160456704 21:57:14 INFO - PROCESS | 2004 | 21:57:17 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:57:17 INFO - PROCESS | 2004 | RSS: Main: 161095680 21:57:17 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40580/tests/kraken/driver.html?testName=ai-astar) 21:57:19 INFO - PROCESS | 2004 | RSS: Main: 162201600 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | __start_tp_report 21:57:19 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 21:57:19 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 21:57:19 INFO - PROCESS | 2004 | |i|pagename|runs| 21:57:19 INFO - PROCESS | 2004 | |0;ai-astar;103;112;111;110;111;112;110;113;112;111 21:57:19 INFO - PROCESS | 2004 | |1;audio-beat-detection;149;125;122;169;122;124;126;129;149;126 21:57:19 INFO - PROCESS | 2004 | |2;audio-dft;165;163;163;162;164;168;166;165;163;163 21:57:19 INFO - PROCESS | 2004 | |3;audio-fft;76;76;78;113;77;77;76;78;95;75 21:57:19 INFO - PROCESS | 2004 | |4;audio-oscillator;83;82;115;83;83;83;102;83;82;110 21:57:19 INFO - PROCESS | 2004 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;118;118 21:57:19 INFO - PROCESS | 2004 | |6;imaging-darkroom;148;148;148;148;148;148;150;148;147;148 21:57:19 INFO - PROCESS | 2004 | |7;imaging-desaturate;96;98;96;96;97;96;97;99;96;96 21:57:19 INFO - PROCESS | 2004 | |8;json-parse-financial;58;60;61;57;59;59;59;58;58;62 21:57:19 INFO - PROCESS | 2004 | |9;json-stringify-tinderbox;68;67;67;67;68;67;67;67;68;68 21:57:19 INFO - PROCESS | 2004 | |10;stanford-crypto-aes;81;83;82;83;86;81;81;85;87;84 21:57:19 INFO - PROCESS | 2004 | |11;stanford-crypto-ccm;132;127;129;132;129;128;133;131;172;128 21:57:19 INFO - PROCESS | 2004 | |12;stanford-crypto-pbkdf2;178;178;170;162;165;166;172;170;166;175 21:57:19 INFO - PROCESS | 2004 | |13;stanford-crypto-sha256-iterative;63;66;64;63;63;63;68;61;62;62 21:57:19 INFO - PROCESS | 2004 | __end_tp_report 21:57:19 INFO - PROCESS | 2004 | __start_cc_report 21:57:19 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,729 21:57:19 INFO - PROCESS | 2004 | __end_cc_report 21:57:19 INFO - PROCESS | 2004 | __startTimestamp1483077439826__endTimestamp 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | ------- Summary: start ------- 21:57:19 INFO - PROCESS | 2004 | Number of tests: 14 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 21:57:19 INFO - PROCESS | 2004 | Values: 103.0 112.0 111.0 110.0 111.0 112.0 110.0 113.0 112.0 111.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:127.50 stddev:15.98 (12.5%) stddev-sans-first:16.01 21:57:19 INFO - PROCESS | 2004 | Values: 149.0 125.0 122.0 169.0 122.0 124.0 126.0 129.0 149.0 126.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 21:57:19 INFO - PROCESS | 2004 | Values: 165.0 163.0 163.0 162.0 164.0 168.0 166.0 165.0 163.0 163.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:12.33 (16.0%) stddev-sans-first:12.88 21:57:19 INFO - PROCESS | 2004 | Values: 76.0 76.0 78.0 113.0 77.0 77.0 76.0 78.0 95.0 75.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.00 stddev:13.07 (15.8%) stddev-sans-first:13.57 21:57:19 INFO - PROCESS | 2004 | Values: 83.0 82.0 115.0 83.0 83.0 83.0 102.0 83.0 82.0 110.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:57:19 INFO - PROCESS | 2004 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 21:57:19 INFO - PROCESS | 2004 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 150.0 148.0 147.0 148.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:1.06 (1.1%) stddev-sans-first:1.09 21:57:19 INFO - PROCESS | 2004 | Values: 96.0 98.0 96.0 96.0 97.0 96.0 97.0 99.0 96.0 96.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:1.52 (2.6%) stddev-sans-first:1.56 21:57:19 INFO - PROCESS | 2004 | Values: 58.0 60.0 61.0 57.0 59.0 59.0 59.0 58.0 58.0 62.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 21:57:19 INFO - PROCESS | 2004 | Values: 68.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 68.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:2.16 (2.6%) stddev-sans-first:2.13 21:57:19 INFO - PROCESS | 2004 | Values: 81.0 83.0 82.0 83.0 86.0 81.0 81.0 85.0 87.0 84.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:131.50 stddev:13.47 (10.2%) stddev-sans-first:14.27 21:57:19 INFO - PROCESS | 2004 | Values: 132.0 127.0 129.0 132.0 129.0 128.0 133.0 131.0 172.0 128.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:5.55 (3.2%) stddev-sans-first:5.12 21:57:19 INFO - PROCESS | 2004 | Values: 178.0 178.0 170.0 162.0 165.0 166.0 172.0 170.0 166.0 175.0 21:57:19 INFO - PROCESS | 2004 | 21:57:19 INFO - PROCESS | 2004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.19 21:57:19 INFO - PROCESS | 2004 | Values: 63.0 66.0 64.0 63.0 63.0 63.0 68.0 61.0 62.0 62.0 21:57:19 INFO - PROCESS | 2004 | -------- Summary: end -------- 21:57:19 INFO - PROCESS | 2004 | 21:57:20 INFO - TEST-INFO | 2004: exit 0 21:57:20 INFO - TEST-OK | kraken | took 62200ms 21:57:20 INFO - SUITE-END | took 1176s 21:57:20 INFO - Completed test suite (00:19:36) 21:57:20 INFO - javascript benchmark 21:57:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7138.6041532909285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3190.1067701043703, 3213.2127628730964, 3234.900133954455, 3240.740740740741, 3245.350929814038, 5332.600054995881, 5459.372172200198, 5480.397156312807, 5539.695316757582, 5552.611317207797, 5365.302510673617, 5392.892142157155, 5440.347158341005, 5440.510354068133, 5547.77808887645, 4894.8776280593, 4930.186519224341, 4956.950430495685, 5046.621503387242, 5065.468125846788, 4857.805687772502, 4983.302337672729, 5068.290439338495, 5092.643514953955, 5092.719900405476, 4848.200046992242, 5032.0690672225755, 5050.242463630448, 5075.720835354054, 5088.414832294259, 4879.82920597781, 4954.826581069645, 4986.850394488171, 5018.924716129261, 5074.416442109168, 4972.726500042496, 4975.4029516457895, 4985.227289770091, 4992.650514463989, 5014.548690617826, 5440.319960004999, 5490.862728431821, 5521.696306703129, 5526.419725928759, 5576.163575463673, 5716.228309178249, 5753.194552762617, 5757.769689212427, 5778.797742079049, 5787.218725472049, 5777.913331300034, 5787.334456537468, 5788.0, 5843.357230704619, 5846.736896839652, 5424.1321388577635, 5432.158015507603, 5439.83680489582, 5441.102218133963, 5450.700211488406, 5834.241548598655, 5871.735771890275, 5902.1441890926435, 5923.08192230205, 5945.316288626863, 5707.6575405475805, 5744.425557444222, 5773.018586840247, 5799.5650326225705, 5824.854378640568, 5808.94191058084, 5812.157237200667, 5822.796202132905, 5846.239988801429, 5874.089516125007, 5584.748686309044, 5619.831405057855, 5793.768249270066, 5826.300843898759, 5844.386339434383, 5869.765209391662, 5875.265591801025, 5875.383084776123, 5888.852778680567, 5925.762969481259, 4439.089986552749, 4447.510773814878, 4448.0, 4467.218236808546, 4485.48416932057, 3882.8446862125197, 3885.4560361549406, 3889.3193691103943, 3947.9932617182435, 3960.0693836948294, 5616.241807355955, 5645.633033852787, 5646.661200327993, 5711.771529138871, 5722.484976352148, 5898.0, 5902.61632993854, 5964.970175149183, 5970.791022314285, 5980.461758441761, 5407.134858422633, 5428.294321738149, 5554.666719996813, 5648.887022259614, 5668.121441176624, 4893.559579637849, 4913.434954980152, 4914.410270767531, 4935.629827762932, 4957.405111386656, 6140.600860944024, 6156.138140660311, 6167.814965551041, 6190.969045154836, 6191.783287585003, 5695.7436915338085, 5747.08046712524, 5916.05343145112, 5917.289925209003, 5926.585139040226, 6086.1175129606845, 6090.330063693079, 6133.294671112879, 6169.043798211284, 6183.443490085734, 5801.76792928295, 5851.561132915133, 5854.0048191806645, 5856.882862342644, 5894.528437725057, 5754.0, 5794.942050579441, 5932.733027013881, 5952.107183922446, 5959.255093113361, 5654.40628733977, 5724.65652060861, 5726.455986681425, 5735.8566035849435, 5748.597598168088, 5654.745536450787, 5724.8282551523525, 5725.570582206268, 5744.023516002206, 5770.596058275881, 5561.5272701820795, 5569.0, 5751.0, 5754.0, 5777.942220577908, 5698.515626171822, 5854.2389489366105, 5866.0, 5872.882542349043, 5875.794347197828, 5504.339479262514, 5726.112452569859, 5736.139579063174, 5740.0, 5745.080787074048], "value": 5403.872288676786, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.0686939072967, 563.6195567991607, 574.5891687443477, 574.7729646789518, 581.3982528083435, 40282.0, 41563.79218103909, 41599.0, 44815.32777008347, 45042.32436513455, 43466.34800477987, 44065.77967110168, 44253.55746442534, 44285.33571996423, 44441.55558444415, 8719.912800872005, 9007.594658240361, 9016.594253258587, 10091.394516329006, 10388.688339349794, 10342.793144137113, 10423.374597524135, 10428.582856685762, 10435.686929392092, 10485.58057677692, 10359.171266298716, 10392.064714175724, 10424.843627345595, 10452.111570516516, 10519.789604207912, 10403.063724264777, 10405.0, 10467.057964783167, 10491.63279285229, 10530.631427900025, 10332.225083118796, 10366.067053965104, 10404.479776011169, 10440.060394564525, 10484.947575262075, 33382.332353352795, 33816.6618333816, 33915.15212119717, 34137.487937680955, 34378.14054648629, 3858.2862170498547, 3951.8024098794945, 3993.6206060424215, 4011.959880401188, 4039.575844536311, 28745.0, 29001.709982900324, 29054.0, 29163.854180729173, 29833.552496712568, 3976.6619837313865, 3995.7402768820225, 4019.196160767858, 4029.37544680575, 4063.6749060075417, 325448.0, 327549.0, 328521.0, 328720.3563982189, 329045.0, 50407.49592504028, 51058.489415106116, 51150.0, 51172.48827511752, 51201.92788432706, 53123.0, 53292.604887413756, 53395.466045339046, 53486.465135348146, 53507.197392039154, 14810.555683329518, 15392.461263855712, 15398.615034624, 15398.692026159413, 15414.614634634, 11624.476898539586, 11871.109666775026, 12001.63995080149, 12283.201591896499, 12335.876641233473, 17044.14779261032, 17072.91463542699, 17076.487705368858, 17084.48746537606, 17163.0, 6794.694238759268, 6857.622830744257, 6881.862362752717, 6973.825654358681, 7000.404965577983, 885.2696525366598, 890.3945317184248, 897.6319708919442, 902.4495058014605, 913.5432283858071, 29695.406091878474, 29970.02204989727, 30001.399972000876, 30276.848615757222, 30544.54183187254, 1006.8338724110587, 1068.4924660786064, 1083.2417307884512, 1102.399192440122, 1111.5664890692635, 15489.612759680873, 15709.371625135094, 16014.279357428944, 16050.592411138188, 16054.759178612096, 542941.0, 543419.0, 545389.0, 547954.0, 550174.0, 57129.714351427974, 57568.0, 57670.71164644234, 57692.711536442046, 57739.13391299134, 1355.5594431809702, 1389.4997800791707, 1391.1513976474344, 1396.9022168448314, 1407.2893188939724, 28560.85719571389, 28661.713382865906, 29142.27144321409, 29298.0, 30357.69642303637, 48765.0, 49005.50994490152, 49518.50481495139, 49519.0, 49538.75230623824, 409357.0, 409512.7146185619, 409571.0, 409837.0, 411095.0, 25563.6165457522, 25603.87198063998, 25824.8708756455, 26728.198154055408, 26916.0, 41204.175916482105, 41213.58786412217, 41249.1750165001, 41886.371704425066, 42202.788986056104, 34884.30231395409, 34906.48086131621, 35054.29891402209, 35433.291334173686, 35900.10249743777, 34591.654083458845, 34614.82692586521, 34776.82611586926, 34831.30337393289, 34973.0, 34599.65400345964, 34792.82603586966, 34874.65125348714, 35126.64873351234, 35790.46314305235, 29533.85233073821, 31509.369812604076, 31825.363492729553, 31924.201894952814, 32159.19602009875, 24286.8068642495, 24418.51162976695, 24544.263672089866, 24686.0, 25061.373465663506], "value": 19194.081318578068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.02468027373754, 407.741084411399, 408.7731309123436, 412.0892826852656, 428.21850123524575, 15637.296321665524, 16419.261133249, 17657.0, 19238.807611923894, 19259.903700481496, 12174.086943479253, 12356.196847204925, 12713.491460341598, 16738.916305418486, 18130.0, 5246.554042906348, 5398.946010539884, 5444.428335024825, 5447.891042179154, 5451.64564303321, 5609.747561359749, 5793.391693872146, 5826.766929322822, 5828.47543721065, 5840.678762668052, 5603.831885043455, 5803.100519419497, 5883.176355310238, 5922.31893332268, 5986.850328741794, 5930.673812940287, 5942.524598032169, 5986.431289027535, 6004.849878753044, 6098.695065246764, 5775.325155704841, 5821.767129314822, 5831.737571809279, 5836.212111364954, 5837.620554663933, 22192.0, 22295.88520573981, 22396.552068958692, 22546.661800073012, 22694.54610907789, 2802.7617652499357, 3004.3690824926794, 3049.845760664492, 3055.144559523337, 3077.5537547055774, 10202.846957295647, 10252.0, 10318.638847640372, 10490.370577765283, 10757.139428845674, 1936.1896626654122, 1977.1794705197326, 1987.9801201987939, 2006.237629700719, 2013.7180794688754, 62104.0, 78410.0, 78817.0, 79243.0, 79567.99999999942, 10925.289856159325, 11054.778904422028, 11093.83359249612, 11126.61056863006, 11176.161787865942, 15424.768628470581, 15536.766948495782, 15565.766513502307, 15581.610459738597, 15596.84403155954, 7767.990161278997, 8110.716124935717, 8213.589320533949, 8249.216324449168, 8270.131636178236, 7636.465447418627, 7653.540787552764, 7937.087234968052, 7951.403644726669, 7953.522788632585, 4709.434867815884, 4714.6464015199, 4741.976290118596, 4783.449903261169, 4896.755162241945, 1999.1703443070962, 2043.6832290994919, 2045.5704302096726, 2073.2743539761263, 2077.6987336836073, 889.4440974391006, 909.6907051602487, 913.7943962608493, 916.2029034739686, 939.3283802081407, 17427.82572174262, 17504.82495175032, 18336.449906502825, 18708.81291187098, 18736.53158671044, 914.7484441778564, 923.196818767663, 924.2098006204733, 934.1685899549407, 946.7065209784851, 9427.528623568795, 10258.0, 10294.536745846455, 10398.511798177495, 10533.262671612914, 407868.63050587795, 413757.0, 416098.0, 416225.0, 422109.0, 50175.74912125416, 53180.73409632927, 77194.6140269295, 79791.0, 79893.60053199697, 972.7324985629009, 987.2299606307092, 988.19462138357, 988.5255077562666, 1003.5032658833924, 16411.681502621814, 16580.336786528405, 16705.74941375856, 16725.163741813103, 16939.15304234808, 32072.67927320697, 33779.4933076009, 38005.04987375338, 40899.773006809846, 41059.58940410558, 55808.72095639496, 55951.0, 56693.43306566882, 57086.714566426905, 57949.71025145016, 8244.216799404046, 8277.793055173668, 8560.0, 8682.565871706516, 8693.347998900234, 12452.31512266834, 12551.246925184518, 12647.798459146366, 12692.682682932631, 12936.800743873377, 10930.234883558074, 11135.72160695989, 11163.609273675382, 11459.255148415326, 11471.713207169887, 10757.386392041257, 10776.976187262198, 10897.891021090005, 10967.616133435291, 11016.17378696585, 10935.125189984941, 11022.03206845551, 11135.610253641084, 11226.101911847196, 11430.942845285721, 8451.830963380575, 8553.588657871382, 8566.100559441418, 8609.182127697859, 8627.137286271323, 8900.73297801067, 10630.73423164427, 11024.889751102386, 11167.72080697989, 11604.6518604442], "value": 8906.215029645733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.5980335800944, 1363.0662995847838, 1367.6102310841409, 1380.1374141161773, 1386.2999185411365, 7419.703211871519, 7626.771196864089, 8049.235322644354, 8444.788880277996, 8521.360897932664, 8019.198080191978, 8200.7949801255, 8294.0, 8445.957770211156, 8458.95770521148, 2299.6665483504926, 2339.146211632759, 2346.9178578749747, 2350.4711439925964, 2353.776391242829, 2314.849534780234, 2317.6639387288833, 2366.8461549999283, 2368.928932132039, 2372.1697405907967, 2333.614953532665, 2362.621980483123, 2368.5854975379325, 2368.9813380246487, 2370.134900761227, 2234.9664755028607, 2264.241479104502, 2265.060000099965, 2268.6143355629583, 2272.136588096521, 2161.1571487119877, 2177.618916689589, 2177.738671359431, 2195.4291884110085, 2200.922967696123, 8289.502629842229, 8453.154684531559, 8463.322934165251, 8469.618867150994, 8476.406651534395, 5169.0, 5282.603804714662, 5289.920651190235, 5291.682499050069, 5296.311479507639, 3168.1446009577285, 3334.299797042624, 3362.899113026613, 3374.0, 3438.621751607321, 1337.9331033448289, 1396.6717821311984, 1402.6773842016291, 1428.243031193469, 1476.313514215884, 11261.943690281496, 11367.943160284229, 11427.60003399877, 11515.59695410665, 11543.595974140948, 4270.252705776476, 4422.049259409242, 4474.843380481668, 4536.865783554112, 4544.88637784058, 9061.456312621263, 9086.863697044417, 9185.494797786052, 9207.355485115977, 9213.355065145375, 5176.197689358156, 5185.455527169668, 5186.844394668166, 5198.70032491877, 5207.895842083213, 4749.382580264612, 4763.499832517605, 4783.425988881357, 4800.159972004955, 4863.975680121647, 3519.8240087995496, 3561.4479755637917, 3579.6062433132333, 3612.8554857805393, 3772.396416573335, 1057.3602970202917, 1181.1141643767176, 1206.9094817888692, 1207.2032458577296, 1220.1398014399826, 911.7538264668502, 935.7473482159779, 936.4474959773767, 936.9859452108224, 943.099340130174, 5399.434780878089, 5692.943070569241, 5756.0, 5847.502962248172, 5867.061270196748, 925.9398139120935, 954.6849539651898, 968.4625033106694, 970.4080510888352, 988.8071825993862, 3788.431735239681, 3908.4528166056775, 3964.0684439156776, 4096.221717873595, 4113.300738874339, 10088.596456141671, 10125.240606954361, 10273.229507786946, 10296.0, 10333.586656533806, 9989.750256243651, 10208.336458130198, 10218.591256349811, 10220.335678180894, 10248.795024099476, 7741.535507869546, 7852.450328476952, 7918.0, 7933.603319833986, 7949.403794715419, 5652.850024095966, 5723.084306510938, 5814.680192589448, 5860.765569377178, 5874.5887787854435, 9213.355065145644, 9291.953540232256, 9330.486823224788, 9339.159475647224, 9414.340996130479, 9360.578773955325, 9367.0, 9455.14903658674, 9484.336096473457, 9733.61065557398, 7065.0, 7165.856682866418, 7285.453590980592, 7298.56208627484, 7309.853802924018, 8030.397720170894, 8083.0, 8143.104258531675, 8179.836403271782, 8186.426950113435, 7275.126984761862, 7422.628868556442, 7455.254474552501, 7507.249275072449, 7511.098668159637, 7189.209186989531, 7209.211826100823, 7216.96391518039, 7249.202587715242, 7395.741149059757, 6566.113574667359, 6663.433608143362, 6730.687515934345, 6732.764353247613, 6748.831279218059, 4892.217245240744, 4913.508649135201, 5015.874603134951, 5056.469070747518, 5115.053715062725, 4709.835155769531, 4794.616430685606, 4807.182778927521, 4911.0, 4982.427020892499], "value": 4471.614890976994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.3157813303254, 399.8980260033691, 404.60550962811254, 405.557941843391, 407.9082206503539, 5331.546818520425, 5414.8917021659645, 5416.0, 5456.972715136429, 5474.003977096721, 5383.012428102402, 5398.16462402783, 5398.946010539893, 5414.1321244170795, 5415.756290966906, 4162.438070860433, 4272.0562144224305, 4289.957100428987, 4324.783760811963, 4327.913441731163, 4301.849435269766, 4309.612134907858, 4315.892102697442, 4335.219660461115, 4346.6739994500385, 4296.162248361571, 4345.0, 4349.717268377562, 4369.279068953619, 4369.8419918721565, 4253.0, 4279.33670281107, 4287.764172970486, 4304.440422745054, 4368.934465983013, 3893.6495715385468, 3893.7079719020903, 3898.902527436837, 3903.473031140788, 3909.7263191576603, 5313.628046036779, 5316.601254905898, 5320.441353657849, 5334.333208348957, 5342.626016178869, 4864.148773964542, 4972.975135124338, 5003.5246651568405, 5011.699298042129, 5032.84901452957, 5657.57568182388, 5688.402717714622, 5711.286089238845, 5726.5705072119345, 5728.455796699307, 4245.150969806051, 4355.716878402894, 4362.934555981663, 4382.561743825624, 4384.583464570861, 5858.47273745365, 5864.560157988125, 5875.706214689249, 5900.793472228452, 6009.369016253318, 4486.551344865553, 4492.415985921874, 4503.0, 4506.436695413074, 4507.143642707875, 4539.477960034572, 4566.703164294377, 4576.290674945389, 4577.8397756078375, 4581.541845815392, 4862.5380588844, 4915.95084049155, 4961.2558116282125, 4991.5258050485145, 5059.696418214919, 5656.43435656431, 5690.573207009491, 5692.829215123553, 5715.857103572361, 5777.797777077866, 1508.6077619818925, 1509.7056074065672, 1512.7277090123664, 1529.1360381384482, 1533.4479587348546, 939.915407613318, 993.4933184076028, 994.2394068537575, 1010.2877471382658, 1113.3932007056173, 5246.632735708464, 5252.264682944391, 5270.420253772082, 5302.363716353985, 5305.681659100466, 5486.945130548644, 5543.944560554342, 5571.498565129158, 5647.887042259214, 5698.686572238566, 4999.65002449825, 5120.92318615221, 5201.453847345974, 5204.76578553966, 5259.737013149327, 2931.853407329625, 2943.543750718642, 2947.60207372002, 2957.9112626621236, 2986.9551956720666, 5757.86196522896, 5782.392848750821, 5783.652980821164, 5784.71076446176, 5820.417958204146, 5876.529877609781, 5951.880962380728, 5997.940020599825, 6008.24896887889, 6045.183900173508, 6080.179175811298, 6128.846778830476, 6148.78479253224, 6158.7228574714245, 6168.550390658192, 5881.5000724937145, 5896.528277737856, 5896.882062358814, 5924.555658325729, 5928.644281343133, 5564.137558678412, 5797.942020579909, 5832.12518122285, 5844.47399734026, 5854.443827836349, 6177.598456100339, 6177.62934223948, 6183.628982261079, 6190.721417536131, 6191.566590338633, 3996.7610040887416, 4132.566080561498, 4147.688923330823, 4151.584841515824, 4155.210510003089, 5901.734421950937, 5904.261967254093, 5905.822825315247, 5910.881782364415, 5913.231279933581, 5761.164631128547, 5770.2498675171955, 5803.7968671098, 5805.390434004369, 5826.912596311144, 5457.918131227955, 5721.742521586455, 5744.32363287488, 5773.018586840331, 5806.8096040312475, 5745.2818397700285, 5753.734178480728, 5763.971180144073, 5780.884382312414, 5784.190213370216, 5628.915566266427, 5766.538676905753, 5789.0, 5798.710064496842, 5809.390014048464, 5617.8033768817895, 5630.915536266877, 5643.943560564506, 5654.321481422091, 5671.489565939085], "value": 4415.441802732248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.3844901139961, 745.8284594543255, 784.7214238945176, 791.5013541468876, 798.3533337996228, 14935.701285974274, 15745.212739363044, 15865.127417992006, 15878.0, 15879.047257164579, 15315.387384504607, 15425.15161666108, 15461.30424130914, 15564.37742490299, 15587.14270715113, 667.4526887951881, 690.1855810144028, 748.2554857916381, 768.0591275687294, 791.0349373764013, 814.8207394373228, 816.4488969945293, 818.3167055508658, 822.0, 827.0117209934131, 860.5783166248524, 861.9784505387385, 862.4135587800293, 874.9475031498099, 876.6843936182969, 851.4805968359295, 852.6972924611766, 862.0732712334235, 864.9351298652564, 867.5315329721942, 627.1157667688583, 633.2306247908767, 635.5900444213503, 636.5067073018402, 636.5607730665826, 15025.525913271493, 15153.393864245418, 15170.544883653509, 15889.36442542297, 16148.59628509285, 14920.62698432537, 15040.774388384183, 15163.696726065527, 15398.153101579408, 15400.537983860502, 12414.255144691348, 12662.746745065047, 12771.425285862158, 12808.10343275971, 12866.806997895039, 3437.364087643794, 3497.3879571075213, 3539.6460353964653, 3573.749837511375, 3644.2893635741043, 77245.8413123798, 77356.61321693411, 77756.22243777546, 79029.20970790334, 79559.20440795633, 11586.652400428, 11730.178887477965, 11929.58246461387, 12315.876841231653, 12436.875631243753, 22190.112395504322, 22650.66024009641, 22684.0, 22695.319140425814, 22714.659280110813, 8347.165283471604, 8389.916100839035, 8518.105598912149, 8586.65653373858, 8618.78453038679, 4490.326451032306, 4520.021287072114, 4598.954010459853, 4609.285560738091, 4640.373549570832, 3491.2144767427126, 3562.5546806649168, 3579.982100089535, 3583.2475180212446, 3613.33153366628, 610.856448734547, 613.2212090644856, 613.8035828534915, 625.5277265664486, 629.9825781363157, 738.9371903388272, 752.420636110192, 766.3371183925975, 775.902098530573, 799.9000124984377, 8777.517236551923, 9402.576884040234, 9958.900410995942, 10217.591296348211, 10512.684619461428, 614.2628845385556, 622.7602373086395, 623.3579413204316, 626.5269721360344, 628.2837565175703, 4622.560856718674, 4685.484596694361, 4758.333833263346, 4793.640476964241, 4854.320395144682, 64511.0, 78479.60760196163, 79804.60097699474, 81451.18548814555, 82229.17770822335, 60958.085628715606, 61104.0, 69512.0, 69723.3027669727, 71045.64477177581, 61150.38849611447, 61472.692636537424, 61567.38432615706, 63024.0, 63656.36343636597, 9204.401713888576, 9323.673671421468, 9517.2862035349, 9518.666846660612, 9560.522750816675, 36442.45336319904, 37294.0, 38207.61792382152, 40384.3942340871, 41050.58949410468, 50020.0, 50406.49593504018, 50760.0, 55133.0, 55419.722901385234, 12064.93967530192, 12188.695282618006, 12218.20581662189, 12397.0, 12851.238027105412, 14286.85713142897, 14398.136111833324, 14631.341589628706, 14683.265836708335, 14937.551873443814, 13632.795508067189, 13723.725525489235, 13765.174089554259, 14385.058017167548, 14813.274309991111, 13876.23680697531, 14212.0, 14262.215578143301, 14364.928175359057, 14384.352704128549, 13453.596392108253, 14305.21321327337, 14409.42362305496, 14413.927930360282, 14450.132992020512, 11558.306501609593, 11739.941300293443, 12165.148439609142, 12572.182808117443, 12619.0, 10833.51249193804, 11356.54573817038, 11405.828912566483, 11502.137339699724, 11606.0], "value": 7254.936179258855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 110.0, 111.0, 112.0, 110.0, 113.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 122.0, 169.0, 122.0, 124.0, 126.0, 129.0, 149.0, 126.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 164.0, 168.0, 166.0, 165.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 113.0, 77.0, 77.0, 76.0, 78.0, 95.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 83.0, 83.0, 83.0, 102.0, 83.0, 82.0, 110.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 150.0, 148.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 97.0, 99.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 61.0, 57.0, 59.0, 59.0, 59.0, 58.0, 58.0, 62.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 83.0, 86.0, 81.0, 81.0, 85.0, 87.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 129.0, 132.0, 129.0, 128.0, 133.0, 131.0, 172.0, 128.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 170.0, 162.0, 165.0, 166.0, 172.0, 170.0, 166.0, 175.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 63.0, 63.0, 63.0, 68.0, 61.0, 62.0, 62.0], "value": 63.5, "unit": "score"}]}]} 21:57:21 INFO - Return code: 0 21:57:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:57:21 ERROR - # TBPL SUCCESS # 21:57:21 INFO - Running post-action listener: _resource_record_post_action 21:57:21 INFO - [mozharness: 2016-12-30 05:57:21.159726Z] Finished run-tests step (success) 21:57:21 INFO - Running post-run listener: _resource_record_post_run 21:57:21 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 398643200; Read time: 0; Write time: 296064 21:57:21 INFO - TinderboxPrint: CPU usage
13.4% 21:57:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:57:21 INFO - TinderboxPrint: I/O write bytes / time
398,643,200 / 296,064 21:57:21 INFO - TinderboxPrint: CPU idle
8,248.1 (86.6%) 21:57:21 INFO - TinderboxPrint: CPU user
1,217.5 (12.8%) 21:57:21 INFO - TinderboxPrint: Swap in / out
0 / 0 21:57:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105512960; Read time: 0; Write time: 81572 21:57:21 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293130240; Read time: 0; Write time: 214492 21:57:21 INFO - Running post-run listener: _upload_blobber_files 21:57:21 INFO - Blob upload gear active. 21:57:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:57:21 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 21:57:21 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'] 21:57:21 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 21:57:22 INFO - (blobuploader) - INFO - Open directory for files ... 21:57:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:57:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:57:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:57:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:57:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:57:22 INFO - (blobuploader) - INFO - Done attempting. 21:57:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:57:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:57:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:57:23 INFO - (blobuploader) - INFO - Done attempting. 21:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:57:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:57:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:57:26 INFO - (blobuploader) - INFO - Done attempting. 21:57:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:57:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:57:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:57:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:57:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:57:27 INFO - (blobuploader) - INFO - Done attempting. 21:57:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:57:27 INFO - Return code: 0 21:57:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:57:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:57:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc9f55ded10ecc6704d021e52fbaf6ca5cd17aac013ac3b8c88454c51363b148ed4964ea685dd28a2e41e1631d01734c29a86fb90204ea9f3fb04bf56432b15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd4181c52e1fd9ce8db72c71b4aee872102849fbcf8dbaca374cc86c41a1d85d9812343e53f29f8f44644c6b875f9b88065c5468269546ba7bf5c56506d58200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6e9480bdf5bd91aaec843bd0cbb655420ca092720447db152c8f6540a654e40c99d00a6bfab5eeb26cc5d9c206d51400ca5e905fa80c6a80e48b50658e3876e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640f8bfceb973d42476b7a907b83292fa59d6267c7af926dc6502629ff00aa63ffed8c1516849db4e2292945e93a2c01c4ccf655139506328d788ac7c7975f7f"} 21:57:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:57:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:57:27 INFO - Contents: 21:57:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc9f55ded10ecc6704d021e52fbaf6ca5cd17aac013ac3b8c88454c51363b148ed4964ea685dd28a2e41e1631d01734c29a86fb90204ea9f3fb04bf56432b15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd4181c52e1fd9ce8db72c71b4aee872102849fbcf8dbaca374cc86c41a1d85d9812343e53f29f8f44644c6b875f9b88065c5468269546ba7bf5c56506d58200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6e9480bdf5bd91aaec843bd0cbb655420ca092720447db152c8f6540a654e40c99d00a6bfab5eeb26cc5d9c206d51400ca5e905fa80c6a80e48b50658e3876e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640f8bfceb973d42476b7a907b83292fa59d6267c7af926dc6502629ff00aa63ffed8c1516849db4e2292945e93a2c01c4ccf655139506328d788ac7c7975f7f"} 21:57:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:57:27 INFO - Copying logs to upload dir... 21:57:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:57:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.285421 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-29 21:57:27.022827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 21:57:27.026056) ========= 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=fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366 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/fc9f55ded10ecc6704d021e52fbaf6ca5cd17aac013ac3b8c88454c51363b148ed4964ea685dd28a2e41e1631d01734c29a86fb90204ea9f3fb04bf56432b15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd4181c52e1fd9ce8db72c71b4aee872102849fbcf8dbaca374cc86c41a1d85d9812343e53f29f8f44644c6b875f9b88065c5468269546ba7bf5c56506d58200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6e9480bdf5bd91aaec843bd0cbb655420ca092720447db152c8f6540a654e40c99d00a6bfab5eeb26cc5d9c206d51400ca5e905fa80c6a80e48b50658e3876e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640f8bfceb973d42476b7a907b83292fa59d6267c7af926dc6502629ff00aa63ffed8c1516849db4e2292945e93a2c01c4ccf655139506328d788ac7c7975f7f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011939 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062604/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/fc9f55ded10ecc6704d021e52fbaf6ca5cd17aac013ac3b8c88454c51363b148ed4964ea685dd28a2e41e1631d01734c29a86fb90204ea9f3fb04bf56432b15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd4181c52e1fd9ce8db72c71b4aee872102849fbcf8dbaca374cc86c41a1d85d9812343e53f29f8f44644c6b875f9b88065c5468269546ba7bf5c56506d58200", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6e9480bdf5bd91aaec843bd0cbb655420ca092720447db152c8f6540a654e40c99d00a6bfab5eeb26cc5d9c206d51400ca5e905fa80c6a80e48b50658e3876e8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640f8bfceb973d42476b7a907b83292fa59d6267c7af926dc6502629ff00aa63ffed8c1516849db4e2292945e93a2c01c4ccf655139506328d788ac7c7975f7f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 21:57:27.052182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:57:27.052557) ========= 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=fa44defc139c4ba8574fe040000001db-1483076210.23253-1968870366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:57:27.238722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 21:57:27.239062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 21:57:27.239471) ========= ========= Total master_lag: 0.26 =========