builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1483077363.36 results: success (0) buildid: 20161229193930 builduid: a48673f8a90c46f3885b54649ec9c8f0 revision: 376b3896239c1545e9570263af1eae9ce228244e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.358442) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.359016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.359325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.375296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.375830) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 21:56:03-- 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% 225M=0s 2016-12-29 21:56:03 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120244 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.509827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.510140) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014244 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.561341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:03.562011) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 376b3896239c1545e9570263af1eae9ce228244e --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 376b3896239c1545e9570263af1eae9ce228244e --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=d6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 21:56:03,835 truncating revision to first 12 chars 2016-12-29 21:56:03,835 Setting DEBUG logging. 2016-12-29 21:56:03,835 attempt 1/10 2016-12-29 21:56:03,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/376b3896239c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 21:56:04,294 unpacking tar archive at: mozilla-inbound-376b3896239c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:04.362233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:04.362568) ========= script_repo_revision: 376b3896239c1545e9570263af1eae9ce228244e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:04.362963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:04.363249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 21:56:04.372091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-29 21:56:04.372648) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:04 INFO - MultiFileLogger online at 20161229 21:56:04 in /builds/slave/test 21:56:04 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:56:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:56:04 INFO - {'append_to_log': False, 21:56:04 INFO - 'base_work_dir': '/builds/slave/test', 21:56:04 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:56:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:56:04 INFO - 'branch': 'Mozilla-Inbound', 21:56:04 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:04 INFO - 'config_files': ('talos/linux_config.py',), 21:56:04 INFO - 'default_actions': ('clobber', 21:56:04 INFO - 'read-buildbot-config', 21:56:04 INFO - 'download-and-extract', 21:56:04 INFO - 'populate-webroot', 21:56:04 INFO - 'create-virtualenv', 21:56:04 INFO - 'install', 21:56:04 INFO - 'run-tests'), 21:56:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:04 INFO - 'download_minidump_stackwalk': True, 21:56:04 INFO - 'download_symbols': 'ondemand', 21:56:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:04 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:04 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:04 INFO - 'installer_path': 'installer.exe', 21:56:04 INFO - 'log_level': 'info', 21:56:04 INFO - 'log_name': 'talos', 21:56:04 INFO - 'log_to_console': True, 21:56:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:04 INFO - 'opt_config_files': (), 21:56:04 INFO - 'pip_index': False, 21:56:04 INFO - 'sps_profile': False, 21:56:04 INFO - 'sps_profile_interval': 0, 21:56:04 INFO - 'suite': 'dromaeojs-e10s', 21:56:04 INFO - 'system_bits': '32', 21:56:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:04 INFO - 'title': 'talos-linux64-ix-034', 21:56:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:04 INFO - 'use_talos_json': True, 21:56:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:56:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:04 INFO - 'work_dir': 'build'} 21:56:04 INFO - [mozharness: 2016-12-30 05:56:04.734975Z] Running clobber step. 21:56:04 INFO - Running pre-action listener: _resource_record_pre_action 21:56:04 INFO - Running main action method: clobber 21:56:04 INFO - rmtree: /builds/slave/test/build 21:56:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:56:05 INFO - Running post-action listener: _resource_record_post_action 21:56:05 INFO - [mozharness: 2016-12-30 05:56:05.203720Z] Finished clobber step (success) 21:56:05 INFO - [mozharness: 2016-12-30 05:56:05.203820Z] Running read-buildbot-config step. 21:56:05 INFO - Running pre-action listener: _resource_record_pre_action 21:56:05 INFO - Running main action method: read_buildbot_config 21:56:05 INFO - Using buildbot properties: 21:56:05 INFO - { 21:56:05 INFO - "project": "", 21:56:05 INFO - "product": "firefox", 21:56:05 INFO - "script_repo_revision": "production", 21:56:05 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:56:05 INFO - "repository": "", 21:56:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:56:05 INFO - "buildid": "20161229193930", 21:56:05 INFO - "stage_platform": "linux64-pgo", 21:56:05 INFO - "basedir": "/builds/slave/test", 21:56:05 INFO - "buildnumber": 1852, 21:56:05 INFO - "platform": "ubuntu64_hw", 21:56:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:56:05 INFO - "slavebuilddir": "test", 21:56:05 INFO - "branch": "mozilla-inbound", 21:56:05 INFO - "revision": "376b3896239c1545e9570263af1eae9ce228244e", 21:56:05 INFO - "slavename": "talos-linux64-ix-034", 21:56:05 INFO - "builduid": "a48673f8a90c46f3885b54649ec9c8f0", 21:56:05 INFO - "repo_path": "integration/mozilla-inbound" 21:56:05 INFO - } 21:56:05 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:56:05 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 21:56:05 INFO - Running post-action listener: _resource_record_post_action 21:56:05 INFO - [mozharness: 2016-12-30 05:56:05.206199Z] Finished read-buildbot-config step (success) 21:56:05 INFO - [mozharness: 2016-12-30 05:56:05.206289Z] Running download-and-extract step. 21:56:05 INFO - Running pre-action listener: _resource_record_pre_action 21:56:05 INFO - Running main action method: download_and_extract 21:56:05 INFO - mkdir: /builds/slave/test/build/tests 21:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:05 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:56:05 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/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:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/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:56:05 INFO - Downloaded 1361 bytes. 21:56:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:56:05 INFO - Using the following test package requirements: 21:56:05 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:56:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'jsshell-linux-x86_64.zip'], 21:56:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:05 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:56:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:56:05 INFO - Expected file size: 21836102 21:56:05 INFO - Obtained file size: 21836102 21:56:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:56:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:56:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:56:09 INFO - Expected file size: 21836102 21:56:09 INFO - Obtained file size: 21836102 21:56:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:56:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:56:14 INFO - Expected file size: 14409776 21:56:14 INFO - Obtained file size: 14409776 21:56: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:56:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:56:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/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:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/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:56:15 INFO - Downloaded 61365277 bytes. 21:56:15 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:56:15 INFO - mkdir: /builds/slave/test/properties 21:56:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:56:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:56:15 INFO - Contents: 21:56:15 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:56:15 INFO - Running post-action listener: _resource_record_post_action 21:56:15 INFO - Running post-action listener: set_extra_try_arguments 21:56:15 INFO - [mozharness: 2016-12-30 05:56:15.683384Z] Finished download-and-extract step (success) 21:56:15 INFO - [mozharness: 2016-12-30 05:56:15.683614Z] Running populate-webroot step. 21:56:15 INFO - Running pre-action listener: _resource_record_pre_action 21:56:15 INFO - Running main action method: populate_webroot 21:56:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:15 INFO - '--tppagecycles', 21:56:15 INFO - '7'], 21:56:15 INFO - 'tests': ['tsvgm']}}, 21:56:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:56:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:56:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['damp', 'tps']}, 21:56:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'tests': ['damp', 'tps']}, 21:56:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['dromaeo_dom']}, 21:56:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['basic_compositor_video']}, 21:56:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:56:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['a11yr', 21:56:15 INFO - 'ts_paint', 21:56:15 INFO - 'tpaint', 21:56:15 INFO - 'sessionrestore', 21:56:15 INFO - 'sessionrestore_no_auto_restore', 21:56:15 INFO - 'tabpaint']}, 21:56:15 INFO - 'other-e10s': {'tests': ['a11yr', 21:56:15 INFO - 'ts_paint', 21:56:15 INFO - 'tpaint', 21:56:15 INFO - 'sessionrestore', 21:56:15 INFO - 'sessionrestore_no_auto_restore', 21:56:15 INFO - 'tabpaint']}, 21:56:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:56:15 INFO - 'ts_paint', 21:56:15 INFO - 'tpaint', 21:56:15 INFO - 'sessionrestore', 21:56:15 INFO - 'sessionrestore_no_auto_restore', 21:56:15 INFO - 'tabpaint']}, 21:56:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:56:15 INFO - 'ts_paint', 21:56:15 INFO - 'tpaint', 21:56:15 INFO - 'sessionrestore', 21:56:15 INFO - 'sessionrestore_no_auto_restore', 21:56:15 INFO - 'tabpaint']}, 21:56:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['a11yr', 21:56:15 INFO - 'ts_paint', 21:56:15 INFO - 'tpaint', 21:56:15 INFO - 'sessionrestore', 21:56:15 INFO - 'sessionrestore_no_auto_restore', 21:56:15 INFO - 'tabpaint']}, 21:56:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['a11yr', 21:56:15 INFO - 'ts_paint', 21:56:15 INFO - 'tpaint', 21:56:15 INFO - 'sessionrestore', 21:56:15 INFO - 'sessionrestore_no_auto_restore', 21:56:15 INFO - 'tabpaint']}, 21:56:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['tsvgx', 21:56:15 INFO - 'tsvgr_opacity', 21:56:15 INFO - 'tart', 21:56:15 INFO - 'tscrollx', 21:56:15 INFO - 'cart', 21:56:15 INFO - 'tsvg_static']}, 21:56:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:56:15 INFO - 'tsvgr_opacity', 21:56:15 INFO - 'tart', 21:56:15 INFO - 'tscrollx', 21:56:15 INFO - 'cart', 21:56:15 INFO - 'tsvg_static']}, 21:56:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'talos_options': ['--disable-e10s'], 21:56:15 INFO - 'tests': ['tp5o']}, 21:56:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:56:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'talos_options': ['--disable-e10s', 21:56:15 INFO - '--xperf_path', 21:56:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:15 INFO - 'tests': ['tp5n']}, 21:56:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:56:15 INFO - 'talos_options': ['--xperf_path', 21:56:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:15 INFO - 'tests': ['tp5n']}}, 21:56:15 INFO - 'talos.zip': {'path': '', 21:56:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:15 INFO - Running post-action listener: _resource_record_post_action 21:56:15 INFO - [mozharness: 2016-12-30 05:56:15.698675Z] Finished populate-webroot step (success) 21:56:15 INFO - [mozharness: 2016-12-30 05:56:15.698765Z] Running create-virtualenv step. 21:56:15 INFO - Running pre-action listener: _resource_record_pre_action 21:56:15 INFO - Running main action method: create_virtualenv 21:56:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:56:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:56:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:56:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:15 INFO - Using real prefix '/usr' 21:56:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:56:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:18 INFO - Installing pip.................done. 21:56:18 INFO - Return code: 0 21:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:56:18 INFO - Reading from file tmpfile_stdout 21:56:18 INFO - Output received: 21:56:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:56:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56: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:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:56:18 INFO - Using env: {'DISPLAY': ':0', 21:56:18 INFO - 'HOME': '/home/cltbld', 21:56:18 INFO - 'LANG': 'en_US.UTF-8', 21:56:18 INFO - 'LANGUAGE': 'en_US:en', 21:56:18 INFO - 'LOGNAME': 'cltbld', 21:56:18 INFO - 'MAIL': '/var/mail/cltbld', 21:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:18 INFO - 'MOZ_NO_REMOTE': '1', 21:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:18 INFO - 'NO_EM_RESTART': '1', 21:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:18 INFO - 'PWD': '/builds/slave/test', 21:56:18 INFO - 'SHELL': '/bin/bash', 21:56:18 INFO - 'SHLVL': '1', 21:56:18 INFO - 'TERM': 'linux', 21:56:18 INFO - 'TMOUT': '86400', 21:56:18 INFO - 'USER': 'cltbld', 21:56:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:18 INFO - '_': '/tools/buildbot/bin/python'} 21:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:18 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:56:18 INFO - Cleaning up... 21:56:18 INFO - Return code: 0 21:56:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:56: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:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:56:18 INFO - Using env: {'DISPLAY': ':0', 21:56:18 INFO - 'HOME': '/home/cltbld', 21:56:18 INFO - 'LANG': 'en_US.UTF-8', 21:56:18 INFO - 'LANGUAGE': 'en_US:en', 21:56:18 INFO - 'LOGNAME': 'cltbld', 21:56:18 INFO - 'MAIL': '/var/mail/cltbld', 21:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:18 INFO - 'MOZ_NO_REMOTE': '1', 21:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:18 INFO - 'NO_EM_RESTART': '1', 21:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:18 INFO - 'PWD': '/builds/slave/test', 21:56:18 INFO - 'SHELL': '/bin/bash', 21:56:18 INFO - 'SHLVL': '1', 21:56:18 INFO - 'TERM': 'linux', 21:56:18 INFO - 'TMOUT': '86400', 21:56:18 INFO - 'USER': 'cltbld', 21:56:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:18 INFO - '_': '/tools/buildbot/bin/python'} 21:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:18 INFO - Downloading/unpacking psutil>=3.1.1 21:56:18 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:56:18 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:56:18 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:56:18 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:56:18 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:56:18 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:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:21 INFO - Installing collected packages: psutil 21:56:21 INFO - Running setup.py install for psutil 21:56:21 INFO - building 'psutil._psutil_linux' extension 21:56:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:56:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:56:21 INFO - building 'psutil._psutil_posix' extension 21:56:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:56:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:56:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:21 INFO - Successfully installed psutil 21:56:21 INFO - Cleaning up... 21:56:21 INFO - Return code: 0 21:56:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:56: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:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:56:21 INFO - Using env: {'DISPLAY': ':0', 21:56:21 INFO - 'HOME': '/home/cltbld', 21:56:21 INFO - 'LANG': 'en_US.UTF-8', 21:56:21 INFO - 'LANGUAGE': 'en_US:en', 21:56:21 INFO - 'LOGNAME': 'cltbld', 21:56:21 INFO - 'MAIL': '/var/mail/cltbld', 21:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:21 INFO - 'MOZ_NO_REMOTE': '1', 21:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:21 INFO - 'NO_EM_RESTART': '1', 21:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:21 INFO - 'PWD': '/builds/slave/test', 21:56:21 INFO - 'SHELL': '/bin/bash', 21:56:21 INFO - 'SHLVL': '1', 21:56:21 INFO - 'TERM': 'linux', 21:56:21 INFO - 'TMOUT': '86400', 21:56:21 INFO - 'USER': 'cltbld', 21:56:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:21 INFO - '_': '/tools/buildbot/bin/python'} 21:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:56:21 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:56:21 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:56:21 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:56:21 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:56:21 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:56:21 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:56:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:56:23 INFO - Installing collected packages: mozsystemmonitor 21:56:23 INFO - Running setup.py install for mozsystemmonitor 21:56:23 INFO - Successfully installed mozsystemmonitor 21:56:23 INFO - Cleaning up... 21:56:24 INFO - Return code: 0 21:56:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:56:24 INFO - Using env: {'DISPLAY': ':0', 21:56:24 INFO - 'HOME': '/home/cltbld', 21:56:24 INFO - 'LANG': 'en_US.UTF-8', 21:56:24 INFO - 'LANGUAGE': 'en_US:en', 21:56:24 INFO - 'LOGNAME': 'cltbld', 21:56:24 INFO - 'MAIL': '/var/mail/cltbld', 21:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:24 INFO - 'MOZ_NO_REMOTE': '1', 21:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:24 INFO - 'NO_EM_RESTART': '1', 21:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:24 INFO - 'PWD': '/builds/slave/test', 21:56:24 INFO - 'SHELL': '/bin/bash', 21:56:24 INFO - 'SHLVL': '1', 21:56:24 INFO - 'TERM': 'linux', 21:56:24 INFO - 'TMOUT': '86400', 21:56:24 INFO - 'USER': 'cltbld', 21:56:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:24 INFO - '_': '/tools/buildbot/bin/python'} 21:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:24 INFO - Downloading/unpacking jsonschema==2.5.1 21:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:26 INFO - warning: no files found matching '*.txt' 21:56:26 INFO - no previously-included directories found matching 'build' 21:56:26 INFO - no previously-included directories found matching 'dist' 21:56:26 INFO - no previously-included directories found matching '.git*' 21:56:26 INFO - Installing collected packages: jsonschema, functools32 21:56:26 INFO - Running setup.py install for functools32 21:56:26 INFO - warning: no files found matching '*.txt' 21:56:26 INFO - no previously-included directories found matching 'build' 21:56:26 INFO - no previously-included directories found matching 'dist' 21:56:26 INFO - no previously-included directories found matching '.git*' 21:56:26 INFO - Successfully installed jsonschema functools32 21:56:26 INFO - Cleaning up... 21:56:26 INFO - Return code: 0 21:56:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:56: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:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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', '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 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:56: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 functools32==3.2.3-2 21:56:26 INFO - Using env: {'DISPLAY': ':0', 21:56:26 INFO - 'HOME': '/home/cltbld', 21:56:26 INFO - 'LANG': 'en_US.UTF-8', 21:56:26 INFO - 'LANGUAGE': 'en_US:en', 21:56:26 INFO - 'LOGNAME': 'cltbld', 21:56:26 INFO - 'MAIL': '/var/mail/cltbld', 21:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:26 INFO - 'MOZ_NO_REMOTE': '1', 21:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:26 INFO - 'NO_EM_RESTART': '1', 21:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:26 INFO - 'PWD': '/builds/slave/test', 21:56:26 INFO - 'SHELL': '/bin/bash', 21:56:26 INFO - 'SHLVL': '1', 21:56:26 INFO - 'TERM': 'linux', 21:56:26 INFO - 'TMOUT': '86400', 21:56:26 INFO - 'USER': 'cltbld', 21:56:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:26 INFO - '_': '/tools/buildbot/bin/python'} 21:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:56:26 INFO - Cleaning up... 21:56:26 INFO - Return code: 0 21:56:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:56: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:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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', '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 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:56: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 blobuploader==1.2.4 21:56:26 INFO - Using env: {'DISPLAY': ':0', 21:56:26 INFO - 'HOME': '/home/cltbld', 21:56:26 INFO - 'LANG': 'en_US.UTF-8', 21:56:26 INFO - 'LANGUAGE': 'en_US:en', 21:56:26 INFO - 'LOGNAME': 'cltbld', 21:56:26 INFO - 'MAIL': '/var/mail/cltbld', 21:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:26 INFO - 'MOZ_NO_REMOTE': '1', 21:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:26 INFO - 'NO_EM_RESTART': '1', 21:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:26 INFO - 'PWD': '/builds/slave/test', 21:56:26 INFO - 'SHELL': '/bin/bash', 21:56:26 INFO - 'SHLVL': '1', 21:56:26 INFO - 'TERM': 'linux', 21:56:26 INFO - 'TMOUT': '86400', 21:56:26 INFO - 'USER': 'cltbld', 21:56:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:26 INFO - '_': '/tools/buildbot/bin/python'} 21:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:56:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:29 INFO - Downloading docopt-0.6.1.tar.gz 21:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:30 INFO - Running setup.py install for blobuploader 21:56:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:56:30 INFO - Running setup.py install for requests 21:56:30 INFO - Running setup.py install for docopt 21:56:30 INFO - Successfully installed blobuploader requests docopt 21:56:30 INFO - Cleaning up... 21:56:30 INFO - Return code: 0 21:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:30 INFO - Using env: {'DISPLAY': ':0', 21:56:30 INFO - 'HOME': '/home/cltbld', 21:56:30 INFO - 'LANG': 'en_US.UTF-8', 21:56:30 INFO - 'LANGUAGE': 'en_US:en', 21:56:30 INFO - 'LOGNAME': 'cltbld', 21:56:30 INFO - 'MAIL': '/var/mail/cltbld', 21:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:30 INFO - 'MOZ_NO_REMOTE': '1', 21:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:30 INFO - 'NO_EM_RESTART': '1', 21:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:30 INFO - 'PWD': '/builds/slave/test', 21:56:30 INFO - 'SHELL': '/bin/bash', 21:56:30 INFO - 'SHLVL': '1', 21:56:30 INFO - 'TERM': 'linux', 21:56:30 INFO - 'TMOUT': '86400', 21:56:30 INFO - 'USER': 'cltbld', 21:56:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:30 INFO - '_': '/tools/buildbot/bin/python'} 21:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:30 INFO - Running setup.py (path:/tmp/pip-zSBgb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:30 INFO - Running setup.py (path:/tmp/pip-herSSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:30 INFO - Running setup.py (path:/tmp/pip-9P8wmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:31 INFO - Running setup.py (path:/tmp/pip-Z55wSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:31 INFO - Running setup.py (path:/tmp/pip-YuWF7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:31 INFO - Running setup.py (path:/tmp/pip-mvAywS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:31 INFO - Running setup.py (path:/tmp/pip-6snIOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:31 INFO - Running setup.py (path:/tmp/pip-VSXWkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:31 INFO - Running setup.py (path:/tmp/pip-0O3hlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:31 INFO - Running setup.py (path:/tmp/pip-5I29AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:31 INFO - Running setup.py (path:/tmp/pip-JtI79o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:31 INFO - Running setup.py (path:/tmp/pip-BgzUK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:31 INFO - Running setup.py (path:/tmp/pip-F2Kl64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:31 INFO - Running setup.py (path:/tmp/pip-l5r803-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:31 INFO - Running setup.py (path:/tmp/pip-vu_kXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:31 INFO - Running setup.py (path:/tmp/pip-FXVqtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:31 INFO - Running setup.py (path:/tmp/pip-tI1gt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:32 INFO - Running setup.py install for manifestparser 21:56:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Running setup.py install for mozcrash 21:56:32 INFO - Running setup.py install for mozdebug 21:56:32 INFO - Running setup.py install for mozdevice 21:56:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Running setup.py install for mozfile 21:56:32 INFO - Running setup.py install for mozhttpd 21:56:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Running setup.py install for mozinfo 21:56:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Running setup.py install for mozInstall 21:56:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:32 INFO - Running setup.py install for mozleak 21:56:32 INFO - Running setup.py install for mozlog 21:56:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Running setup.py install for moznetwork 21:56:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Running setup.py install for mozprocess 21:56:33 INFO - Running setup.py install for mozprofile 21:56:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Running setup.py install for mozrunner 21:56:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Running setup.py install for mozscreenshot 21:56:33 INFO - Running setup.py install for moztest 21:56:33 INFO - Running setup.py install for mozversion 21:56:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:33 INFO - Cleaning up... 21:56:33 INFO - Return code: 0 21:56:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:33 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 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:33 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:56:33 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:56:33 INFO - Using env: {'DISPLAY': ':0', 21:56:33 INFO - 'HOME': '/home/cltbld', 21:56:33 INFO - 'LANG': 'en_US.UTF-8', 21:56:33 INFO - 'LANGUAGE': 'en_US:en', 21:56:33 INFO - 'LOGNAME': 'cltbld', 21:56:33 INFO - 'MAIL': '/var/mail/cltbld', 21:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:33 INFO - 'MOZ_NO_REMOTE': '1', 21:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:33 INFO - 'NO_EM_RESTART': '1', 21:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:33 INFO - 'PWD': '/builds/slave/test', 21:56:33 INFO - 'SHELL': '/bin/bash', 21:56:33 INFO - 'SHLVL': '1', 21:56:33 INFO - 'TERM': 'linux', 21:56:33 INFO - 'TMOUT': '86400', 21:56:33 INFO - 'USER': 'cltbld', 21:56:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:33 INFO - '_': '/tools/buildbot/bin/python'} 21:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:34 INFO - Running setup.py (path:/tmp/pip-BYnacg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:34 INFO - Running setup.py (path:/tmp/pip-UV3Eyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:34 INFO - Running setup.py (path:/tmp/pip-HOMagr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:34 INFO - Running setup.py (path:/tmp/pip-Vitn4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:34 INFO - Running setup.py (path:/tmp/pip-ZZ0Jhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:34 INFO - Running setup.py (path:/tmp/pip-44esTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:34 INFO - Running setup.py (path:/tmp/pip-3DQTo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:34 INFO - Running setup.py (path:/tmp/pip-LZ2wxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:34 INFO - Running setup.py (path:/tmp/pip-RM0gGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:34 INFO - Running setup.py (path:/tmp/pip-SUfJ3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:34 INFO - Running setup.py (path:/tmp/pip-OrY7R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:34 INFO - Running setup.py (path:/tmp/pip-GsBfkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:34 INFO - Running setup.py (path:/tmp/pip-PEKqsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:35 INFO - Running setup.py (path:/tmp/pip-83oPxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:35 INFO - Running setup.py (path:/tmp/pip-O5_TeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:35 INFO - Running setup.py (path:/tmp/pip-iLjQgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:35 INFO - Running setup.py (path:/tmp/pip-hSxTcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:37 INFO - Downloading blessings-1.6.tar.gz 21:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:37 INFO - Installing collected packages: blessings 21:56:37 INFO - Running setup.py install for blessings 21:56:37 INFO - Successfully installed blessings 21:56:37 INFO - Cleaning up... 21:56:37 INFO - Return code: 0 21:56:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:37 INFO - Reading from file tmpfile_stdout 21:56:37 INFO - Current package versions: 21:56:37 INFO - argparse == 1.2.1 21:56:37 INFO - blessings == 1.6 21:56:37 INFO - blobuploader == 1.2.4 21:56:37 INFO - docopt == 0.6.1 21:56:37 INFO - functools32 == 3.2.3-2 21:56:37 INFO - jsonschema == 2.5.1 21:56:37 INFO - manifestparser == 1.1 21:56:37 INFO - mozInstall == 1.12 21:56:37 INFO - mozcrash == 1.0 21:56:37 INFO - mozdebug == 0.1 21:56:37 INFO - mozdevice == 0.49 21:56:37 INFO - mozfile == 1.2 21:56:37 INFO - mozhttpd == 0.7 21:56:37 INFO - mozinfo == 0.9 21:56:37 INFO - mozleak == 0.1 21:56:37 INFO - mozlog == 3.4 21:56:37 INFO - moznetwork == 0.27 21:56:37 INFO - mozprocess == 0.23 21:56:37 INFO - mozprofile == 0.28 21:56:37 INFO - mozrunner == 6.13 21:56:37 INFO - mozscreenshot == 0.1 21:56:37 INFO - mozsystemmonitor == 0.3 21:56:37 INFO - moztest == 0.7 21:56:37 INFO - mozversion == 1.4 21:56:37 INFO - psutil == 3.1.1 21:56:37 INFO - requests == 1.2.3 21:56:37 INFO - wsgiref == 0.1.2 21:56:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:37 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 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:37 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:56:37 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:56:37 INFO - Using env: {'DISPLAY': ':0', 21:56:37 INFO - 'HOME': '/home/cltbld', 21:56:37 INFO - 'LANG': 'en_US.UTF-8', 21:56:37 INFO - 'LANGUAGE': 'en_US:en', 21:56:37 INFO - 'LOGNAME': 'cltbld', 21:56:37 INFO - 'MAIL': '/var/mail/cltbld', 21:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:37 INFO - 'MOZ_NO_REMOTE': '1', 21:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:37 INFO - 'NO_EM_RESTART': '1', 21:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:37 INFO - 'PWD': '/builds/slave/test', 21:56:37 INFO - 'SHELL': '/bin/bash', 21:56:37 INFO - 'SHLVL': '1', 21:56:37 INFO - 'TERM': 'linux', 21:56:37 INFO - 'TMOUT': '86400', 21:56:37 INFO - 'USER': 'cltbld', 21:56:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:37 INFO - '_': '/tools/buildbot/bin/python'} 21:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:56:38 INFO - Cleaning up... 21:56:38 INFO - Return code: 0 21:56:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', '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:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:38 INFO - Using env: {'DISPLAY': ':0', 21:56:38 INFO - 'HOME': '/home/cltbld', 21:56:38 INFO - 'LANG': 'en_US.UTF-8', 21:56:38 INFO - 'LANGUAGE': 'en_US:en', 21:56:38 INFO - 'LOGNAME': 'cltbld', 21:56:38 INFO - 'MAIL': '/var/mail/cltbld', 21:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:38 INFO - 'MOZ_NO_REMOTE': '1', 21:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:38 INFO - 'NO_EM_RESTART': '1', 21:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:38 INFO - 'PWD': '/builds/slave/test', 21:56:38 INFO - 'SHELL': '/bin/bash', 21:56:38 INFO - 'SHLVL': '1', 21:56:38 INFO - 'TERM': 'linux', 21:56:38 INFO - 'TMOUT': '86400', 21:56:38 INFO - 'USER': 'cltbld', 21:56:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:38 INFO - '_': '/tools/buildbot/bin/python'} 21:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:56:38 INFO - Cleaning up... 21:56:38 INFO - Return code: 0 21:56:38 INFO - Running post-action listener: _resource_record_post_action 21:56:38 INFO - Running post-action listener: _start_resource_monitoring 21:56:38 INFO - Starting resource monitoring. 21:56:38 INFO - [mozharness: 2016-12-30 05:56:38.326323Z] Finished create-virtualenv step (success) 21:56:38 INFO - [mozharness: 2016-12-30 05:56:38.326837Z] Running install step. 21:56:38 INFO - Running pre-action listener: _resource_record_pre_action 21:56:38 INFO - Running main action method: install 21:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:38 INFO - Reading from file tmpfile_stdout 21:56:38 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:38 INFO - Reading from file tmpfile_stdout 21:56:38 INFO - Output received: 21:56:38 INFO - Usage: mozinstall [options] installer 21:56:38 INFO - Options: 21:56:38 INFO - -h, --help show this help message and exit 21:56:38 INFO - -d DEST, --destination=DEST 21:56:38 INFO - Directory to install application into. [default: 21:56:38 INFO - "/builds/slave/test"] 21:56:38 INFO - --app=APP Application being installed. [default: firefox] 21:56:38 INFO - mkdir: /builds/slave/test/build/application 21:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:56:55 INFO - Reading from file tmpfile_stdout 21:56:55 INFO - Output received: 21:56:55 INFO - /builds/slave/test/build/application/firefox/firefox 21:56:55 INFO - Running post-action listener: _resource_record_post_action 21:56:55 INFO - [mozharness: 2016-12-30 05:56:55.957994Z] Finished install step (success) 21:56:55 INFO - [mozharness: 2016-12-30 05:56:55.958265Z] Running run-tests step. 21:56:55 INFO - Running pre-action listener: _resource_record_pre_action 21:56:55 INFO - Running main action method: run_tests 21:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:55 INFO - Python 2.7.3 21:56:55 INFO - Return code: 0 21:56:55 INFO - grabbing minidump binary from tooltool 21:56:55 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:56:55 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 0x1a46820>, '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 0x1a47520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a479b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:55 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:56:55 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:56:55 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:56:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:56 INFO - Return code: 0 21:56:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:56:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:56:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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:56:56 INFO - Using env: {'DISPLAY': ':0', 21:56:56 INFO - 'HOME': '/home/cltbld', 21:56:56 INFO - 'LANG': 'en_US.UTF-8', 21:56:56 INFO - 'LANGUAGE': 'en_US:en', 21:56:56 INFO - 'LOGNAME': 'cltbld', 21:56:56 INFO - 'MAIL': '/var/mail/cltbld', 21:56:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:56 INFO - 'MOZ_NO_REMOTE': '1', 21:56:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:56 INFO - 'NO_EM_RESTART': '1', 21:56:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:56 INFO - 'PWD': '/builds/slave/test', 21:56:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:56 INFO - 'SHELL': '/bin/bash', 21:56:56 INFO - 'SHLVL': '1', 21:56:56 INFO - 'TERM': 'linux', 21:56:56 INFO - 'TMOUT': '86400', 21:56:56 INFO - 'USER': 'cltbld', 21:56:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366', 21:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:56 INFO - '_': '/tools/buildbot/bin/python'} 21:56:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:56:56 INFO - mozversion application_buildid: 20161229175002 21:56:56 INFO - mozversion application_changeset: 376b3896239c1545e9570263af1eae9ce228244e 21:56:56 INFO - mozversion application_display_name: Nightly 21:56:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:56 INFO - mozversion application_name: Firefox 21:56:56 INFO - mozversion application_remotingname: firefox 21:56:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:56:56 INFO - mozversion application_vendor: Mozilla 21:56:56 INFO - mozversion application_version: 53.0a1 21:56:56 INFO - mozversion platform_buildid: 20161229175002 21:56:56 INFO - mozversion platform_changeset: 376b3896239c1545e9570263af1eae9ce228244e 21:56:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:56:56 INFO - mozversion platform_version: 53.0a1 21:56:56 INFO - using testdate: 1483077416 21:56:56 INFO - actual date: 1483077416 21:56:56 INFO - starting webserver on 'localhost:50631' 21:56:56 INFO - SUITE-START | Running 2 tests 21:56:56 INFO - TEST-START | dromaeo_css 21:56:56 INFO - operating with platform_type : linux_ 21:56:56 INFO - Initialising browser for dromaeo_css test... 21:56:56 INFO - TEST-INFO | started process 27460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYDSqv/profile http://localhost:50631/getInfo.html) 21:56:56 INFO - PROCESS | 27460 | 1483077416684 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:57:00 INFO - PROCESS | 27460 | __metrics Screen width/height:1600/1200 21:57:00 INFO - PROCESS | 27460 | colorDepth:24 21:57:00 INFO - PROCESS | 27460 | Browser inner width/height: 1024/697 21:57:00 INFO - PROCESS | 27460 | __metrics 21:57:00 ERROR - PROCESS | 27460 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 21:57:01 INFO - TEST-INFO | 27460: exit 0 21:57:01 INFO - Browser initialized. 21:57:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:01 INFO - TEST-INFO | started process 27581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYDSqv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:13 INFO - PROCESS | 27581 | RSS: Main: 154787840 21:57:13 INFO - PROCESS | 27581 | 22:00:14 INFO - PROCESS | 27581 | Cycle 1(1): loaded http://localhost:50631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50631/tests/dromaeo/cssquery-ext.html) 22:00:15 INFO - PROCESS | 27581 | RSS: Main: 165105664 22:00:15 INFO - PROCESS | 27581 | 22:02:02 INFO - PROCESS | 27581 | ************************* 22:02:02 INFO - PROCESS | 27581 | A coding exception was thrown and uncaught in a Task. 22:02:02 INFO - PROCESS | 27581 | 22:02:02 INFO - PROCESS | 27581 | Full message: ReferenceError: fetch is not defined 22:02:02 INFO - PROCESS | 27581 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 22:02:02 INFO - PROCESS | 27581 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 22:02:02 INFO - PROCESS | 27581 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 22:02:02 INFO - PROCESS | 27581 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 22:02:02 INFO - PROCESS | 27581 | TaskImpl@resource://gre/modules/Task.jsm:277:3 22:02:02 INFO - PROCESS | 27581 | asyncFunction@resource://gre/modules/Task.jsm:252:14 22:02:02 INFO - PROCESS | 27581 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 22:02:02 INFO - PROCESS | 27581 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 22:02:02 INFO - PROCESS | 27581 | TaskImpl@resource://gre/modules/Task.jsm:277:3 22:02:02 INFO - PROCESS | 27581 | asyncFunction@resource://gre/modules/Task.jsm:252:14 22:02:02 INFO - PROCESS | 27581 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 22:02:02 INFO - PROCESS | 27581 | 22:02:02 INFO - PROCESS | 27581 | ************************* 22:03:17 INFO - PROCESS | 27581 | Cycle 1(1): loaded http://localhost:50631/tests/dromaeo/cssquery-ext.html (next: http://localhost:50631/tests/dromaeo/cssquery-jquery.html) 22:03:18 INFO - PROCESS | 27581 | RSS: Main: 160722944 22:03:18 INFO - PROCESS | 27581 | 22:06:20 INFO - PROCESS | 27581 | Cycle 1(1): loaded http://localhost:50631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50631/tests/dromaeo/cssquery-mootools.html) 22:06:20 INFO - PROCESS | 27581 | RSS: Main: 165871616 22:06:20 INFO - PROCESS | 27581 | 22:09:22 INFO - PROCESS | 27581 | Cycle 1(1): loaded http://localhost:50631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50631/tests/dromaeo/cssquery-prototype.html) 22:09:23 INFO - PROCESS | 27581 | RSS: Main: 160497664 22:09:23 INFO - PROCESS | 27581 | 22:12:26 INFO - PROCESS | 27581 | Cycle 1(1): loaded http://localhost:50631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50631/tests/dromaeo/cssquery-yui.html) 22:12:26 INFO - PROCESS | 27581 | RSS: Main: 164847616 22:12:26 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | Cycle 1(1): loaded http://localhost:50631/tests/dromaeo/cssquery-yui.html (next: http://localhost:50631/tests/dromaeo/cssquery-dojo.html) 22:15:29 INFO - PROCESS | 27581 | RSS: Main: 164388864 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | __start_tp_report 22:15:29 INFO - PROCESS | 27581 | _x_x_mozilla_page_load 22:15:29 INFO - PROCESS | 27581 | _x_x_mozilla_page_load_details 22:15:29 INFO - PROCESS | 27581 | |i|pagename|runs| 22:15:29 INFO - PROCESS | 27581 | |0;dojo.html;3172.5875636167293;3184.2357834119803;3198.3123628419885;3222.806631602104;3224.3873664003854;5299.761510732017;5361.1154159563675;5375.354957405112;5399.460053994599;5428.185772134182;5292.153255479124;5334.91997620036;5390.757415916283;5393.541548968333;5479.753411096501;4846.34574332465;4891.4130304363525;4910.508949105097;5006.123928312549;5006.123928312549;4821.807127714905;4929.4824043475455;4955.653104282702;4956.033573453178;4981.053599816041;4789.616830653539;4902.3872015998;4928.310036594879;4980.87547811304;5036.320096786923;4809.0862736080035;4812.807487700487;4880.365552478191;4941.579965702919;4988.077205716918;4885.998370334073;4887.491892431266;4902.117618828609;4906.632002599819;4938.333325001151;5342.652727572696;5380.2736630555155;5410.864728381783;5427.402985671573;5431.538319242869;5643.8589035274035;5677.57418193633;5699.2306038684665;5736.196932429463;5739.426057394269;5775.075987841967;5798.449147330997;5805.4194580542035;5809.477147056743;5876.177335173079;5364.249005139283;5385.919211211835;5387.1380579107545;5401.810936617199;5426;5757.481826635539;5800.53595712342;5844.649321040752;5878.911816322759;5903.970480147572;5682.318121825408;5711.485966262973;5714.514266287412;5747.655140691572;5764.164196191613;5750.424957504216;5779.133130030445;5813.244278243801;5834.620749651259;5840.88318233633;5599.496045355938;5649.4633009864;5668.404817494104;5675.574331925122;5707.029804933171;5730.570207234474;5742.08126699726;5748.367679555246;5752.7698892043845;5790.623609465371;4300.075483771005;4306.117245964632;4309;4340.283853164193;4348.326009468537;3821.8662346818282;3846.576876543578;3852.4799152114106;3887.941680874789;3891.727579069438;5519.69641669704;5539.2522009529;5561.138023606348;5583.302087239095;5621.409751976065;5768.653880767168;5773.076307790733;5777.393373695785;5796.1595568642315;5813.505852002542;5330.786768529293;5377.838664840061;5490.670559766427;5530.529904958124;5557.5831812614215;4816.8554943351755;4850.684705494132;4859.465458799529;4880;4881.316615673809;6102.908456373158;6117.418845209698;6133.202683651097;6162.876742465215;6167.475764559973;5648.661080335193;5710.114932185518;5845.41545845429;5856;5857.384974577608;6052.636841789506;6114.6636934969;6126.6017708848785;6162.630242185304;6174.166487524127;5749.396313387034;5803.216565763568;5803.680797556175;5816.127580862904;5844.327902291291;5674.801381951612;5881.411858814085;5909.084091965752;5921.7631294747725;5924.437178468039;5538.224648549126;5547.694876781816;5555.72221388937;5589.413111623384;5656.971715141398;5585.994520986262;5610.18652295423;5610.495055444866;5613.494785469327;5616.4383561645145;5518.227448157341;5567.944320556905;5578.470045345685;5611.214429979725;5633.8591535211945;5603.991281569357;5672.60291779588;5693.946619875336;5698.54411647059;5766.538676905921;5501.834944951658;5543.805966791143;5547.389787123494;5549.223108764857;5564.221009058654 22:15:29 INFO - PROCESS | 27581 | |1;ext.html;551.7103520651658;566.6713306282356;573.7303467370334;576.4206971993146;576.9048107062335;38112.618873811254;39291;39550.8022459888;43633;43763;41620.375694364535;42120.57879421205;42214.7889260554;42253;42368.09343579539;8633.956830215855;8795.340349473783;8803.911960880405;8814.427062240933;10011.299209055369;9922.851157232648;10240.539175737109;10240.948795256014;10242.28304018719;10278.486075696223;10285.382877027365;10308.433036183007;10335.896641033569;10340.586376544967;10344.896551034506;10261.897381026169;10310.07209351162;10314;10331.690049298533;10346.896531034668;10070.9496452518;10186.134178594828;10192.541335639915;10205.2346074044;10208.693739187836;37149.442758358644;37152.44271335932;37176.628233717856;37192.628073719185;37336.626633733584;3899.902502437462;3963.7819919904396;3970.166265084336;3983.2830090583684;4053.837846486137;28360.290992725142;28606.427871442662;28623.57064644032;28721;28901.27746806347;4138.710290279651;4275.893102672458;4305.590968857953;4321.82712691492;4346.1090476452255;316527.417362914;316716;317961;318406;318502;49635.503644963086;49812.75093624509;49956.25065624018;50166.49833501691;50170.24744628833;52315.73842130765;52570.211446828325;52687.473125269025;52780.499510087786;52798.472015280124;14306.928465357814;14691.853081469262;14706.205820893996;14715.19066451334;14822.258887055605;10912.563497460013;11084.445777711082;11138.10895128404;11211.943940280247;11466.94266528662;16334.794802701483;16448.588785280463;16462;16483.58791030234;16485.423010194827;6642.833929151713;6657.800265992028;6758.290379510179;6758.425533829582;6798.320167983162;890.5947793753827;893.1604291965532;900.7793090692691;921.755734730297;940.7930255343813;25938.22185334443;25946.610800838003;26320.73679263183;26512.33719156998;26513.33716657099;1063.3194755356578;1067.556963860005;1067.7223921780237;1068.8343306787306;1071.8392241163888;14081.647958800908;14675.559733208021;14727.631809204855;14893.851061489464;15145.772813407808;487009;488348;489558;490604;491789;50158.247626285636;50245;50346;50602.74698626557;50774.74612626913;1384.2317513779747;1392.791081337787;1400.803887455757;1418.3121186224673;1422.239102080382;26932;27240.727592724612;27359.58960615632;27945.44109117847;28968;41797;42370.15259694851;42517.57482425136;42525.36211956885;42540;441259;444067;444880;446051;449553;24556.631650524898;24864.751352486244;25216;25326.74673253244;26150.476990460465;39770.2045959085;40011;40745.59254407418;41021.17957640771;41260.58739412687;33922.660773392934;34030.82984585061;34124.82937585296;34135;34315.65684343225;33544.66455335415;33563.83218083894;33689.494657579664;33986.83006584951;34167.65832341645;34321.31357372888;34568.48147277743;34634.82682586571;34813.12967175841;34925;24379.26862194137;25410.745892541578;27466;27920.581191282552;28089.57865631976;25304;25430.872845635655;25690.871545642152;26034.360018519405;26144.477110458065 22:15:29 INFO - PROCESS | 27581 | |2;jquery.html;399.1737104194317;404.3005600311463;407.33604225113066;408.60365445517846;426.6458839163495;14687.706245875102;17105.23026463809;17970.101494925235;18787.436376908696;18816.341428050004;16945;17405.82594174058;17489.300427982864;18510.167042483088;18767.249310027615;5147.974260128694;5151.896962060747;5285.075111855429;5324.307839980797;5364.839054828341;5165.63840531163;5289.047971365153;5303.734813259341;5304.681719096847;5306.840794776143;5122.15484445068;5196.246544251081;5267.1045922193125;5267.76295066721;5272.789088436458;5172.146595811687;5176.870578235536;5249.1338929076655;5314.521693047605;5336.519713225809;5069.771860266297;5149.819756308511;5223.268742376071;5375.596830237748;5417;13108.082434229607;13539.45842166322;13830.930845345809;14944;21524.677129843065;2884.13475957212;2896.7537759290485;2897.5074237379695;3018.3963207358397;3042.9087127386215;6269.686515674198;7184.856302873914;10078.848817267746;10440.32137911041;10463.94768026155;1857.619188066443;1914.4161030885575;1929.2958070304378;1934;1935.6709359408935;72151.63924180345;72709.27290727077;73493;75386.24613753847;76020.61989690016;10346.896531034594;10663.306885052447;10735.892641073646;10792.24454288208;10851.837222441669;12110.515579376726;14483.420663173565;14506.419743210365;14534.200618965848;14535.200563969083;7399.6670149843385;7466.514676546116;7725.034370703662;7778.805529861799;7786.8053298666855;7370.299821516947;7422.851542969111;7469.962650186714;7607.657655405409;7671;4099.426080348753;4106.466159399319;4134.669226461876;4159.313713237282;4234.237837189336;1964.196916956738;1976.8715033522774;1983.2364539652337;2029.4926268432891;2071.5339048714222;872.228078150841;887.8313120507083;899.5861903524452;902.4089221559889;926.9212116970133;17251.82748172527;17390.47828565145;17670.204840782197;17901.462956111336;18159.45521634353;878.3456325037888;948.3645957208687;950.8288508068614;957.6791774755395;960.4333443268365;9265.675701350421;9398.060193980684;9477.194438472668;9494.905050949541;9593;454087;455312;457144.8568928884;468027;469694;65427.67286163634;76407;81978.18021819825;82036.58981705173;83841.58079209687;1027.9229057820694;1028.3161697471098;1054.0671505717496;1055.0978913029248;1062.7927554127025;15118.244087795787;15167;15250.466233681767;15268.923655382096;15854.207289635702;37387.813060934524;37968.62031379761;38122.809385952896;38173.42739858849;38603.61396386;51431.74284128555;51558.74220628873;51902.74048629884;52111;54687.17969230385;7886.329661978796;8073.959630202046;8289.171082891662;8364.665413383396;8398.202170793766;9153.954230228806;12064.577739779066;12791.104622676323;12831.422585983466;12925.612231633066;11001.889981100087;11040.723981900195;11073.944630276797;11164.553417863195;11230.494627741935;10831.783364332827;10857;10919.617813376493;11083.445827708421;11313.773724525628;10975.451227438436;11065.668029959113;11088.501017454073;11172.608958686407;11189.160812938899;8221.260086592236;8351.791205219919;8400.537970411442;8607.225349718556;8644.394892357475;9920.503974801375;11062.834057488983;11119.221654484109;11205.775884482428;11583.5945741902 22:15:29 INFO - PROCESS | 27581 | |3;mootools.html;1382.5921353200808;1386.9098508596935;1387.6253411578869;1388.8750012498874;1399.6430910117917;7877.054753429589;8017.799555011113;8339.958300208506;8347.91652083479;8429.45208561443;8347.29048030918;8444.95777521113;8502.744917652464;8516.489010659365;8532.274756645693;2313.5141620259724;2347.58917189492;2356.257778799681;2357.5167090746354;2363.0311572255378;2318.5710643531;2324.2910912171783;2375.3705268103968;2393.85636861788;2402.675638788767;2322.628379459287;2344.343583796531;2345.3433038749176;2346.389938615955;2348.4363752699314;2265.660150977358;2273.5225602623386;2275.601769690306;2278.5898538263104;2284.771522847702;2296.0356650206954;2326.6975293211776;2331.0559223514506;2367.1833217540093;2374.382660508263;8322.62548185333;8449.662013519452;8450.112738162466;8459.450135741157;8474.1102184271;5036.546710796009;5209.244659524347;5209.322788037569;5210.947890521084;5212.869678258036;3171.5242713592916;3179.60254968129;3247.382997230519;3309.1065412338535;3349.363620912019;1252.5303011370736;1268.6067319131098;1293.8447386313703;1320.9933950330187;1373.9931300343435;10581.682549523526;10590.311629744043;10663.680089597325;10674.9466252669;10774.676759697222;4266.530681625019;4354.325079612665;4469.195544801967;4490.079533695584;4550.249208880564;8935.419197752126;8946.552672366486;8977.147171018743;8989.280857531381;8990.460572365679;5087.847364579068;5111.284420181178;5165.14775062118;5187.818426355059;5208.947910520922;4759.4764575896625;4787.3537072495465;4793.304970779218;4845.2732090186755;4853.223484242504;3499.545059142346;3534.3461459630053;3587.121155316964;3648.21563363878;3725.5343082114737;1026.2918586175515;1077.1867240233573;1081.3295756630782;1132.3545579019878;1134.9262297950606;754.9773506794805;844.2148801614558;899.2086963472103;912.8585069314267;918.6325469812128;5269.973650131725;5420.403755586883;5790.739416726257;5851.210086638334;5931.525477961753;925.6251218256617;943.4009404028492;953.0218068535826;954.627695198873;955.1737746848926;3749.6250374962833;3752.2120354725266;3831;3870.748401353903;3903.843846246118;9754.219662426989;10074.848877266846;10097.848532272023;10119.13987311072;10137.847932281022;9298.395604285699;9746.171575416169;9784.070513301225;10009.799804003878;10022.849657255147;7647.464677472635;7766.184550622216;7794.727184548514;7800.726974555863;7853.803654908673;5647.322321321468;5801.738921748447;5839.240898683144;5935.169076329404;6081.452669259788;8940.240079593048;9065.954670226607;9107.544622768703;9151.954240228757;9245.491497967676;9464.1009104135;9479.810403792024;9556.092171243721;9645.517724113906;9660.855087173839;7136.643167841483;7197.31625495598;7258.49190556656;7270.600116993616;7278.272172782679;7533.2466753324225;7540.132884718328;7647.770566883002;7698.03774528184;7728.072631284282;6601.108850305147;6767.424768894699;6861.931380686129;6868.961952848598;6905.585664860125;6818.727250910107;6889.793306200822;6970.581765094111;7006.299370062953;7224.8916266255;6063.5452341073715;6100.389961004042;6170.845728856814;6177.413145751147;6181.258249010148;4991.950080499294;5073.315102461268;5082.618803589671;5137.152369858932;5228.921566176587;5029.74851257443;5040.5967522597375;5087.491250874883;5203.063448579292;5286.286351342674 22:15:29 INFO - PROCESS | 27581 | |4;prototype.html;394.9249642567912;403.5540727496117;411.0586756328009;412.17564870259474;415.38315601332016;5161.200013997827;5279.445658205891;5329.706866122362;5350.19747037944;5362.946370536289;5089.491050894909;5185.170372740362;5212.817551385702;5244.292020577221;5267.841964741064;4208.915821683565;4219.451471308726;4236.4916210054835;4239.724417912841;4242.448481697391;4113.444684967536;4235.9364609530885;4252.404663347118;4252.617264446199;4253.574642535753;4167.916641667165;4170.687198460128;4181.895452613694;4185.623293903548;4193;4156.501219853607;4166.375043743433;4179.9727132340795;4180.477440319944;4187.832486700559;3813.3707938190164;3814.313423583754;3826.253880493305;3833.252515759428;3850.8062500624897;5078.517540833652;5120.183898855615;5133.8716532087;5155.607985843839;5204.141316682742;4841.2496063110275;4847.830325938575;4848.878778030577;4859.975700121512;4880.389951256093;5481.909697996635;5597.636153650041;5600.767831077156;5609.382967873531;5613.550915926716;4024.7383920045104;4090.7954602270065;4095.7747323897174;4097.836086556535;4125.711200215986;5787.797427090031;5788.102844059177;5806.954748145332;5855.443732845373;5917.378675239124;4275.5724427557;4276.2089013532595;4309.482862056573;4313.741175529478;4315.5900189481945;4246.745195288293;4296.140771845643;4325.9134817303475;4341.327094300388;4354.608085272341;4776;4812.446568644581;4826.420829500412;4842.201036828954;4843.95156048435;5547.223388725582;5593.636413633101;5665.886682266331;5672.205891175238;5673.780137270506;1419.552840855148;1480.156310902775;1488.977665335021;1491.2841835918603;1517.324790468231;1056.799208150449;1075.7736180753948;1081.7511972246427;1092.3118435385816;1092.6995076353908;5271;5283.735813209324;5284.762185701653;5285.973570132125;5313.405978206522;5521.834344969658;5554.555635549146;5567.937634301118;5586.944130558723;5589.692566908778;5032.672876263031;5217.58259339252;5287.576993840484;5312.476573627496;5312.867178320573;2876.7917474660276;2903.3757742085554;2929.22375570474;2952.1659207160938;2973.0189037617533;5823.845177284347;5826.7763769608855;5854.473097421167;5912.822615321547;5939.011230566259;5544.833654990357;5875.735591898375;5903.660809305157;5940;5950.315713692894;6115.296740874767;6124.38756124384;6139.508839292846;6154.753809847645;6170.444659980444;5585.385607583082;5784.392638773036;5784.4504772046585;5806.941930580809;5816.47651711348;5653.925754106706;5731.713414329351;5763.625364351304;5769.567282453749;5772.393898640582;5801.883962320814;6110.158776169103;6110.175126357884;6128.693565321805;6159.568830182024;4032.354823228269;4123.649489793281;4131.636559935154;4134.545200027935;4188.183304255641;5773.509251713652;5779.4973306939655;5786.218860453785;5835.56233282497;5857;5643.858903527444;5652.85191627179;5657.2928383952;5664.603477756517;5680.460356266148;5392.514673679388;5560.666360018412;5608.85977850557;5651.886962260814;5655.208270842168;5568.6658800472105;5568.693721845338;5600.159976003632;5608.775648974159;5625.971870140623;5489;5570.916436253378;5628.324601047901;5651.265335506358;5671.234383358359;5455.399906010256;5471.139812463782;5472.4976015351;5477.643953143033;5490.231367608458 22:15:29 INFO - PROCESS | 27581 | |5;yui.html;686.4371215603207;688.0848471532859;725.2276325713115;736.282124928195;744.5086243079569;14430.422783088678;14823.703525929475;14863.554093377188;14969.47606833761;14975.251237438126;14899.478518251863;15092.773608395883;15103.39586416542;15126.394944202246;15144;666.1739443090569;684.7603338831419;790.5849429049738;807.5679511461369;810.6838333050085;787.9212078792132;794.9682012719484;796.3549524884862;797.2107613462688;803.3211935914143;849.218718778725;855.8245559660286;856.884320616715;870.8345414371281;872.7163671806657;855.6021450025768;856.1053698884681;857.2756021162139;859.2739135430583;864.8875646166022;619.0343064818852;626.1140486212005;629.4806784402886;632.250782822357;633.0409429713987;15151;15451.690966180726;15475.380984760595;15974.520764377086;16099.356025758956;13224.404901779442;14077;14472.059316144418;14568.198749068797;14622.780658290134;11397.202195846294;11659.475323610373;11663.358515281656;11737.413129343498;11873.94063029688;3641.217138315275;3679.1962584444777;3741.8503259869844;3742.8315725792404;3776.7356285060055;65623.3437665622;66604;67693.3230667692;73436.26563734347;74269.62865185694;10605.042769492507;10659.520321585547;10787.460626968621;10810.783784324269;10820;21457.141714331563;21459.78540214578;21476.24833130864;21679.132834686752;21788.128474861143;7830.491018083806;7993.960030199928;8113.472624279521;8195.180481951757;8363.58182090893;4224.978875105605;4245.681573881971;4323.200207961537;4339.435873336446;4346.065595896835;3357.261402491497;3429.9657003430148;3441.15691655546;3448.3103379324234;3475.0443628001995;587.1867463562996;593.5963544789585;598.2432223237608;616.8550390658191;618.8700372921737;625.5089754542753;625.64338327154;626.0077776723853;626.7837596029362;630.2688880898136;8710.390272680977;9067.319951003701;9089.227415669742;9318.767030824149;9567.569459374345;571.9313682358061;583.4923616453713;585.871108356161;604.0637012630406;666.1007639686385;3994.980025099856;4133.090720041586;4233.872983810491;4247.8088486018205;4308.547602501755;81499.5925020371;81625.59187204026;82974;83332;84265.15734842696;56333.43666563364;58143.70928145417;71861.28138718651;71894.64052679807;72581;57080.42919570751;57385.71307143437;57748.42251577514;58218.267259910506;58395;9212.479940809959;9726.70819875405;10050.547725352522;10212.591496340063;10263.46048092792;38181;39554.406683899186;39751.80124099477;40519.59480405158;40931.795341023106;53427.73286133545;54509.72745136249;54587.727061364436;54593.727031364586;55279.72360138174;12142.939285303517;12715.618531444072;12717.300548469922;12825.358732063172;12928;14295.92852035733;14305.928470357581;14576.708465830836;14606.488772892897;14918.701625967637;13521.323933803467;13664.726705466033;14100.858991409954;14279.143251404948;14753.483628072965;13490.662733431744;13522.220839038964;13831.723365532433;13909.860901390857;13939.651508712363;12364.876351236373;12648.810267845805;12790.87209127934;13194.934025329812;13237.867621323663;9633.951830240803;9768.902310977084;9873.950630246803;10169.135623472088;10500.632477863544;10047.145992590711;10559.366438013743;10585.153187745116;10587.20595955291;10640.308379955279 22:15:29 INFO - PROCESS | 27581 | __end_tp_report 22:15:29 INFO - PROCESS | 27581 | __start_cc_report 22:15:29 INFO - PROCESS | 27581 | _x_x_mozilla_cycle_collect,316 22:15:29 INFO - PROCESS | 27581 | __end_cc_report 22:15:29 INFO - PROCESS | 27581 | __startTimestamp1483078529695__endTimestamp 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | ------- Summary: start ------- 22:15:29 INFO - PROCESS | 27581 | Number of tests: 6 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | [#0] dojo.html Cycles:165 Average:5368.66 Median:5567.94 stddev:624.18 (11.2%) stddev-sans-first:601.85 22:15:29 INFO - PROCESS | 27581 | Values: 3172.6 3184.2 3198.3 3222.8 3224.4 5299.8 5361.1 5375.4 5399.5 5428.2 5292.2 5334.9 5390.8 5393.5 5479.8 4846.3 4891.4 4910.5 5006.1 5006.1 4821.8 4929.5 4955.7 4956.0 4981.1 4789.6 4902.4 4928.3 4980.9 5036.3 4809.1 4812.8 4880.4 4941.6 4988.1 4886.0 4887.5 4902.1 4906.6 4938.3 5342.7 5380.3 5410.9 5427.4 5431.5 5643.9 5677.6 5699.2 5736.2 5739.4 5775.1 5798.4 5805.4 5809.5 5876.2 5364.2 5385.9 5387.1 5401.8 5426.0 5757.5 5800.5 5844.6 5878.9 5904.0 5682.3 5711.5 5714.5 5747.7 5764.2 5750.4 5779.1 5813.2 5834.6 5840.9 5599.5 5649.5 5668.4 5675.6 5707.0 5730.6 5742.1 5748.4 5752.8 5790.6 4300.1 4306.1 4309.0 4340.3 4348.3 3821.9 3846.6 3852.5 3887.9 3891.7 5519.7 5539.3 5561.1 5583.3 5621.4 5768.7 5773.1 5777.4 5796.2 5813.5 5330.8 5377.8 5490.7 5530.5 5557.6 4816.9 4850.7 4859.5 4880.0 4881.3 6102.9 6117.4 6133.2 6162.9 6167.5 5648.7 5710.1 5845.4 5856.0 5857.4 6052.6 6114.7 6126.6 6162.6 6174.2 5749.4 5803.2 5803.7 5816.1 5844.3 5674.8 5881.4 5909.1 5921.8 5924.4 5538.2 5547.7 5555.7 5589.4 5657.0 5586.0 5610.2 5610.5 5613.5 5616.4 5518.2 5567.9 5578.5 5611.2 5633.9 5604.0 5672.6 5693.9 5698.5 5766.5 5501.8 5543.8 5547.4 5549.2 5564.2 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | [#1] ext.html Cycles:180 Average:55471.17 Median:34077.83 stddev:112506.71 (330.1%) stddev-sans-first:112746.76 22:15:29 INFO - PROCESS | 27581 | Values: 551.7 566.7 573.7 576.4 576.9 38112.6 39291.0 39550.8 43633.0 43763.0 41620.4 42120.6 42214.8 42253.0 42368.1 8634.0 8795.3 8803.9 8814.4 10011.3 9922.9 10240.5 10240.9 10242.3 10278.5 10285.4 10308.4 10335.9 10340.6 10344.9 10261.9 10310.1 10314.0 10331.7 10346.9 10070.9 10186.1 10192.5 10205.2 10208.7 37149.4 37152.4 37176.6 37192.6 37336.6 3899.9 3963.8 3970.2 3983.3 4053.8 28360.3 28606.4 28623.6 28721.0 28901.3 4138.7 4275.9 4305.6 4321.8 4346.1 316527.4 316716.0 317961.0 318406.0 318502.0 49635.5 49812.8 49956.3 50166.5 50170.2 52315.7 52570.2 52687.5 52780.5 52798.5 14306.9 14691.9 14706.2 14715.2 14822.3 10912.6 11084.4 11138.1 11211.9 11466.9 16334.8 16448.6 16462.0 16483.6 16485.4 6642.8 6657.8 6758.3 6758.4 6798.3 890.6 893.2 900.8 921.8 940.8 25938.2 25946.6 26320.7 26512.3 26513.3 1063.3 1067.6 1067.7 1068.8 1071.8 14081.6 14675.6 14727.6 14893.9 15145.8 487009.0 488348.0 489558.0 490604.0 491789.0 50158.2 50245.0 50346.0 50602.7 50774.7 1384.2 1392.8 1400.8 1418.3 1422.2 26932.0 27240.7 27359.6 27945.4 28968.0 41797.0 42370.2 42517.6 42525.4 42540.0 441259.0 444067.0 444880.0 446051.0 449553.0 24556.6 24864.8 25216.0 25326.7 26150.5 39770.2 40011.0 40745.6 41021.2 41260.6 33922.7 34030.8 34124.8 34135.0 34315.7 33544.7 33563.8 33689.5 33986.8 34167.7 34321.3 34568.5 34634.8 34813.1 34925.0 24379.3 25410.7 27466.0 27920.6 28089.6 25304.0 25430.9 25690.9 26034.4 26144.5 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | [#2] jquery.html Cycles:180 Average:26620.79 Median:4102.95 stddev:75794.04 (1847.3%) stddev-sans-first:75981.09 22:15:29 INFO - PROCESS | 27581 | Values: 399.2 404.3 407.3 408.6 426.6 14687.7 17105.2 17970.1 18787.4 18816.3 16945.0 17405.8 17489.3 18510.2 18767.2 5148.0 5151.9 5285.1 5324.3 5364.8 5165.6 5289.0 5303.7 5304.7 5306.8 5122.2 5196.2 5267.1 5267.8 5272.8 5172.1 5176.9 5249.1 5314.5 5336.5 5069.8 5149.8 5223.3 5375.6 5417.0 13108.1 13539.5 13830.9 14944.0 21524.7 2884.1 2896.8 2897.5 3018.4 3042.9 6269.7 7184.9 10078.8 10440.3 10463.9 1857.6 1914.4 1929.3 1934.0 1935.7 72151.6 72709.3 73493.0 75386.2 76020.6 10346.9 10663.3 10735.9 10792.2 10851.8 12110.5 14483.4 14506.4 14534.2 14535.2 7399.7 7466.5 7725.0 7778.8 7786.8 7370.3 7422.9 7470.0 7607.7 7671.0 4099.4 4106.5 4134.7 4159.3 4234.2 1964.2 1976.9 1983.2 2029.5 2071.5 872.2 887.8 899.6 902.4 926.9 17251.8 17390.5 17670.2 17901.5 18159.5 878.3 948.4 950.8 957.7 960.4 9265.7 9398.1 9477.2 9494.9 9593.0 454087.0 455312.0 457144.9 468027.0 469694.0 65427.7 76407.0 81978.2 82036.6 83841.6 1027.9 1028.3 1054.1 1055.1 1062.8 15118.2 15167.0 15250.5 15268.9 15854.2 37387.8 37968.6 38122.8 38173.4 38603.6 51431.7 51558.7 51902.7 52111.0 54687.2 7886.3 8074.0 8289.2 8364.7 8398.2 9154.0 12064.6 12791.1 12831.4 12925.6 11001.9 11040.7 11073.9 11164.6 11230.5 10831.8 10857.0 10919.6 11083.4 11313.8 10975.5 11065.7 11088.5 11172.6 11189.2 8221.3 8351.8 8400.5 8607.2 8644.4 9920.5 11062.8 11119.2 11205.8 11583.6 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | [#3] mootools.html Cycles:180 Average:5416.44 Median:5209.28 stddev:2937.15 (56.4%) stddev-sans-first:2929.74 22:15:29 INFO - PROCESS | 27581 | Values: 1382.6 1386.9 1387.6 1388.9 1399.6 7877.1 8017.8 8340.0 8347.9 8429.5 8347.3 8445.0 8502.7 8516.5 8532.3 2313.5 2347.6 2356.3 2357.5 2363.0 2318.6 2324.3 2375.4 2393.9 2402.7 2322.6 2344.3 2345.3 2346.4 2348.4 2265.7 2273.5 2275.6 2278.6 2284.8 2296.0 2326.7 2331.1 2367.2 2374.4 8322.6 8449.7 8450.1 8459.5 8474.1 5036.5 5209.2 5209.3 5210.9 5212.9 3171.5 3179.6 3247.4 3309.1 3349.4 1252.5 1268.6 1293.8 1321.0 1374.0 10581.7 10590.3 10663.7 10674.9 10774.7 4266.5 4354.3 4469.2 4490.1 4550.2 8935.4 8946.6 8977.1 8989.3 8990.5 5087.8 5111.3 5165.1 5187.8 5208.9 4759.5 4787.4 4793.3 4845.3 4853.2 3499.5 3534.3 3587.1 3648.2 3725.5 1026.3 1077.2 1081.3 1132.4 1134.9 755.0 844.2 899.2 912.9 918.6 5270.0 5420.4 5790.7 5851.2 5931.5 925.6 943.4 953.0 954.6 955.2 3749.6 3752.2 3831.0 3870.7 3903.8 9754.2 10074.8 10097.8 10119.1 10137.8 9298.4 9746.2 9784.1 10009.8 10022.8 7647.5 7766.2 7794.7 7800.7 7853.8 5647.3 5801.7 5839.2 5935.2 6081.5 8940.2 9066.0 9107.5 9152.0 9245.5 9464.1 9479.8 9556.1 9645.5 9660.9 7136.6 7197.3 7258.5 7270.6 7278.3 7533.2 7540.1 7647.8 7698.0 7728.1 6601.1 6767.4 6861.9 6869.0 6905.6 6818.7 6889.8 6970.6 7006.3 7224.9 6063.5 6100.4 6170.8 6177.4 6181.3 4992.0 5073.3 5082.6 5137.2 5228.9 5029.7 5040.6 5087.5 5203.1 5286.3 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | [#4] prototype.html Cycles:180 Average:4747.37 Median:5284.25 stddev:1367.15 (25.9%) stddev-sans-first:1331.38 22:15:29 INFO - PROCESS | 27581 | Values: 394.9 403.6 411.1 412.2 415.4 5161.2 5279.4 5329.7 5350.2 5362.9 5089.5 5185.2 5212.8 5244.3 5267.8 4208.9 4219.5 4236.5 4239.7 4242.4 4113.4 4235.9 4252.4 4252.6 4253.6 4167.9 4170.7 4181.9 4185.6 4193.0 4156.5 4166.4 4180.0 4180.5 4187.8 3813.4 3814.3 3826.3 3833.3 3850.8 5078.5 5120.2 5133.9 5155.6 5204.1 4841.2 4847.8 4848.9 4860.0 4880.4 5481.9 5597.6 5600.8 5609.4 5613.6 4024.7 4090.8 4095.8 4097.8 4125.7 5787.8 5788.1 5807.0 5855.4 5917.4 4275.6 4276.2 4309.5 4313.7 4315.6 4246.7 4296.1 4325.9 4341.3 4354.6 4776.0 4812.4 4826.4 4842.2 4844.0 5547.2 5593.6 5665.9 5672.2 5673.8 1419.6 1480.2 1489.0 1491.3 1517.3 1056.8 1075.8 1081.8 1092.3 1092.7 5271.0 5283.7 5284.8 5286.0 5313.4 5521.8 5554.6 5567.9 5586.9 5589.7 5032.7 5217.6 5287.6 5312.5 5312.9 2876.8 2903.4 2929.2 2952.2 2973.0 5823.8 5826.8 5854.5 5912.8 5939.0 5544.8 5875.7 5903.7 5940.0 5950.3 6115.3 6124.4 6139.5 6154.8 6170.4 5585.4 5784.4 5784.5 5806.9 5816.5 5653.9 5731.7 5763.6 5769.6 5772.4 5801.9 6110.2 6110.2 6128.7 6159.6 4032.4 4123.6 4131.6 4134.5 4188.2 5773.5 5779.5 5786.2 5835.6 5857.0 5643.9 5652.9 5657.3 5664.6 5680.5 5392.5 5560.7 5608.9 5651.9 5655.2 5568.7 5568.7 5600.2 5608.8 5626.0 5489.0 5570.9 5628.3 5651.3 5671.2 5455.4 5471.1 5472.5 5477.6 5490.2 22:15:29 INFO - PROCESS | 27581 | 22:15:29 INFO - PROCESS | 27581 | [#5] yui.html Cycles:180 Average:16991.32 Median:4278.18 stddev:21583.81 (504.5%) stddev-sans-first:21609.64 22:15:29 INFO - PROCESS | 27581 | Values: 686.4 688.1 725.2 736.3 744.5 14430.4 14823.7 14863.6 14969.5 14975.3 14899.5 15092.8 15103.4 15126.4 15144.0 666.2 684.8 790.6 807.6 810.7 787.9 795.0 796.4 797.2 803.3 849.2 855.8 856.9 870.8 872.7 855.6 856.1 857.3 859.3 864.9 619.0 626.1 629.5 632.3 633.0 15151.0 15451.7 15475.4 15974.5 16099.4 13224.4 14077.0 14472.1 14568.2 14622.8 11397.2 11659.5 11663.4 11737.4 11873.9 3641.2 3679.2 3741.9 3742.8 3776.7 65623.3 66604.0 67693.3 73436.3 74269.6 10605.0 10659.5 10787.5 10810.8 10820.0 21457.1 21459.8 21476.2 21679.1 21788.1 7830.5 7994.0 8113.5 8195.2 8363.6 4225.0 4245.7 4323.2 4339.4 4346.1 3357.3 3430.0 3441.2 3448.3 3475.0 587.2 593.6 598.2 616.9 618.9 625.5 625.6 626.0 626.8 630.3 8710.4 9067.3 9089.2 9318.8 9567.6 571.9 583.5 585.9 604.1 666.1 3995.0 4133.1 4233.9 4247.8 4308.5 81499.6 81625.6 82974.0 83332.0 84265.2 56333.4 58143.7 71861.3 71894.6 72581.0 57080.4 57385.7 57748.4 58218.3 58395.0 9212.5 9726.7 10050.5 10212.6 10263.5 38181.0 39554.4 39751.8 40519.6 40931.8 53427.7 54509.7 54587.7 54593.7 55279.7 12142.9 12715.6 12717.3 12825.4 12928.0 14295.9 14305.9 14576.7 14606.5 14918.7 13521.3 13664.7 14100.9 14279.1 14753.5 13490.7 13522.2 13831.7 13909.9 13939.7 12364.9 12648.8 12790.9 13194.9 13237.9 9634.0 9768.9 9874.0 10169.1 10500.6 10047.1 10559.4 10585.2 10587.2 10640.3 22:15:29 INFO - PROCESS | 27581 | -------- Summary: end -------- 22:15:29 INFO - PROCESS | 27581 | 22:15:30 INFO - TEST-INFO | 27581: exit 0 22:15:30 INFO - TEST-OK | dromaeo_css | took 1114237ms 22:15:30 INFO - TEST-START | kraken 22:15:30 INFO - operating with platform_type : linux_ 22:15:30 INFO - Initialising browser for kraken test... 22:15:30 INFO - TEST-INFO | started process 27934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Imf5v/profile http://localhost:50631/getInfo.html) 22:15:30 INFO - PROCESS | 27934 | 1483078530906 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 22:15:34 INFO - PROCESS | 27934 | __metrics Screen width/height:1600/1200 22:15:34 INFO - PROCESS | 27934 | colorDepth:24 22:15:34 INFO - PROCESS | 27934 | Browser inner width/height: 1024/697 22:15:34 INFO - PROCESS | 27934 | __metrics 22:15:35 ERROR - PROCESS | 27934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 22:15:35 INFO - TEST-INFO | 27934: exit 0 22:15:35 INFO - Browser initialized. 22:15:35 INFO - Running cycle 1/1 for kraken test... 22:15:35 INFO - TEST-INFO | started process 28058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Imf5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:47 INFO - PROCESS | 28058 | RSS: Main: 154116096 22:15:47 INFO - PROCESS | 28058 | 22:15:50 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50631/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:51 INFO - PROCESS | 28058 | RSS: Main: 160501760 22:15:51 INFO - PROCESS | 28058 | 22:15:53 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50631/tests/kraken/driver.html?testName=audio-dft) 22:15:54 INFO - PROCESS | 28058 | RSS: Main: 159666176 22:15:54 INFO - PROCESS | 28058 | 22:15:57 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50631/tests/kraken/driver.html?testName=audio-fft) 22:15:58 INFO - PROCESS | 28058 | RSS: Main: 155836416 22:15:58 INFO - PROCESS | 28058 | 22:16:00 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50631/tests/kraken/driver.html?testName=audio-oscillator) 22:16:00 INFO - PROCESS | 28058 | RSS: Main: 156864512 22:16:00 INFO - PROCESS | 28058 | 22:16:02 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:03 INFO - PROCESS | 28058 | RSS: Main: 156471296 22:16:03 INFO - PROCESS | 28058 | 22:16:06 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50631/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:07 INFO - PROCESS | 28058 | RSS: Main: 160698368 22:16:07 INFO - PROCESS | 28058 | 22:16:10 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50631/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:11 INFO - PROCESS | 28058 | RSS: Main: 158908416 22:16:11 INFO - PROCESS | 28058 | 22:16:14 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50631/tests/kraken/driver.html?testName=json-parse-financial) 22:16:14 INFO - PROCESS | 28058 | RSS: Main: 159051776 22:16:14 INFO - PROCESS | 28058 | 22:16:16 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:16 INFO - PROCESS | 28058 | RSS: Main: 159133696 22:16:16 INFO - PROCESS | 28058 | 22:16:18 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:19 INFO - PROCESS | 28058 | RSS: Main: 159248384 22:16:19 INFO - PROCESS | 28058 | 22:16:21 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:22 INFO - PROCESS | 28058 | RSS: Main: 159662080 22:16:22 INFO - PROCESS | 28058 | 22:16:24 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:25 INFO - PROCESS | 28058 | RSS: Main: 159805440 22:16:25 INFO - PROCESS | 28058 | 22:16:28 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:29 INFO - PROCESS | 28058 | RSS: Main: 160030720 22:16:29 INFO - PROCESS | 28058 | 22:16:30 INFO - PROCESS | 28058 | Cycle 1(1): loaded http://localhost:50631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50631/tests/kraken/driver.html?testName=ai-astar) 22:16:31 INFO - PROCESS | 28058 | RSS: Main: 161419264 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | __start_tp_report 22:16:31 INFO - PROCESS | 28058 | _x_x_mozilla_page_load 22:16:31 INFO - PROCESS | 28058 | _x_x_mozilla_page_load_details 22:16:31 INFO - PROCESS | 28058 | |i|pagename|runs| 22:16:31 INFO - PROCESS | 28058 | |0;ai-astar;106;113;113;113;114;112;113;114;113;115 22:16:31 INFO - PROCESS | 28058 | |1;audio-beat-detection;148;122;120;166;121;128;121;122;141;122 22:16:31 INFO - PROCESS | 28058 | |2;audio-dft;162;162;163;162;165;164;166;163;163;162 22:16:31 INFO - PROCESS | 28058 | |3;audio-fft;76;77;77;111;78;76;77;75;92;75 22:16:31 INFO - PROCESS | 28058 | |4;audio-oscillator;84;83;111;85;83;83;95;85;83;114 22:16:31 INFO - PROCESS | 28058 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;120;125 22:16:31 INFO - PROCESS | 28058 | |6;imaging-darkroom;149;148;148;149;147;149;147;147;147;147 22:16:31 INFO - PROCESS | 28058 | |7;imaging-desaturate;96;96;95;96;96;96;99;97;97;97 22:16:31 INFO - PROCESS | 28058 | |8;json-parse-financial;58;56;58;56;65;57;57;57;57;58 22:16:31 INFO - PROCESS | 28058 | |9;json-stringify-tinderbox;66;66;67;67;67;69;67;69;66;66 22:16:31 INFO - PROCESS | 28058 | |10;stanford-crypto-aes;82;84;81;82;89;83;89;87;83;83 22:16:31 INFO - PROCESS | 28058 | |11;stanford-crypto-ccm;134;138;128;135;140;127;132;129;169;136 22:16:31 INFO - PROCESS | 28058 | |12;stanford-crypto-pbkdf2;168;168;169;167;171;181;170;176;172;168 22:16:31 INFO - PROCESS | 28058 | |13;stanford-crypto-sha256-iterative;64;64;66;66;64;70;63;63;63;63 22:16:31 INFO - PROCESS | 28058 | __end_tp_report 22:16:31 INFO - PROCESS | 28058 | __start_cc_report 22:16:31 INFO - PROCESS | 28058 | _x_x_mozilla_cycle_collect,720 22:16:31 INFO - PROCESS | 28058 | __end_cc_report 22:16:31 INFO - PROCESS | 28058 | __startTimestamp1483078591043__endTimestamp 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | ------- Summary: start ------- 22:16:31 INFO - PROCESS | 28058 | Number of tests: 14 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:2.46 (2.2%) stddev-sans-first:0.87 22:16:31 INFO - PROCESS | 28058 | Values: 106.0 113.0 113.0 113.0 114.0 112.0 113.0 114.0 113.0 115.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:125.00 stddev:15.59 (12.5%) stddev-sans-first:15.29 22:16:31 INFO - PROCESS | 28058 | Values: 148.0 122.0 120.0 166.0 121.0 128.0 121.0 122.0 141.0 122.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.41 22:16:31 INFO - PROCESS | 28058 | Values: 162.0 162.0 163.0 162.0 165.0 164.0 166.0 163.0 163.0 162.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#3] audio-fft Cycles:10 Average:81.40 Median:77.00 stddev:11.54 (15.0%) stddev-sans-first:12.07 22:16:31 INFO - PROCESS | 28058 | Values: 76.0 77.0 77.0 111.0 78.0 76.0 77.0 75.0 92.0 75.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.50 stddev:12.11 (14.5%) stddev-sans-first:12.61 22:16:31 INFO - PROCESS | 28058 | Values: 84.0 83.0 111.0 85.0 83.0 83.0 95.0 85.0 83.0 114.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:2.46 (2.1%) stddev-sans-first:2.55 22:16:31 INFO - PROCESS | 28058 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 120.0 125.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 22:16:31 INFO - PROCESS | 28058 | Values: 149.0 148.0 148.0 149.0 147.0 149.0 147.0 147.0 147.0 147.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 22:16:31 INFO - PROCESS | 28058 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 99.0 97.0 97.0 97.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:2.60 (4.5%) stddev-sans-first:2.76 22:16:31 INFO - PROCESS | 28058 | Values: 58.0 56.0 58.0 56.0 65.0 57.0 57.0 57.0 57.0 58.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 22:16:31 INFO - PROCESS | 28058 | Values: 66.0 66.0 67.0 67.0 67.0 69.0 67.0 69.0 66.0 66.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:2.95 (3.5%) stddev-sans-first:3.00 22:16:31 INFO - PROCESS | 28058 | Values: 82.0 84.0 81.0 82.0 89.0 83.0 89.0 87.0 83.0 83.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:135.50 stddev:12.10 (8.9%) stddev-sans-first:12.79 22:16:31 INFO - PROCESS | 28058 | Values: 134.0 138.0 128.0 135.0 140.0 127.0 132.0 129.0 169.0 136.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:170.50 stddev:4.40 (2.6%) stddev-sans-first:4.53 22:16:31 INFO - PROCESS | 28058 | Values: 168.0 168.0 169.0 167.0 171.0 181.0 170.0 176.0 172.0 168.0 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - PROCESS | 28058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:2.22 (3.5%) stddev-sans-first:2.35 22:16:31 INFO - PROCESS | 28058 | Values: 64.0 64.0 66.0 66.0 64.0 70.0 63.0 63.0 63.0 63.0 22:16:31 INFO - PROCESS | 28058 | -------- Summary: end -------- 22:16:31 INFO - PROCESS | 28058 | 22:16:31 INFO - TEST-INFO | 28058: exit 0 22:16:32 INFO - TEST-OK | kraken | took 61554ms 22:16:32 INFO - SUITE-END | took 1175s 22:16:32 INFO - Completed test suite (00:19:35) 22:16:32 INFO - javascript benchmark 22:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6956.673951641142, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3172.5875636167293, 3184.2357834119803, 3198.3123628419885, 3222.806631602104, 3224.3873664003854, 5299.761510732017, 5361.1154159563675, 5375.354957405112, 5399.460053994599, 5428.185772134182, 5292.153255479124, 5334.91997620036, 5390.757415916283, 5393.541548968333, 5479.753411096501, 4846.34574332465, 4891.4130304363525, 4910.508949105097, 5006.123928312549, 5006.123928312549, 4821.807127714905, 4929.4824043475455, 4955.653104282702, 4956.033573453178, 4981.053599816041, 4789.616830653539, 4902.3872015998, 4928.310036594879, 4980.87547811304, 5036.320096786923, 4809.0862736080035, 4812.807487700487, 4880.365552478191, 4941.579965702919, 4988.077205716918, 4885.998370334073, 4887.491892431266, 4902.117618828609, 4906.632002599819, 4938.333325001151, 5342.652727572696, 5380.2736630555155, 5410.864728381783, 5427.402985671573, 5431.538319242869, 5643.8589035274035, 5677.57418193633, 5699.2306038684665, 5736.196932429463, 5739.426057394269, 5775.075987841967, 5798.449147330997, 5805.4194580542035, 5809.477147056743, 5876.177335173079, 5364.249005139283, 5385.919211211835, 5387.1380579107545, 5401.810936617199, 5426.0, 5757.481826635539, 5800.53595712342, 5844.649321040752, 5878.911816322759, 5903.970480147572, 5682.318121825408, 5711.485966262973, 5714.514266287412, 5747.655140691572, 5764.164196191613, 5750.424957504216, 5779.133130030445, 5813.244278243801, 5834.620749651259, 5840.88318233633, 5599.496045355938, 5649.4633009864, 5668.404817494104, 5675.574331925122, 5707.029804933171, 5730.570207234474, 5742.08126699726, 5748.367679555246, 5752.7698892043845, 5790.623609465371, 4300.075483771005, 4306.117245964632, 4309.0, 4340.283853164193, 4348.326009468537, 3821.8662346818282, 3846.576876543578, 3852.4799152114106, 3887.941680874789, 3891.727579069438, 5519.69641669704, 5539.2522009529, 5561.138023606348, 5583.302087239095, 5621.409751976065, 5768.653880767168, 5773.076307790733, 5777.393373695785, 5796.1595568642315, 5813.505852002542, 5330.786768529293, 5377.838664840061, 5490.670559766427, 5530.529904958124, 5557.5831812614215, 4816.8554943351755, 4850.684705494132, 4859.465458799529, 4880.0, 4881.316615673809, 6102.908456373158, 6117.418845209698, 6133.202683651097, 6162.876742465215, 6167.475764559973, 5648.661080335193, 5710.114932185518, 5845.41545845429, 5856.0, 5857.384974577608, 6052.636841789506, 6114.6636934969, 6126.6017708848785, 6162.630242185304, 6174.166487524127, 5749.396313387034, 5803.216565763568, 5803.680797556175, 5816.127580862904, 5844.327902291291, 5674.801381951612, 5881.411858814085, 5909.084091965752, 5921.7631294747725, 5924.437178468039, 5538.224648549126, 5547.694876781816, 5555.72221388937, 5589.413111623384, 5656.971715141398, 5585.994520986262, 5610.18652295423, 5610.495055444866, 5613.494785469327, 5616.4383561645145, 5518.227448157341, 5567.944320556905, 5578.470045345685, 5611.214429979725, 5633.8591535211945, 5603.991281569357, 5672.60291779588, 5693.946619875336, 5698.54411647059, 5766.538676905921, 5501.834944951658, 5543.805966791143, 5547.389787123494, 5549.223108764857, 5564.221009058654], "value": 5326.1388707175065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7103520651658, 566.6713306282356, 573.7303467370334, 576.4206971993146, 576.9048107062335, 38112.618873811254, 39291.0, 39550.8022459888, 43633.0, 43763.0, 41620.375694364535, 42120.57879421205, 42214.7889260554, 42253.0, 42368.09343579539, 8633.956830215855, 8795.340349473783, 8803.911960880405, 8814.427062240933, 10011.299209055369, 9922.851157232648, 10240.539175737109, 10240.948795256014, 10242.28304018719, 10278.486075696223, 10285.382877027365, 10308.433036183007, 10335.896641033569, 10340.586376544967, 10344.896551034506, 10261.897381026169, 10310.07209351162, 10314.0, 10331.690049298533, 10346.896531034668, 10070.9496452518, 10186.134178594828, 10192.541335639915, 10205.2346074044, 10208.693739187836, 37149.442758358644, 37152.44271335932, 37176.628233717856, 37192.628073719185, 37336.626633733584, 3899.902502437462, 3963.7819919904396, 3970.166265084336, 3983.2830090583684, 4053.837846486137, 28360.290992725142, 28606.427871442662, 28623.57064644032, 28721.0, 28901.27746806347, 4138.710290279651, 4275.893102672458, 4305.590968857953, 4321.82712691492, 4346.1090476452255, 316527.417362914, 316716.0, 317961.0, 318406.0, 318502.0, 49635.503644963086, 49812.75093624509, 49956.25065624018, 50166.49833501691, 50170.24744628833, 52315.73842130765, 52570.211446828325, 52687.473125269025, 52780.499510087786, 52798.472015280124, 14306.928465357814, 14691.853081469262, 14706.205820893996, 14715.19066451334, 14822.258887055605, 10912.563497460013, 11084.445777711082, 11138.10895128404, 11211.943940280247, 11466.94266528662, 16334.794802701483, 16448.588785280463, 16462.0, 16483.58791030234, 16485.423010194827, 6642.833929151713, 6657.800265992028, 6758.290379510179, 6758.425533829582, 6798.320167983162, 890.5947793753827, 893.1604291965532, 900.7793090692691, 921.755734730297, 940.7930255343813, 25938.22185334443, 25946.610800838003, 26320.73679263183, 26512.33719156998, 26513.33716657099, 1063.3194755356578, 1067.556963860005, 1067.7223921780237, 1068.8343306787306, 1071.8392241163888, 14081.647958800908, 14675.559733208021, 14727.631809204855, 14893.851061489464, 15145.772813407808, 487009.0, 488348.0, 489558.0, 490604.0, 491789.0, 50158.247626285636, 50245.0, 50346.0, 50602.74698626557, 50774.74612626913, 1384.2317513779747, 1392.791081337787, 1400.803887455757, 1418.3121186224673, 1422.239102080382, 26932.0, 27240.727592724612, 27359.58960615632, 27945.44109117847, 28968.0, 41797.0, 42370.15259694851, 42517.57482425136, 42525.36211956885, 42540.0, 441259.0, 444067.0, 444880.0, 446051.0, 449553.0, 24556.631650524898, 24864.751352486244, 25216.0, 25326.74673253244, 26150.476990460465, 39770.2045959085, 40011.0, 40745.59254407418, 41021.17957640771, 41260.58739412687, 33922.660773392934, 34030.82984585061, 34124.82937585296, 34135.0, 34315.65684343225, 33544.66455335415, 33563.83218083894, 33689.494657579664, 33986.83006584951, 34167.65832341645, 34321.31357372888, 34568.48147277743, 34634.82682586571, 34813.12967175841, 34925.0, 24379.26862194137, 25410.745892541578, 27466.0, 27920.581191282552, 28089.57865631976, 25304.0, 25430.872845635655, 25690.871545642152, 26034.360018519405, 26144.477110458065], "value": 18603.739325854625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.1737104194317, 404.3005600311463, 407.33604225113066, 408.60365445517846, 426.6458839163495, 14687.706245875102, 17105.23026463809, 17970.101494925235, 18787.436376908696, 18816.341428050004, 16945.0, 17405.82594174058, 17489.300427982864, 18510.167042483088, 18767.249310027615, 5147.974260128694, 5151.896962060747, 5285.075111855429, 5324.307839980797, 5364.839054828341, 5165.63840531163, 5289.047971365153, 5303.734813259341, 5304.681719096847, 5306.840794776143, 5122.15484445068, 5196.246544251081, 5267.1045922193125, 5267.76295066721, 5272.789088436458, 5172.146595811687, 5176.870578235536, 5249.1338929076655, 5314.521693047605, 5336.519713225809, 5069.771860266297, 5149.819756308511, 5223.268742376071, 5375.596830237748, 5417.0, 13108.082434229607, 13539.45842166322, 13830.930845345809, 14944.0, 21524.677129843065, 2884.13475957212, 2896.7537759290485, 2897.5074237379695, 3018.3963207358397, 3042.9087127386215, 6269.686515674198, 7184.856302873914, 10078.848817267746, 10440.32137911041, 10463.94768026155, 1857.619188066443, 1914.4161030885575, 1929.2958070304378, 1934.0, 1935.6709359408935, 72151.63924180345, 72709.27290727077, 73493.0, 75386.24613753847, 76020.61989690016, 10346.896531034594, 10663.306885052447, 10735.892641073646, 10792.24454288208, 10851.837222441669, 12110.515579376726, 14483.420663173565, 14506.419743210365, 14534.200618965848, 14535.200563969083, 7399.6670149843385, 7466.514676546116, 7725.034370703662, 7778.805529861799, 7786.8053298666855, 7370.299821516947, 7422.851542969111, 7469.962650186714, 7607.657655405409, 7671.0, 4099.426080348753, 4106.466159399319, 4134.669226461876, 4159.313713237282, 4234.237837189336, 1964.196916956738, 1976.8715033522774, 1983.2364539652337, 2029.4926268432891, 2071.5339048714222, 872.228078150841, 887.8313120507083, 899.5861903524452, 902.4089221559889, 926.9212116970133, 17251.82748172527, 17390.47828565145, 17670.204840782197, 17901.462956111336, 18159.45521634353, 878.3456325037888, 948.3645957208687, 950.8288508068614, 957.6791774755395, 960.4333443268365, 9265.675701350421, 9398.060193980684, 9477.194438472668, 9494.905050949541, 9593.0, 454087.0, 455312.0, 457144.8568928884, 468027.0, 469694.0, 65427.67286163634, 76407.0, 81978.18021819825, 82036.58981705173, 83841.58079209687, 1027.9229057820694, 1028.3161697471098, 1054.0671505717496, 1055.0978913029248, 1062.7927554127025, 15118.244087795787, 15167.0, 15250.466233681767, 15268.923655382096, 15854.207289635702, 37387.813060934524, 37968.62031379761, 38122.809385952896, 38173.42739858849, 38603.61396386, 51431.74284128555, 51558.74220628873, 51902.74048629884, 52111.0, 54687.17969230385, 7886.329661978796, 8073.959630202046, 8289.171082891662, 8364.665413383396, 8398.202170793766, 9153.954230228806, 12064.577739779066, 12791.104622676323, 12831.422585983466, 12925.612231633066, 11001.889981100087, 11040.723981900195, 11073.944630276797, 11164.553417863195, 11230.494627741935, 10831.783364332827, 10857.0, 10919.617813376493, 11083.445827708421, 11313.773724525628, 10975.451227438436, 11065.668029959113, 11088.501017454073, 11172.608958686407, 11189.160812938899, 8221.260086592236, 8351.791205219919, 8400.537970411442, 8607.225349718556, 8644.394892357475, 9920.503974801375, 11062.834057488983, 11119.221654484109, 11205.775884482428, 11583.5945741902], "value": 8586.512435399145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.5921353200808, 1386.9098508596935, 1387.6253411578869, 1388.8750012498874, 1399.6430910117917, 7877.054753429589, 8017.799555011113, 8339.958300208506, 8347.91652083479, 8429.45208561443, 8347.29048030918, 8444.95777521113, 8502.744917652464, 8516.489010659365, 8532.274756645693, 2313.5141620259724, 2347.58917189492, 2356.257778799681, 2357.5167090746354, 2363.0311572255378, 2318.5710643531, 2324.2910912171783, 2375.3705268103968, 2393.85636861788, 2402.675638788767, 2322.628379459287, 2344.343583796531, 2345.3433038749176, 2346.389938615955, 2348.4363752699314, 2265.660150977358, 2273.5225602623386, 2275.601769690306, 2278.5898538263104, 2284.771522847702, 2296.0356650206954, 2326.6975293211776, 2331.0559223514506, 2367.1833217540093, 2374.382660508263, 8322.62548185333, 8449.662013519452, 8450.112738162466, 8459.450135741157, 8474.1102184271, 5036.546710796009, 5209.244659524347, 5209.322788037569, 5210.947890521084, 5212.869678258036, 3171.5242713592916, 3179.60254968129, 3247.382997230519, 3309.1065412338535, 3349.363620912019, 1252.5303011370736, 1268.6067319131098, 1293.8447386313703, 1320.9933950330187, 1373.9931300343435, 10581.682549523526, 10590.311629744043, 10663.680089597325, 10674.9466252669, 10774.676759697222, 4266.530681625019, 4354.325079612665, 4469.195544801967, 4490.079533695584, 4550.249208880564, 8935.419197752126, 8946.552672366486, 8977.147171018743, 8989.280857531381, 8990.460572365679, 5087.847364579068, 5111.284420181178, 5165.14775062118, 5187.818426355059, 5208.947910520922, 4759.4764575896625, 4787.3537072495465, 4793.304970779218, 4845.2732090186755, 4853.223484242504, 3499.545059142346, 3534.3461459630053, 3587.121155316964, 3648.21563363878, 3725.5343082114737, 1026.2918586175515, 1077.1867240233573, 1081.3295756630782, 1132.3545579019878, 1134.9262297950606, 754.9773506794805, 844.2148801614558, 899.2086963472103, 912.8585069314267, 918.6325469812128, 5269.973650131725, 5420.403755586883, 5790.739416726257, 5851.210086638334, 5931.525477961753, 925.6251218256617, 943.4009404028492, 953.0218068535826, 954.627695198873, 955.1737746848926, 3749.6250374962833, 3752.2120354725266, 3831.0, 3870.748401353903, 3903.843846246118, 9754.219662426989, 10074.848877266846, 10097.848532272023, 10119.13987311072, 10137.847932281022, 9298.395604285699, 9746.171575416169, 9784.070513301225, 10009.799804003878, 10022.849657255147, 7647.464677472635, 7766.184550622216, 7794.727184548514, 7800.726974555863, 7853.803654908673, 5647.322321321468, 5801.738921748447, 5839.240898683144, 5935.169076329404, 6081.452669259788, 8940.240079593048, 9065.954670226607, 9107.544622768703, 9151.954240228757, 9245.491497967676, 9464.1009104135, 9479.810403792024, 9556.092171243721, 9645.517724113906, 9660.855087173839, 7136.643167841483, 7197.31625495598, 7258.49190556656, 7270.600116993616, 7278.272172782679, 7533.2466753324225, 7540.132884718328, 7647.770566883002, 7698.03774528184, 7728.072631284282, 6601.108850305147, 6767.424768894699, 6861.931380686129, 6868.961952848598, 6905.585664860125, 6818.727250910107, 6889.793306200822, 6970.581765094111, 7006.299370062953, 7224.8916266255, 6063.5452341073715, 6100.389961004042, 6170.845728856814, 6177.413145751147, 6181.258249010148, 4991.950080499294, 5073.315102461268, 5082.618803589671, 5137.152369858932, 5228.921566176587, 5029.74851257443, 5040.5967522597375, 5087.491250874883, 5203.063448579292, 5286.286351342674], "value": 4401.015522534928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9249642567912, 403.5540727496117, 411.0586756328009, 412.17564870259474, 415.38315601332016, 5161.200013997827, 5279.445658205891, 5329.706866122362, 5350.19747037944, 5362.946370536289, 5089.491050894909, 5185.170372740362, 5212.817551385702, 5244.292020577221, 5267.841964741064, 4208.915821683565, 4219.451471308726, 4236.4916210054835, 4239.724417912841, 4242.448481697391, 4113.444684967536, 4235.9364609530885, 4252.404663347118, 4252.617264446199, 4253.574642535753, 4167.916641667165, 4170.687198460128, 4181.895452613694, 4185.623293903548, 4193.0, 4156.501219853607, 4166.375043743433, 4179.9727132340795, 4180.477440319944, 4187.832486700559, 3813.3707938190164, 3814.313423583754, 3826.253880493305, 3833.252515759428, 3850.8062500624897, 5078.517540833652, 5120.183898855615, 5133.8716532087, 5155.607985843839, 5204.141316682742, 4841.2496063110275, 4847.830325938575, 4848.878778030577, 4859.975700121512, 4880.389951256093, 5481.909697996635, 5597.636153650041, 5600.767831077156, 5609.382967873531, 5613.550915926716, 4024.7383920045104, 4090.7954602270065, 4095.7747323897174, 4097.836086556535, 4125.711200215986, 5787.797427090031, 5788.102844059177, 5806.954748145332, 5855.443732845373, 5917.378675239124, 4275.5724427557, 4276.2089013532595, 4309.482862056573, 4313.741175529478, 4315.5900189481945, 4246.745195288293, 4296.140771845643, 4325.9134817303475, 4341.327094300388, 4354.608085272341, 4776.0, 4812.446568644581, 4826.420829500412, 4842.201036828954, 4843.95156048435, 5547.223388725582, 5593.636413633101, 5665.886682266331, 5672.205891175238, 5673.780137270506, 1419.552840855148, 1480.156310902775, 1488.977665335021, 1491.2841835918603, 1517.324790468231, 1056.799208150449, 1075.7736180753948, 1081.7511972246427, 1092.3118435385816, 1092.6995076353908, 5271.0, 5283.735813209324, 5284.762185701653, 5285.973570132125, 5313.405978206522, 5521.834344969658, 5554.555635549146, 5567.937634301118, 5586.944130558723, 5589.692566908778, 5032.672876263031, 5217.58259339252, 5287.576993840484, 5312.476573627496, 5312.867178320573, 2876.7917474660276, 2903.3757742085554, 2929.22375570474, 2952.1659207160938, 2973.0189037617533, 5823.845177284347, 5826.7763769608855, 5854.473097421167, 5912.822615321547, 5939.011230566259, 5544.833654990357, 5875.735591898375, 5903.660809305157, 5940.0, 5950.315713692894, 6115.296740874767, 6124.38756124384, 6139.508839292846, 6154.753809847645, 6170.444659980444, 5585.385607583082, 5784.392638773036, 5784.4504772046585, 5806.941930580809, 5816.47651711348, 5653.925754106706, 5731.713414329351, 5763.625364351304, 5769.567282453749, 5772.393898640582, 5801.883962320814, 6110.158776169103, 6110.175126357884, 6128.693565321805, 6159.568830182024, 4032.354823228269, 4123.649489793281, 4131.636559935154, 4134.545200027935, 4188.183304255641, 5773.509251713652, 5779.4973306939655, 5786.218860453785, 5835.56233282497, 5857.0, 5643.858903527444, 5652.85191627179, 5657.2928383952, 5664.603477756517, 5680.460356266148, 5392.514673679388, 5560.666360018412, 5608.85977850557, 5651.886962260814, 5655.208270842168, 5568.6658800472105, 5568.693721845338, 5600.159976003632, 5608.775648974159, 5625.971870140623, 5489.0, 5570.916436253378, 5628.324601047901, 5651.265335506358, 5671.234383358359, 5455.399906010256, 5471.139812463782, 5472.4976015351, 5477.643953143033, 5490.231367608458], "value": 4338.663254871971, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.4371215603207, 688.0848471532859, 725.2276325713115, 736.282124928195, 744.5086243079569, 14430.422783088678, 14823.703525929475, 14863.554093377188, 14969.47606833761, 14975.251237438126, 14899.478518251863, 15092.773608395883, 15103.39586416542, 15126.394944202246, 15144.0, 666.1739443090569, 684.7603338831419, 790.5849429049738, 807.5679511461369, 810.6838333050085, 787.9212078792132, 794.9682012719484, 796.3549524884862, 797.2107613462688, 803.3211935914143, 849.218718778725, 855.8245559660286, 856.884320616715, 870.8345414371281, 872.7163671806657, 855.6021450025768, 856.1053698884681, 857.2756021162139, 859.2739135430583, 864.8875646166022, 619.0343064818852, 626.1140486212005, 629.4806784402886, 632.250782822357, 633.0409429713987, 15151.0, 15451.690966180726, 15475.380984760595, 15974.520764377086, 16099.356025758956, 13224.404901779442, 14077.0, 14472.059316144418, 14568.198749068797, 14622.780658290134, 11397.202195846294, 11659.475323610373, 11663.358515281656, 11737.413129343498, 11873.94063029688, 3641.217138315275, 3679.1962584444777, 3741.8503259869844, 3742.8315725792404, 3776.7356285060055, 65623.3437665622, 66604.0, 67693.3230667692, 73436.26563734347, 74269.62865185694, 10605.042769492507, 10659.520321585547, 10787.460626968621, 10810.783784324269, 10820.0, 21457.141714331563, 21459.78540214578, 21476.24833130864, 21679.132834686752, 21788.128474861143, 7830.491018083806, 7993.960030199928, 8113.472624279521, 8195.180481951757, 8363.58182090893, 4224.978875105605, 4245.681573881971, 4323.200207961537, 4339.435873336446, 4346.065595896835, 3357.261402491497, 3429.9657003430148, 3441.15691655546, 3448.3103379324234, 3475.0443628001995, 587.1867463562996, 593.5963544789585, 598.2432223237608, 616.8550390658191, 618.8700372921737, 625.5089754542753, 625.64338327154, 626.0077776723853, 626.7837596029362, 630.2688880898136, 8710.390272680977, 9067.319951003701, 9089.227415669742, 9318.767030824149, 9567.569459374345, 571.9313682358061, 583.4923616453713, 585.871108356161, 604.0637012630406, 666.1007639686385, 3994.980025099856, 4133.090720041586, 4233.872983810491, 4247.8088486018205, 4308.547602501755, 81499.5925020371, 81625.59187204026, 82974.0, 83332.0, 84265.15734842696, 56333.43666563364, 58143.70928145417, 71861.28138718651, 71894.64052679807, 72581.0, 57080.42919570751, 57385.71307143437, 57748.42251577514, 58218.267259910506, 58395.0, 9212.479940809959, 9726.70819875405, 10050.547725352522, 10212.591496340063, 10263.46048092792, 38181.0, 39554.406683899186, 39751.80124099477, 40519.59480405158, 40931.795341023106, 53427.73286133545, 54509.72745136249, 54587.727061364436, 54593.727031364586, 55279.72360138174, 12142.939285303517, 12715.618531444072, 12717.300548469922, 12825.358732063172, 12928.0, 14295.92852035733, 14305.928470357581, 14576.708465830836, 14606.488772892897, 14918.701625967637, 13521.323933803467, 13664.726705466033, 14100.858991409954, 14279.143251404948, 14753.483628072965, 13490.662733431744, 13522.220839038964, 13831.723365532433, 13909.860901390857, 13939.651508712363, 12364.876351236373, 12648.810267845805, 12790.87209127934, 13194.934025329812, 13237.867621323663, 9633.951830240803, 9768.902310977084, 9873.950630246803, 10169.135623472088, 10500.632477863544, 10047.145992590711, 10559.366438013743, 10585.153187745116, 10587.20595955291, 10640.308379955279], "value": 6976.371572114739, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 113.0, 115.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 120.0, 166.0, 121.0, 128.0, 121.0, 122.0, 141.0, 122.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 165.0, 164.0, 166.0, 163.0, 163.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 111.0, 78.0, 76.0, 77.0, 75.0, 92.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 111.0, 85.0, 83.0, 83.0, 95.0, 85.0, 83.0, 114.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 120.0, 125.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 99.0, 97.0, 97.0, 97.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 56.0, 65.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 69.0, 67.0, 69.0, 66.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 81.0, 82.0, 89.0, 83.0, 89.0, 87.0, 83.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 128.0, 135.0, 140.0, 127.0, 132.0, 129.0, 169.0, 136.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 167.0, 171.0, 181.0, 170.0, 176.0, 172.0, 168.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 66.0, 64.0, 70.0, 63.0, 63.0, 63.0, 63.0], "value": 64.6, "unit": "score"}]}]} 22:16:32 INFO - Return code: 0 22:16:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:16:32 ERROR - # TBPL SUCCESS # 22:16:32 INFO - Running post-action listener: _resource_record_post_action 22:16:32 INFO - [mozharness: 2016-12-30 06:16:32.351745Z] Finished run-tests step (success) 22:16:32 INFO - Running post-run listener: _resource_record_post_run 22:16:32 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 406171648; Read time: 48; Write time: 351648 22:16:32 INFO - TinderboxPrint: CPU usage
13.4% 22:16:32 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 48 22:16:32 INFO - TinderboxPrint: I/O write bytes / time
406,171,648 / 351,648 22:16:32 INFO - TinderboxPrint: CPU idle
8,241.3 (86.6%) 22:16:32 INFO - TinderboxPrint: CPU user
1,215.4 (12.8%) 22:16:32 INFO - TinderboxPrint: Swap in / out
0 / 0 22:16:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111407104; Read time: 0; Write time: 125080 22:16:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 16384; Write bytes: 294150144; Read time: 48; Write time: 226568 22:16:32 INFO - Running post-run listener: _upload_blobber_files 22:16:32 INFO - Blob upload gear active. 22:16:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:16:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:34 INFO - (blobuploader) - INFO - Done attempting. 22:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:35 INFO - (blobuploader) - INFO - Done attempting. 22:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:35 INFO - (blobuploader) - INFO - Done attempting. 22:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:38 INFO - (blobuploader) - INFO - Done attempting. 22:16:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:38 INFO - Return code: 0 22:16:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40cf23572d5daae9bdba6d1717e6e3551a8a1a80ee1270986901e5a7f962e422fea67650a6893cc92fe565d7f9480fab2ba5b7044122a85b3f092ca9a58e64a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d1b960bca003a4acc4cf2fda7af9ca2dfcda2607c1350ae525f5c84d347ca669a6eb98724fb3bc0fb93dc0994012add817299b2196481f2a8bb907e60fcff36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1929a9105cf916d4c3f496988aa43b2376330eda594b81d40c11e8493ee26525164dfc388afbfbaacab79e7bcf795b5de0e4b3673388e45acbacbe84fa1f24fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f64f2d712e46c678838306563cfef875df94ee4beed9bffd334e28670e483dc43bd887c06a9766c3c9cc3b1a0af2598490b97b7a21e2a63686e10aa2c3423d4c"} 22:16:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:38 INFO - Contents: 22:16:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40cf23572d5daae9bdba6d1717e6e3551a8a1a80ee1270986901e5a7f962e422fea67650a6893cc92fe565d7f9480fab2ba5b7044122a85b3f092ca9a58e64a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d1b960bca003a4acc4cf2fda7af9ca2dfcda2607c1350ae525f5c84d347ca669a6eb98724fb3bc0fb93dc0994012add817299b2196481f2a8bb907e60fcff36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1929a9105cf916d4c3f496988aa43b2376330eda594b81d40c11e8493ee26525164dfc388afbfbaacab79e7bcf795b5de0e4b3673388e45acbacbe84fa1f24fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f64f2d712e46c678838306563cfef875df94ee4beed9bffd334e28670e483dc43bd887c06a9766c3c9cc3b1a0af2598490b97b7a21e2a63686e10aa2c3423d4c"} 22:16:38 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:38 INFO - Copying logs to upload dir... 22:16:38 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.298239 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-29 22:16:38.685314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 22:16:38.688971) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40cf23572d5daae9bdba6d1717e6e3551a8a1a80ee1270986901e5a7f962e422fea67650a6893cc92fe565d7f9480fab2ba5b7044122a85b3f092ca9a58e64a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d1b960bca003a4acc4cf2fda7af9ca2dfcda2607c1350ae525f5c84d347ca669a6eb98724fb3bc0fb93dc0994012add817299b2196481f2a8bb907e60fcff36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1929a9105cf916d4c3f496988aa43b2376330eda594b81d40c11e8493ee26525164dfc388afbfbaacab79e7bcf795b5de0e4b3673388e45acbacbe84fa1f24fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f64f2d712e46c678838306563cfef875df94ee4beed9bffd334e28670e483dc43bd887c06a9766c3c9cc3b1a0af2598490b97b7a21e2a63686e10aa2c3423d4c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011833 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062602/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40cf23572d5daae9bdba6d1717e6e3551a8a1a80ee1270986901e5a7f962e422fea67650a6893cc92fe565d7f9480fab2ba5b7044122a85b3f092ca9a58e64a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d1b960bca003a4acc4cf2fda7af9ca2dfcda2607c1350ae525f5c84d347ca669a6eb98724fb3bc0fb93dc0994012add817299b2196481f2a8bb907e60fcff36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1929a9105cf916d4c3f496988aa43b2376330eda594b81d40c11e8493ee26525164dfc388afbfbaacab79e7bcf795b5de0e4b3673388e45acbacbe84fa1f24fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f64f2d712e46c678838306563cfef875df94ee4beed9bffd334e28670e483dc43bd887c06a9766c3c9cc3b1a0af2598490b97b7a21e2a63686e10aa2c3423d4c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 22:16:38.716775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 22:16:38.717488) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483077362.811343-2052261366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 22:16:38.799711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 22:16:38.800060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 22:16:38.800422) ========= ========= Total master_lag: 0.17 =========