builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1484235295.22 results: success (0) buildid: 20170112073441 builduid: 9761a1699dde402399459cb218be7b16 revision: ba83951bf8aaff2805f8de3cea8ada4fbb16b527 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.225108) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.225580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.225854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.248736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.249191) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 07:34:55-- 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 2017-01-12 07:34:56 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.317882 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.581041) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.581349) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020737 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:55.630018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 07:34:55.630333) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ba83951bf8aaff2805f8de3cea8ada4fbb16b527 --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 ba83951bf8aaff2805f8de3cea8ada4fbb16b527 --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=934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 07:34:56,303 truncating revision to first 12 chars 2017-01-12 07:34:56,303 Setting DEBUG logging. 2017-01-12 07:34:56,303 attempt 1/10 2017-01-12 07:34:56,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ba83951bf8aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 07:34:57,188 unpacking tar archive at: mozilla-inbound-ba83951bf8aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.213836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 07:34:56.857379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:56.860725) ========= script_repo_revision: ba83951bf8aaff2805f8de3cea8ada4fbb16b527 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:56.861109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:56.861374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 07:34:56.871779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-01-12 07:34:56.872050) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:34:57 INFO - MultiFileLogger online at 20170112 07:34:57 in /builds/slave/test 07:34:57 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 07:34:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:57 INFO - {'append_to_log': False, 07:34:57 INFO - 'base_work_dir': '/builds/slave/test', 07:34:57 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:34:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:57 INFO - 'branch': 'Mozilla-Inbound', 07:34:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:57 INFO - 'config_files': ('talos/linux_config.py',), 07:34:57 INFO - 'default_actions': ('clobber', 07:34:57 INFO - 'read-buildbot-config', 07:34:57 INFO - 'download-and-extract', 07:34:57 INFO - 'populate-webroot', 07:34:57 INFO - 'create-virtualenv', 07:34:57 INFO - 'install', 07:34:57 INFO - 'run-tests'), 07:34:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:57 INFO - 'download_minidump_stackwalk': True, 07:34:57 INFO - 'download_symbols': 'ondemand', 07:34:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:57 INFO - 'installer_path': 'installer.exe', 07:34:57 INFO - 'log_level': 'info', 07:34:57 INFO - 'log_name': 'talos', 07:34:57 INFO - 'log_to_console': True, 07:34:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:34:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:34:57 INFO - 'opt_config_files': (), 07:34:57 INFO - 'pip_index': False, 07:34:57 INFO - 'sps_profile': False, 07:34:57 INFO - 'sps_profile_interval': 0, 07:34:57 INFO - 'suite': 'dromaeojs-e10s', 07:34:57 INFO - 'system_bits': '32', 07:34:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:57 INFO - 'title': 'talos-linux64-ix-057', 07:34:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:57 INFO - 'use_talos_json': True, 07:34:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:57 INFO - 'work_dir': 'build'} 07:34:57 INFO - [mozharness: 2017-01-12 15:34:57.641507Z] Running clobber step. 07:34:57 INFO - Running pre-action listener: _resource_record_pre_action 07:34:57 INFO - Running main action method: clobber 07:34:57 INFO - rmtree: /builds/slave/test/build 07:34:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:58 INFO - Running post-action listener: _resource_record_post_action 07:34:58 INFO - [mozharness: 2017-01-12 15:34:58.116348Z] Finished clobber step (success) 07:34:58 INFO - [mozharness: 2017-01-12 15:34:58.116448Z] Running read-buildbot-config step. 07:34:58 INFO - Running pre-action listener: _resource_record_pre_action 07:34:58 INFO - Running main action method: read_buildbot_config 07:34:58 INFO - Using buildbot properties: 07:34:58 INFO - { 07:34:58 INFO - "project": "", 07:34:58 INFO - "product": "firefox", 07:34:58 INFO - "script_repo_revision": "production", 07:34:58 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:34:58 INFO - "repository": "", 07:34:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:34:58 INFO - "buildid": "20170112073441", 07:34:58 INFO - "stage_platform": "linux64-pgo", 07:34:58 INFO - "basedir": "/builds/slave/test", 07:34:58 INFO - "buildnumber": 2449, 07:34:58 INFO - "platform": "ubuntu64_hw", 07:34:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:34:58 INFO - "slavebuilddir": "test", 07:34:58 INFO - "branch": "mozilla-inbound", 07:34:58 INFO - "revision": "ba83951bf8aaff2805f8de3cea8ada4fbb16b527", 07:34:58 INFO - "slavename": "talos-linux64-ix-057", 07:34:58 INFO - "builduid": "9761a1699dde402399459cb218be7b16", 07:34:58 INFO - "repo_path": "integration/mozilla-inbound" 07:34:58 INFO - } 07:34:58 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:34:58 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 07:34:58 INFO - Running post-action listener: _resource_record_post_action 07:34:58 INFO - [mozharness: 2017-01-12 15:34:58.118847Z] Finished read-buildbot-config step (success) 07:34:58 INFO - [mozharness: 2017-01-12 15:34:58.118936Z] Running download-and-extract step. 07:34:58 INFO - Running pre-action listener: _resource_record_pre_action 07:34:58 INFO - Running main action method: download_and_extract 07:34:58 INFO - mkdir: /builds/slave/test/build/tests 07:34:58 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')]} 07:34:58 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:34:58 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/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 07:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/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 07:34:58 INFO - Downloaded 1361 bytes. 07:34:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:34:58 INFO - Using the following test package requirements: 07:34:58 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:58 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:34:58 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:34:58 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'jsshell-linux-x86_64.zip'], 07:34:58 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:34:58 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:58 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:34:58 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:34:58 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:34:58 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:58 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:34:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:34:58 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/1484228514/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:34:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:34:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:34:58 INFO - Expected file size: 21851200 07:34:58 INFO - Obtained file size: 21851200 07:35:02 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 07:35:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:35:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:35:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:35:02 INFO - Expected file size: 21851200 07:35:02 INFO - Obtained file size: 21851200 07:35:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:35:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:35:07 INFO - Expected file size: 14403532 07:35:07 INFO - Obtained file size: 14403532 07:35:07 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')]} 07:35:07 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:35:07 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/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 07:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/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 07:35:14 INFO - Downloaded 61593889 bytes. 07:35:14 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:35:14 INFO - mkdir: /builds/slave/test/properties 07:35:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:14 INFO - Contents: 07:35:14 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:35:15 INFO - Running post-action listener: _resource_record_post_action 07:35:15 INFO - Running post-action listener: set_extra_try_arguments 07:35:15 INFO - [mozharness: 2017-01-12 15:35:15.466514Z] Finished download-and-extract step (success) 07:35:15 INFO - [mozharness: 2017-01-12 15:35:15.466742Z] Running populate-webroot step. 07:35:15 INFO - Running pre-action listener: _resource_record_pre_action 07:35:15 INFO - Running main action method: populate_webroot 07:35:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:15 INFO - '--tppagecycles', 07:35:15 INFO - '7'], 07:35:15 INFO - 'tests': ['tsvgm']}}, 07:35:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['damp', 'tps']}, 07:35:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'tests': ['damp', 'tps']}, 07:35:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['dromaeo_dom']}, 07:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['basic_compositor_video']}, 07:35:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['a11yr', 07:35:15 INFO - 'ts_paint', 07:35:15 INFO - 'tpaint', 07:35:15 INFO - 'sessionrestore', 07:35:15 INFO - 'sessionrestore_no_auto_restore', 07:35:15 INFO - 'tabpaint']}, 07:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:15 INFO - 'ts_paint', 07:35:15 INFO - 'tpaint', 07:35:15 INFO - 'sessionrestore', 07:35:15 INFO - 'sessionrestore_no_auto_restore', 07:35:15 INFO - 'tabpaint']}, 07:35:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:15 INFO - 'ts_paint', 07:35:15 INFO - 'tpaint', 07:35:15 INFO - 'sessionrestore', 07:35:15 INFO - 'sessionrestore_no_auto_restore', 07:35:15 INFO - 'tabpaint']}, 07:35:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:15 INFO - 'ts_paint', 07:35:15 INFO - 'tpaint', 07:35:15 INFO - 'sessionrestore', 07:35:15 INFO - 'sessionrestore_no_auto_restore', 07:35:15 INFO - 'tabpaint']}, 07:35:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['a11yr', 07:35:15 INFO - 'ts_paint', 07:35:15 INFO - 'tpaint', 07:35:15 INFO - 'sessionrestore', 07:35:15 INFO - 'sessionrestore_no_auto_restore', 07:35:15 INFO - 'tabpaint']}, 07:35:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['a11yr', 07:35:15 INFO - 'ts_paint', 07:35:15 INFO - 'tpaint', 07:35:15 INFO - 'sessionrestore', 07:35:15 INFO - 'sessionrestore_no_auto_restore', 07:35:15 INFO - 'tabpaint']}, 07:35:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['tsvgx', 07:35:15 INFO - 'tsvgr_opacity', 07:35:15 INFO - 'tart', 07:35:15 INFO - 'tscrollx', 07:35:15 INFO - 'cart', 07:35:15 INFO - 'tsvg_static']}, 07:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:15 INFO - 'tsvgr_opacity', 07:35:15 INFO - 'tart', 07:35:15 INFO - 'tscrollx', 07:35:15 INFO - 'cart', 07:35:15 INFO - 'tsvg_static']}, 07:35:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'talos_options': ['--disable-e10s'], 07:35:15 INFO - 'tests': ['tp5o']}, 07:35:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:35:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'talos_options': ['--disable-e10s', 07:35:15 INFO - '--xperf_path', 07:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:15 INFO - 'tests': ['tp5n']}, 07:35:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:35:15 INFO - 'talos_options': ['--xperf_path', 07:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:15 INFO - 'tests': ['tp5n']}}, 07:35:15 INFO - 'talos.zip': {'path': '', 07:35:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:15 INFO - Running post-action listener: _resource_record_post_action 07:35:15 INFO - [mozharness: 2017-01-12 15:35:15.489133Z] Finished populate-webroot step (success) 07:35:15 INFO - [mozharness: 2017-01-12 15:35:15.489222Z] Running create-virtualenv step. 07:35:15 INFO - Running pre-action listener: _resource_record_pre_action 07:35:15 INFO - Running main action method: create_virtualenv 07:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35: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 07:35:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:15 INFO - Using real prefix '/usr' 07:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:18 INFO - Installing pip.................done. 07:35:18 INFO - Return code: 0 07:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:35:18 INFO - Reading from file tmpfile_stdout 07:35:18 INFO - Output received: 07:35: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) 07:35:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:18 INFO - Using env: {'DISPLAY': ':0', 07:35:18 INFO - 'HOME': '/home/cltbld', 07:35:18 INFO - 'LANG': 'en_US.UTF-8', 07:35:18 INFO - 'LANGUAGE': 'en_US:en', 07:35:18 INFO - 'LOGNAME': 'cltbld', 07:35:18 INFO - 'MAIL': '/var/mail/cltbld', 07:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:18 INFO - 'MOZ_NO_REMOTE': '1', 07:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:18 INFO - 'NO_EM_RESTART': '1', 07:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:18 INFO - 'PWD': '/builds/slave/test', 07:35:18 INFO - 'SHELL': '/bin/bash', 07:35:18 INFO - 'SHLVL': '1', 07:35:18 INFO - 'TERM': 'linux', 07:35:18 INFO - 'TMOUT': '86400', 07:35:18 INFO - 'USER': 'cltbld', 07:35:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:18 INFO - '_': '/tools/buildbot/bin/python'} 07:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35: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 07:35:18 INFO - Cleaning up... 07:35:18 INFO - Return code: 0 07:35:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:18 INFO - Using env: {'DISPLAY': ':0', 07:35:18 INFO - 'HOME': '/home/cltbld', 07:35:18 INFO - 'LANG': 'en_US.UTF-8', 07:35:18 INFO - 'LANGUAGE': 'en_US:en', 07:35:18 INFO - 'LOGNAME': 'cltbld', 07:35:18 INFO - 'MAIL': '/var/mail/cltbld', 07:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:18 INFO - 'MOZ_NO_REMOTE': '1', 07:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:18 INFO - 'NO_EM_RESTART': '1', 07:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:18 INFO - 'PWD': '/builds/slave/test', 07:35:18 INFO - 'SHELL': '/bin/bash', 07:35:18 INFO - 'SHLVL': '1', 07:35:18 INFO - 'TERM': 'linux', 07:35:18 INFO - 'TMOUT': '86400', 07:35:18 INFO - 'USER': 'cltbld', 07:35:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:18 INFO - '_': '/tools/buildbot/bin/python'} 07:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:18 INFO - Downloading/unpacking psutil>=3.1.1 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:20 INFO - Installing collected packages: psutil 07:35:20 INFO - Running setup.py install for psutil 07:35:20 INFO - building 'psutil._psutil_linux' extension 07:35:20 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 07:35: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 07:35:21 INFO - building 'psutil._psutil_posix' extension 07:35: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 07:35: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 07:35:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:21 INFO - Successfully installed psutil 07:35:21 INFO - Cleaning up... 07:35:21 INFO - Return code: 0 07:35:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:21 INFO - Using env: {'DISPLAY': ':0', 07:35:21 INFO - 'HOME': '/home/cltbld', 07:35:21 INFO - 'LANG': 'en_US.UTF-8', 07:35:21 INFO - 'LANGUAGE': 'en_US:en', 07:35:21 INFO - 'LOGNAME': 'cltbld', 07:35:21 INFO - 'MAIL': '/var/mail/cltbld', 07:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:21 INFO - 'MOZ_NO_REMOTE': '1', 07:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:21 INFO - 'NO_EM_RESTART': '1', 07:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:21 INFO - 'PWD': '/builds/slave/test', 07:35:21 INFO - 'SHELL': '/bin/bash', 07:35:21 INFO - 'SHLVL': '1', 07:35:21 INFO - 'TERM': 'linux', 07:35:21 INFO - 'TMOUT': '86400', 07:35:21 INFO - 'USER': 'cltbld', 07:35:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:21 INFO - '_': '/tools/buildbot/bin/python'} 07:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:23 INFO - Installing collected packages: mozsystemmonitor 07:35:23 INFO - Running setup.py install for mozsystemmonitor 07:35:23 INFO - Successfully installed mozsystemmonitor 07:35:23 INFO - Cleaning up... 07:35:23 INFO - Return code: 0 07:35:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:35:23 INFO - Using env: {'DISPLAY': ':0', 07:35:23 INFO - 'HOME': '/home/cltbld', 07:35:23 INFO - 'LANG': 'en_US.UTF-8', 07:35:23 INFO - 'LANGUAGE': 'en_US:en', 07:35:23 INFO - 'LOGNAME': 'cltbld', 07:35:23 INFO - 'MAIL': '/var/mail/cltbld', 07:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:23 INFO - 'MOZ_NO_REMOTE': '1', 07:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:23 INFO - 'NO_EM_RESTART': '1', 07:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:23 INFO - 'PWD': '/builds/slave/test', 07:35:23 INFO - 'SHELL': '/bin/bash', 07:35:23 INFO - 'SHLVL': '1', 07:35:23 INFO - 'TERM': 'linux', 07:35:23 INFO - 'TMOUT': '86400', 07:35:23 INFO - 'USER': 'cltbld', 07:35:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:23 INFO - '_': '/tools/buildbot/bin/python'} 07:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:24 INFO - Downloading/unpacking jsonschema==2.5.1 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:26 INFO - warning: no files found matching '*.txt' 07:35:26 INFO - no previously-included directories found matching 'build' 07:35:26 INFO - no previously-included directories found matching 'dist' 07:35:26 INFO - no previously-included directories found matching '.git*' 07:35:26 INFO - Installing collected packages: jsonschema, functools32 07:35:26 INFO - Running setup.py install for functools32 07:35:26 INFO - warning: no files found matching '*.txt' 07:35:26 INFO - no previously-included directories found matching 'build' 07:35:26 INFO - no previously-included directories found matching 'dist' 07:35:26 INFO - no previously-included directories found matching '.git*' 07:35:26 INFO - Successfully installed jsonschema functools32 07:35:26 INFO - Cleaning up... 07:35:26 INFO - Return code: 0 07:35:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:26 INFO - Using env: {'DISPLAY': ':0', 07:35:26 INFO - 'HOME': '/home/cltbld', 07:35:26 INFO - 'LANG': 'en_US.UTF-8', 07:35:26 INFO - 'LANGUAGE': 'en_US:en', 07:35:26 INFO - 'LOGNAME': 'cltbld', 07:35:26 INFO - 'MAIL': '/var/mail/cltbld', 07:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:26 INFO - 'MOZ_NO_REMOTE': '1', 07:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:26 INFO - 'NO_EM_RESTART': '1', 07:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:26 INFO - 'PWD': '/builds/slave/test', 07:35:26 INFO - 'SHELL': '/bin/bash', 07:35:26 INFO - 'SHLVL': '1', 07:35:26 INFO - 'TERM': 'linux', 07:35:26 INFO - 'TMOUT': '86400', 07:35:26 INFO - 'USER': 'cltbld', 07:35:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:26 INFO - '_': '/tools/buildbot/bin/python'} 07:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:26 INFO - Cleaning up... 07:35:26 INFO - Return code: 0 07:35:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:35:27 INFO - Using env: {'DISPLAY': ':0', 07:35:27 INFO - 'HOME': '/home/cltbld', 07:35:27 INFO - 'LANG': 'en_US.UTF-8', 07:35:27 INFO - 'LANGUAGE': 'en_US:en', 07:35:27 INFO - 'LOGNAME': 'cltbld', 07:35:27 INFO - 'MAIL': '/var/mail/cltbld', 07:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:27 INFO - 'MOZ_NO_REMOTE': '1', 07:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:27 INFO - 'NO_EM_RESTART': '1', 07:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:27 INFO - 'PWD': '/builds/slave/test', 07:35:27 INFO - 'SHELL': '/bin/bash', 07:35:27 INFO - 'SHLVL': '1', 07:35:27 INFO - 'TERM': 'linux', 07:35:27 INFO - 'TMOUT': '86400', 07:35:27 INFO - 'USER': 'cltbld', 07:35:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:27 INFO - '_': '/tools/buildbot/bin/python'} 07:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:29 INFO - Downloading docopt-0.6.1.tar.gz 07:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:30 INFO - Running setup.py install for blobuploader 07:35:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:30 INFO - Running setup.py install for requests 07:35:30 INFO - Running setup.py install for docopt 07:35:30 INFO - Successfully installed blobuploader requests docopt 07:35:30 INFO - Cleaning up... 07:35:30 INFO - Return code: 0 07:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:30 INFO - Using env: {'DISPLAY': ':0', 07:35:30 INFO - 'HOME': '/home/cltbld', 07:35:30 INFO - 'LANG': 'en_US.UTF-8', 07:35:30 INFO - 'LANGUAGE': 'en_US:en', 07:35:30 INFO - 'LOGNAME': 'cltbld', 07:35:30 INFO - 'MAIL': '/var/mail/cltbld', 07:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:30 INFO - 'MOZ_NO_REMOTE': '1', 07:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:30 INFO - 'NO_EM_RESTART': '1', 07:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:30 INFO - 'PWD': '/builds/slave/test', 07:35:30 INFO - 'SHELL': '/bin/bash', 07:35:30 INFO - 'SHLVL': '1', 07:35:30 INFO - 'TERM': 'linux', 07:35:30 INFO - 'TMOUT': '86400', 07:35:30 INFO - 'USER': 'cltbld', 07:35:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:30 INFO - '_': '/tools/buildbot/bin/python'} 07:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:30 INFO - Running setup.py (path:/tmp/pip-vr0fhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:30 INFO - Running setup.py (path:/tmp/pip-MvhLDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:31 INFO - Running setup.py (path:/tmp/pip-jF7_yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:31 INFO - Running setup.py (path:/tmp/pip-JUrJSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:31 INFO - Running setup.py (path:/tmp/pip-ILZUqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:31 INFO - Running setup.py (path:/tmp/pip-r7F4Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:31 INFO - Running setup.py (path:/tmp/pip-JXiYxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:31 INFO - Running setup.py (path:/tmp/pip-EAlRMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:31 INFO - Running setup.py (path:/tmp/pip-JLxlJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:31 INFO - Running setup.py (path:/tmp/pip-cBqkbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:31 INFO - Running setup.py (path:/tmp/pip-yB8HI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:31 INFO - Running setup.py (path:/tmp/pip-TvGodP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:31 INFO - Running setup.py (path:/tmp/pip-kTJqjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:31 INFO - Running setup.py (path:/tmp/pip-epsbcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:31 INFO - Running setup.py (path:/tmp/pip-izMyZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:31 INFO - Running setup.py (path:/tmp/pip-2WvYZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:32 INFO - Running setup.py (path:/tmp/pip-kKzBR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:32 INFO - Running setup.py install for manifestparser 07:35:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozcrash 07:35:32 INFO - Running setup.py install for mozdebug 07:35:32 INFO - Running setup.py install for mozdevice 07:35:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozfile 07:35:32 INFO - Running setup.py install for mozhttpd 07:35:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozinfo 07:35:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozInstall 07:35:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozleak 07:35:33 INFO - Running setup.py install for mozlog 07:35:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Running setup.py install for moznetwork 07:35:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Running setup.py install for mozprocess 07:35:33 INFO - Running setup.py install for mozprofile 07:35:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Running setup.py install for mozrunner 07:35:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Running setup.py install for mozscreenshot 07:35:33 INFO - Running setup.py install for moztest 07:35:33 INFO - Running setup.py install for mozversion 07:35:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:33 INFO - Cleaning up... 07:35:33 INFO - Return code: 0 07:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:33 INFO - Using env: {'DISPLAY': ':0', 07:35:33 INFO - 'HOME': '/home/cltbld', 07:35:33 INFO - 'LANG': 'en_US.UTF-8', 07:35:33 INFO - 'LANGUAGE': 'en_US:en', 07:35:33 INFO - 'LOGNAME': 'cltbld', 07:35:33 INFO - 'MAIL': '/var/mail/cltbld', 07:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:33 INFO - 'MOZ_NO_REMOTE': '1', 07:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:33 INFO - 'NO_EM_RESTART': '1', 07:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:33 INFO - 'PWD': '/builds/slave/test', 07:35:33 INFO - 'SHELL': '/bin/bash', 07:35:33 INFO - 'SHLVL': '1', 07:35:33 INFO - 'TERM': 'linux', 07:35:33 INFO - 'TMOUT': '86400', 07:35:33 INFO - 'USER': 'cltbld', 07:35:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:33 INFO - '_': '/tools/buildbot/bin/python'} 07:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:34 INFO - Running setup.py (path:/tmp/pip-lZNtQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:34 INFO - Running setup.py (path:/tmp/pip-CG_VD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:34 INFO - Running setup.py (path:/tmp/pip-vkKfC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:34 INFO - Running setup.py (path:/tmp/pip-_w5WXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:34 INFO - Running setup.py (path:/tmp/pip-mHRaau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:34 INFO - Running setup.py (path:/tmp/pip-8on0z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:34 INFO - Running setup.py (path:/tmp/pip-o6dGLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:34 INFO - Running setup.py (path:/tmp/pip-9HIcpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:34 INFO - Running setup.py (path:/tmp/pip-rzgpBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:34 INFO - Running setup.py (path:/tmp/pip-7o8356-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:34 INFO - Running setup.py (path:/tmp/pip-qVVlHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35: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)) 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:34 INFO - Running setup.py (path:/tmp/pip-tlWEQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:35 INFO - Running setup.py (path:/tmp/pip-lTavIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35: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)) 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:35 INFO - Running setup.py (path:/tmp/pip-ZEJn4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35: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)) 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:35 INFO - Running setup.py (path:/tmp/pip-7kntah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35: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)) 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:35 INFO - Running setup.py (path:/tmp/pip-xozE9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:35 INFO - Running setup.py (path:/tmp/pip-tgQStd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:37 INFO - Downloading blessings-1.6.tar.gz 07:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:37 INFO - Installing collected packages: blessings 07:35:37 INFO - Running setup.py install for blessings 07:35:37 INFO - Successfully installed blessings 07:35:37 INFO - Cleaning up... 07:35:37 INFO - Return code: 0 07:35:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:37 INFO - Reading from file tmpfile_stdout 07:35:37 INFO - Current package versions: 07:35:37 INFO - argparse == 1.2.1 07:35:37 INFO - blessings == 1.6 07:35:37 INFO - blobuploader == 1.2.4 07:35:37 INFO - docopt == 0.6.1 07:35:37 INFO - functools32 == 3.2.3-2 07:35:37 INFO - jsonschema == 2.5.1 07:35:37 INFO - manifestparser == 1.1 07:35:37 INFO - mozInstall == 1.12 07:35:37 INFO - mozcrash == 1.0 07:35:37 INFO - mozdebug == 0.1 07:35:37 INFO - mozdevice == 0.49 07:35:37 INFO - mozfile == 1.2 07:35:37 INFO - mozhttpd == 0.7 07:35:37 INFO - mozinfo == 0.9 07:35:37 INFO - mozleak == 0.1 07:35:37 INFO - mozlog == 3.4 07:35:37 INFO - moznetwork == 0.27 07:35:37 INFO - mozprocess == 0.24 07:35:37 INFO - mozprofile == 0.28 07:35:37 INFO - mozrunner == 6.13 07:35:37 INFO - mozscreenshot == 0.1 07:35:37 INFO - mozsystemmonitor == 0.3 07:35:37 INFO - moztest == 0.8 07:35:37 INFO - mozversion == 1.4 07:35:37 INFO - psutil == 3.1.1 07:35:37 INFO - requests == 1.2.3 07:35:37 INFO - wsgiref == 0.1.2 07:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:37 INFO - Using env: {'DISPLAY': ':0', 07:35:37 INFO - 'HOME': '/home/cltbld', 07:35:37 INFO - 'LANG': 'en_US.UTF-8', 07:35:37 INFO - 'LANGUAGE': 'en_US:en', 07:35:37 INFO - 'LOGNAME': 'cltbld', 07:35:37 INFO - 'MAIL': '/var/mail/cltbld', 07:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:37 INFO - 'MOZ_NO_REMOTE': '1', 07:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:37 INFO - 'NO_EM_RESTART': '1', 07:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:37 INFO - 'PWD': '/builds/slave/test', 07:35:37 INFO - 'SHELL': '/bin/bash', 07:35:37 INFO - 'SHLVL': '1', 07:35:37 INFO - 'TERM': 'linux', 07:35:37 INFO - 'TMOUT': '86400', 07:35:37 INFO - 'USER': 'cltbld', 07:35:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:37 INFO - '_': '/tools/buildbot/bin/python'} 07:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35: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)) 07:35:38 INFO - Cleaning up... 07:35:38 INFO - Return code: 0 07:35:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x14241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1535a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1796480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', '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 07:35: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 07:35: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 07:35:38 INFO - Using env: {'DISPLAY': ':0', 07:35:38 INFO - 'HOME': '/home/cltbld', 07:35:38 INFO - 'LANG': 'en_US.UTF-8', 07:35:38 INFO - 'LANGUAGE': 'en_US:en', 07:35:38 INFO - 'LOGNAME': 'cltbld', 07:35:38 INFO - 'MAIL': '/var/mail/cltbld', 07:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:38 INFO - 'MOZ_NO_REMOTE': '1', 07:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:38 INFO - 'NO_EM_RESTART': '1', 07:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:38 INFO - 'PWD': '/builds/slave/test', 07:35:38 INFO - 'SHELL': '/bin/bash', 07:35:38 INFO - 'SHLVL': '1', 07:35:38 INFO - 'TERM': 'linux', 07:35:38 INFO - 'TMOUT': '86400', 07:35:38 INFO - 'USER': 'cltbld', 07:35:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:38 INFO - '_': '/tools/buildbot/bin/python'} 07:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:38 INFO - Cleaning up... 07:35:38 INFO - Return code: 0 07:35:38 INFO - Running post-action listener: _resource_record_post_action 07:35:38 INFO - Running post-action listener: _start_resource_monitoring 07:35:38 INFO - Starting resource monitoring. 07:35:38 INFO - [mozharness: 2017-01-12 15:35:38.348901Z] Finished create-virtualenv step (success) 07:35:38 INFO - [mozharness: 2017-01-12 15:35:38.349362Z] Running install step. 07:35:38 INFO - Running pre-action listener: _resource_record_pre_action 07:35:38 INFO - Running main action method: install 07:35:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:38 INFO - Reading from file tmpfile_stdout 07:35:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:38 INFO - Reading from file tmpfile_stdout 07:35:38 INFO - Output received: 07:35:38 INFO - Usage: mozinstall [options] installer 07:35:38 INFO - Options: 07:35:38 INFO - -h, --help show this help message and exit 07:35:38 INFO - -d DEST, --destination=DEST 07:35:38 INFO - Directory to install application into. [default: 07:35:38 INFO - "/builds/slave/test"] 07:35:38 INFO - --app=APP Application being installed. [default: firefox] 07:35:38 INFO - mkdir: /builds/slave/test/build/application 07:35: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'] 07:35: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 07:35:56 INFO - Reading from file tmpfile_stdout 07:35:56 INFO - Output received: 07:35:56 INFO - /builds/slave/test/build/application/firefox/firefox 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - [mozharness: 2017-01-12 15:35:56.066932Z] Finished install step (success) 07:35:56 INFO - [mozharness: 2017-01-12 15:35:56.067209Z] Running run-tests step. 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: run_tests 07:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:56 INFO - Python 2.7.3 07:35:56 INFO - Return code: 0 07:35:56 INFO - grabbing minidump binary from tooltool 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793820>, '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 0x1794520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17949b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:35:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:35:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:35:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:56 INFO - Return code: 0 07:35:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:35:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:35:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35: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/1484228514/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:35: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/1484228514/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 07:35:56 INFO - Using env: {'DISPLAY': ':0', 07:35:56 INFO - 'HOME': '/home/cltbld', 07:35:56 INFO - 'LANG': 'en_US.UTF-8', 07:35:56 INFO - 'LANGUAGE': 'en_US:en', 07:35:56 INFO - 'LOGNAME': 'cltbld', 07:35:56 INFO - 'MAIL': '/var/mail/cltbld', 07:35:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:56 INFO - 'MOZ_NO_REMOTE': '1', 07:35:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:56 INFO - 'NO_EM_RESTART': '1', 07:35:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:56 INFO - 'PWD': '/builds/slave/test', 07:35:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:56 INFO - 'SHELL': '/bin/bash', 07:35:56 INFO - 'SHLVL': '1', 07:35:56 INFO - 'TERM': 'linux', 07:35:56 INFO - 'TMOUT': '86400', 07:35:56 INFO - 'USER': 'cltbld', 07:35:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772', 07:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:56 INFO - '_': '/tools/buildbot/bin/python'} 07:35: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/1484228514/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:35:56 INFO - mozversion application_buildid: 20170112054154 07:35:56 INFO - mozversion application_changeset: ba83951bf8aaff2805f8de3cea8ada4fbb16b527 07:35:56 INFO - mozversion application_display_name: Nightly 07:35:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:56 INFO - mozversion application_name: Firefox 07:35:56 INFO - mozversion application_remotingname: firefox 07:35:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:35:56 INFO - mozversion application_vendor: Mozilla 07:35:56 INFO - mozversion application_version: 53.0a1 07:35:56 INFO - mozversion platform_buildid: 20170112054154 07:35:56 INFO - mozversion platform_changeset: ba83951bf8aaff2805f8de3cea8ada4fbb16b527 07:35:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:35:56 INFO - mozversion platform_version: 53.0a1 07:35:56 INFO - using testdate: 1484235356 07:35:56 INFO - actual date: 1484235356 07:35:56 INFO - starting webserver on 'localhost:37027' 07:35:56 INFO - SUITE-START | Running 2 tests 07:35:56 INFO - TEST-START | dromaeo_css 07:35:56 INFO - operating with platform_type : linux_ 07:35:56 INFO - Initialising browser for dromaeo_css test... 07:35:56 INFO - TEST-INFO | started process 24666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpseK3Jq/profile http://localhost:37027/getInfo.html) 07:36:00 INFO - PROCESS | 24666 | __metrics Screen width/height:1600/1200 07:36:00 INFO - PROCESS | 24666 | colorDepth:24 07:36:00 INFO - PROCESS | 24666 | Browser inner width/height: 1024/697 07:36:00 INFO - PROCESS | 24666 | __metrics 07:36:00 ERROR - PROCESS | 24666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 07:36:01 INFO - TEST-INFO | 24666: exit 0 07:36:01 INFO - Browser initialized. 07:36:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:01 INFO - TEST-INFO | started process 24787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpseK3Jq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:13 INFO - PROCESS | 24787 | RSS: Main: 155578368 07:36:13 INFO - PROCESS | 24787 | 07:39:13 INFO - PROCESS | 24787 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37027/tests/dromaeo/cssquery-ext.html) 07:39:15 INFO - PROCESS | 24787 | RSS: Main: 163627008 07:39:15 INFO - PROCESS | 24787 | 07:41:02 INFO - PROCESS | 24787 | ************************* 07:41:02 INFO - PROCESS | 24787 | A coding exception was thrown and uncaught in a Task. 07:41:02 INFO - PROCESS | 24787 | 07:41:02 INFO - PROCESS | 24787 | Full message: ReferenceError: fetch is not defined 07:41:02 INFO - PROCESS | 24787 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:41:02 INFO - PROCESS | 24787 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:41:02 INFO - PROCESS | 24787 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:41:02 INFO - PROCESS | 24787 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:41:02 INFO - PROCESS | 24787 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:41:02 INFO - PROCESS | 24787 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:41:02 INFO - PROCESS | 24787 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:41:02 INFO - PROCESS | 24787 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:41:02 INFO - PROCESS | 24787 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:41:02 INFO - PROCESS | 24787 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:41:02 INFO - PROCESS | 24787 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:41:02 INFO - PROCESS | 24787 | 07:41:02 INFO - PROCESS | 24787 | ************************* 07:42:17 INFO - PROCESS | 24787 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-ext.html (next: http://localhost:37027/tests/dromaeo/cssquery-jquery.html) 07:42:18 INFO - PROCESS | 24787 | RSS: Main: 160358400 07:42:18 INFO - PROCESS | 24787 | 07:45:19 INFO - PROCESS | 24787 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37027/tests/dromaeo/cssquery-mootools.html) 07:45:20 INFO - PROCESS | 24787 | RSS: Main: 166084608 07:45:20 INFO - PROCESS | 24787 | 07:48:22 INFO - PROCESS | 24787 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37027/tests/dromaeo/cssquery-prototype.html) 07:48:22 INFO - PROCESS | 24787 | RSS: Main: 161337344 07:48:22 INFO - PROCESS | 24787 | 07:51:25 INFO - PROCESS | 24787 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37027/tests/dromaeo/cssquery-yui.html) 07:51:26 INFO - PROCESS | 24787 | RSS: Main: 165314560 07:51:26 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-yui.html (next: http://localhost:37027/tests/dromaeo/cssquery-dojo.html) 07:54:28 INFO - PROCESS | 24787 | RSS: Main: 164630528 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | __start_tp_report 07:54:28 INFO - PROCESS | 24787 | _x_x_mozilla_page_load 07:54:28 INFO - PROCESS | 24787 | _x_x_mozilla_page_load_details 07:54:28 INFO - PROCESS | 24787 | |i|pagename|runs| 07:54:28 INFO - PROCESS | 24787 | |0;dojo.html;3220.146661134799;3242.7892187007856;3252.577164968553;3259.054874086515;3263.592050993626;5340.572754179666;5435.673859568424;5454.563634909207;5489.121740521512;5518.641288316257;5384.6499977501435;5414.214938833867;5456.181572764087;5534.501894829465;5535.723213839312;4706.74112923789;4940.629452791055;4978.103941290576;5028.572571331441;5170.715610641413;5092;5123.359580052494;5126.154184559562;5131.512506311894;5181.378234611851;4894.632902532288;4939.5554400104165;5101.51535604117;5132.40977287613;5145.382554093514;4918.434380046305;4941.678790878582;5006.974965125188;5031.421386540558;5082.390113186404;4941.110600091982;4947.703137811707;4949.208126699711;4955.851324460272;4973.179425394842;5351.063563876306;5360.490753378423;5437.102878025121;5444.101723215665;5449.891002179934;5746.339170995348;5768;5828.271466066742;5830.970845145789;5927.3776253493625;5905.970470147622;5913.46778789911;5915.349311575723;5916.142159386908;5917.993941030035;5536.197251398525;5539.584531160179;5541.473560011793;5542.501174894239;5542.722863856831;5795.333536643256;5857.58996870215;5912.024515954905;5931.673757943355;5980.312264089598;5748.425157484302;5752.798652047159;5785.27684039495;5803.622764520293;5844.853878653068;5738.713064346849;5805.216295800097;5849.151872978479;5873.911891321633;5898.351181370046;5772.884542309131;5807.854803629859;5865.736041878125;5870.765169393262;5994.670293133832;5928.436798504135;5931.762729490858;5932.911006334908;5933.288005439289;5933.554983376264;4619.3994780678295;4623.606993405599;4634.629229661619;4640.141573808856;4681.859544213679;3984.86052988144;4009.659178969762;4028.295048366524;4053.047533829548;4083.816228269735;5545.584081193927;5554.611177217556;5567.4432556744005;5571.164325351229;5614.2701448811395;5807.216025836543;5827.825165245049;5869.236999190078;5882.735276912549;5894.115882617642;5371.758270877742;5471.179323101566;5478.890422191534;5526.751296191601;5541.725403157297;5046.823361182341;5056.367954005749;5057.443681195065;5084.593232541388;5108.846734597893;6119;6150.323464418911;6173.506119510428;6173.536984726164;6177.413145751147;5807.796727114531;5819.883602328015;5858.2677165354335;5912.172295878494;5918.082697181943;6053.4551890330085;6125.203723515914;6131.437835141539;6155.569110162246;6155.907661385172;5734;5777.133429985536;5795.652260864362;5816.73824677882;5826.766929322949;5742.655440673573;5790.247267855152;5834.795782147605;5906.793262235973;5918.852028699317;5663.886722265449;5692.544596432358;5699.373068962494;5734.655920644775;5804.245448091721;5716.199732037435;5721.399253078367;5723.399043100581;5734.713264336683;5734.827955161351;5457.426970168234;5542.584306176972;5550.47270509301;5729.1119876419225;5735.7418916148035;5728.570357223141;5750.079987202028;5777.826665200051;5801;5827.76688932438;5595.972020139873;5621.325440947113;5627.409122042291;5632.690202038763;5633.577481688808 07:54:28 INFO - PROCESS | 24787 | |1;ext.html;555.2587295959893;584.5703407995123;585.0259318235138;611.461913516106;625.412112614143;40344.39483407747;46064.539354606444;46268.07463850721;46332.76833615831;46345.536544634546;46149.76925115378;46741.597752067406;46784.53215467844;46895.062098758004;46993;8852.999999999984;9022.593983270735;9045.864312035292;10205.693829185098;10565.735856603607;10230.43732594707;10332.276740628158;10359.067683908446;10376;10395.532201050972;10326.43204623749;10355.689329320096;10376.377417354945;10412.895871041268;10426.635067772591;10289.3311934724;10313.174946004301;10363.740906477324;10381.688549343531;10409.583616655362;10100.747481312952;10110.545025473872;10172.491375431198;10181.28730988831;10197.541110650038;39805.80097099496;39845.80077099596;39970.60029399698;40152.39771403431;40185;4179.97910010448;4249;4271.8718438446895;4282.614564689162;4438.866833994953;30025.699743002726;30040.8497957511;30117.69882301171;30185.547216791765;30191.69808301911;4288.485381754178;4488.147252022105;4567.474740404863;4643.210654188796;4666.556677115668;318158;320020;321310;321334;321921;55187.44812551823;55550.16723244082;55634.72182639142;55641.72179139078;55702.72148639231;57431;57574.42425575691;57592.42407575955;57600.71199644059;57862.4213757857;15633;15807.525774226791;15814.68370632581;15870.429153440384;15938.760918586231;11277.266977646426;11508.712282193012;12070.396480175956;12221.633350999306;12261.264324140402;17947.282108715506;17972;18029.27882884696;18118.909405452887;18156.273749050153;7157.24848890859;7210.603416812126;7217.566945983258;7247.855042899112;7330.753771858796;928.215657769184;945.9783433891381;953.6662168241198;969.6993931880999;974.6247694637616;30705.232369190504;30726.69273307283;31521.36957260842;31889.521657175163;32149.839250804063;1090.4983707494482;1144.9084073274119;1146.3351256271342;1171.5840876488894;1186.1993154620598;16131.838681613268;16664.33342666304;16980.40568580094;17254.396096136574;17353;444380;447484;448724;448728;451109;64290.35709642844;65131.34868651348;65132.348676513575;65483;65553.67223163949;1484.2578710644677;1493.9253037348305;1499.4002399040253;1516.5601975427003;1521.9467318643794;31104.68895311018;31677;31857.8407107963;31940.840295799302;32878.83560582182;55417;55621;56112.719436402556;56173.15740263981;56574.43425565692;368210;368807;369199;370105;370660;25964.975428808564;26817.329566760985;26981.460370792865;28169.15492535227;28725.56911646285;43910.34134488049;44046.77976610096;44203;44876.10247795091;45545.772271138434;36283.74012029711;37202.25595488129;37884.86345409642;38111.61888381192;39136.80431597824;36918.44622330721;37048.25903481969;37268.813655931546;37342.2531549362;37373;37300.81349593234;37781.43327850029;37876.81061594674;38450;38497.2300553993;31872.840635796674;33872.32255354928;34196.48705269473;34241;34420.48369274513;26014.86992565025;26028;26214.213573592824;26336.34159146037;26499.337516562242 07:54:28 INFO - PROCESS | 24787 | |2;jquery.html;423.8961454443662;427.38141857755477;433.4971433137561;433.56859924375243;447.4183561370218;20619.587608247824;20799.376018719442;21482.89258553705;21514.462138446546;21607.56784864302;20360.389188324338;20716.689249661267;20744.792552074476;20761;20945.790542094575;5706.572007099474;5953.940460595403;5955.583109182359;5956.404359564052;5966.701664916758;5670.262865827437;5791.478766910977;5863.179154918314;5865.384134665863;5896.498797602188;5785.334686511063;5804;5831.766729330821;5845.8830823383505;5872.9706351468185;5722.570807189478;5805.216295800076;5876.588638795265;5901.114832775075;5910.202122713422;5228.607854410896;5277.155655095166;5282.2340760589495;5321.361436627591;5322.973385133088;24813.131540396;25211.369715757068;25242.368940776443;25506;25637.48725025489;3147.8497955136945;3157.1160075178987;3178.9205269868207;3227.693369129929;3248.7888287261253;15443.679608884144;15455.690886182214;15774.763378549216;16216.270267837976;16462.42381516653;1977.4561995451222;1987.3044434447827;1998.8500862435376;2004.5690176611952;2016.6773316269328;86923;88701.55649221777;88913.55543222242;89173;90012.54993724989;11486.138539609396;11531.365774882293;11644.70888227784;11731.706707332214;12033;16094;16137.919310403608;16190.838091619169;16204.189790510427;16261.349546018027;8360.665573377119;8671;8691.261242794308;8699.086595907338;8795.560221989002;8162.551059691774;8203.8359232815;8399.706010289732;8435.95782021086;8459.280961118251;7347.5224110432655;7363.15323737777;7425.888611670829;7435.51669141504;7452.813679657944;2013.9295124670566;2080.1055546115012;2080.6774949882792;2088.363049269987;2098.0768461876723;924.3021518753433;935.7988032573029;939.727479031087;940.3135710930922;943.6178347769164;19355.80644193568;19948.50128746764;22251.887405629655;22365.32904012882;22474;994.1847684898459;1013;1013.1742629756725;1042.629866397418;1052.084686322904;10551.366917984946;10990.835137472945;11032.669019929415;11071.114310855111;11110.61112861046;627317;634274;638963;641469;654542;86290.84272893227;99837.50081249693;100805;112467;119814;1148.9655310340704;1153.763478486908;1183.230899915062;1194.1581185264367;1203.2780331801025;18164.90917545404;18550.44348669542;18573.164207610418;18608.627827443644;18889.622207556047;44588.777056114515;45645.771771140935;45768.54231457776;45973.54026459692;46862.531374685816;57770;61775.69112154411;65240.67379663071;65952.67023664851;66723;6364.204474440695;9033;9097.81728375307;9359.953200233955;9507.524623768646;9143.63425462974;12340.580833203938;13142.868571314164;14398.499802999346;14573.344199511259;11459.770804584028;12334.259944403364;12626;13068.607941761762;13281.867181328449;12374.62876113718;12490.751664700441;12554.372281386077;12659.430325635552;13128.212307261594;12762.106652534234;12919.354032298535;13001.95984321271;13311.80032299497;13575.79636305476;8062;8197.303229225345;9073.954630226806;9102.817943640957;9126.406783559047;12484.812727808909;12511.311877846805;12579.182353147016;12644.747105058032;12792.296423696785 07:54:28 INFO - PROCESS | 24787 | |3;mootools.html;1487.9776803347945;1509.9924500377497;1515.265096428232;1515.54533639908;1522.1323845408115;7938.960305198466;8218.91781082189;8396.790080247989;8807.383483156182;8847.823043539125;8452;8685.696000639979;8686.522241276727;8837.293016558677;8861.556922153883;2326.68589740385;2341.1337805012167;2374.5844477216506;2376.049580167938;2381.714194296678;2310.4685922237895;2320.872352020638;2344.37873963399;2352.517733864562;2355.9057637694473;2312.0289478419104;2314.3982564533258;2333.0667732906804;2335.2177020698086;2349.283468542094;2233.2630232023557;2264.1622599638076;2279.2364557873134;2290.874001929885;2297.173017713622;2276.5674521840965;2286.451251699597;2290.713660792401;2306.1813056364917;2307.042577330406;8401.159884011611;8489.533075680834;8494.023187333474;8514;8605.569721513963;5157.535821776059;5283;5284;5284.5243928046275;5289.259503669489;3141.921451963696;3193.0899693587216;3348.1462227131924;3412.2493051528872;3419.076849250688;1330.7671157547488;1336.245021562814;1340.8390993080893;1395.4906459142442;1400.0479673821796;12005.879941200563;12025.218360806519;12060.396980150957;12067.577634782829;12129.636110916686;4406.537313582092;4625.918336748477;4677.695949763254;4690.296455531629;4729.125111854318;10271.281010329205;10285.588576456857;10322.535485903152;10342.27604067723;10361.119304859021;5332.200169974457;5339.038972984822;5341.225522299323;5348.786048558092;5359.517643412111;4255.595718406808;4256.9996050928;4758.928616070762;4783.6651434399255;4794.4486384065585;3788;3863.30460517104;3870.283997460479;3930.449737036817;3952.8616498422416;1284.5825106840127;1298.0459362368651;1304.1979182802509;1311.5934060441293;1320.4454129265732;1003.6336737090909;1013.4426065663855;1019.7348689340677;1028.93311934724;1041.1774697988503;5749.137629355547;5771.971140144273;5775.16260142277;5812.186293918855;5828.213191219216;1032.4785983078498;1046.5238316565944;1081.534939975818;1082.2748758331936;1095.638439315024;3644.3804553226014;3849.9615003849603;3873.535175778868;3880.592537783492;4101.384792281182;10479.580816767397;10716.78566428667;10774.030337269684;10786.730331741612;10790.67627971162;10536.209784266211;10637.787244255072;10670.093042091354;10672.252942293964;10675.626353077605;8019.639116239667;8206.384521160937;8350.373721970755;8356.623951922056;8412.579371031425;5512.91730624049;5549.694766787866;5652.123920792284;5752.252207213203;5757.971210143923;9519.762005949906;9587.808243835223;9607;9676.452666593446;9722.75693107678;9539.666111686058;9676.564554595201;9681.612735490784;9687.51562421862;9905.257105716955;7189.065421495172;7262.745803896838;7287.453440991841;7506.887396688945;7557.05536807899;8503.277221436247;8563.61463734121;8565.100664430145;8586.65653373858;8592.140785921609;7483.363914067365;7621;7645.350145237717;7652.273034061978;7900.2889739923685;7433;7482.476226664299;7503.399728021855;7512.849743005;7561.432892532972;6345.428911397997;6396.232452105777;6426.935730642634;6435.742570297136;6450.064740612679;4956.454789973028;4958.504149585013;5010.423801262901;5018.648694591344;5199;4863.2461968394955;4890.24201248807;4932.2601609757385;4950.45544990058;4960.7767650456535 07:54:28 INFO - PROCESS | 24787 | |4;prototype.html;376.64783427495274;394.22337994151513;395.6261333040278;407.329942245007;408.2060392536516;5268.868278293045;5377.731113444327;5493.148561972896;5511.889762204759;5549.722513874301;5330.973345133269;5370.382406023308;5406.297181366417;5434.402215756273;5440.510354068133;4260.829566817323;4262.808173632178;4279.801655536455;4286.82852685893;4309.4397728295435;4012.8996775080564;4243.236217480852;4245.511766146902;4260.1266740318315;4262.78686065697;4217.557156498554;4229.429027081335;4245.341971994346;4258.808353624095;4274.187904298174;4255.255330317197;4271.402003719466;4275.893102672427;4277.679174061957;4346.891972239832;3578.874739384135;3812.2756676231706;3815.103450689086;3826.559945606263;3828.2152158807376;5230.686158830483;5249.1627930224495;5250.212468129773;5252.501012403815;5254.947450525522;4863.24619683946;4868.78090485929;4879.512048795127;4887.437944636376;4896.36347274852;5518.696471694056;5650.63270887391;5727.627704199213;5728.22668939692;5765.971170144165;4116.814743336557;4117.258893399187;4121.690873184493;4140.8136633851545;4143.948745371031;5938.435848594377;5944.464998150187;5953.404659534012;5968.0465213872385;5990.580659353847;4093.8157782899243;4202.495700515958;4218.198542276958;4254.319308910622;4258.318669012943;4232.280512312914;4276.31578947367;4278.7860606969525;4279.293916503742;4288.2281189385585;4832.4684284728655;4873.244647079709;4884.3650325458175;4892.486288939681;4895.583875370562;5657.302809157236;5774.769009239667;5780.364159942403;5781.248437703071;5794.101914203306;1425.736238795826;1431.205680847119;1433.5054406229833;1435.404307212495;1448.1311213271952;946.1910066892708;984.07988530724;985.5072463768116;1004.1013293102632;1006.3609607899036;5185.351831021122;5239.711815850089;5248.6588371755715;5256.869772998747;5277.736113194325;5611.663300202001;5641.717914104278;5670.206171136044;5724.742386592613;5735.1970724098655;4984.22744474607;5220.660657057279;5256.948610277883;5290.1800220965815;5294.444083371268;2996.3557835065567;3011.4428830666398;3015.577819105327;3017.3814368054495;3019.698030196963;5742.885142297131;5889.558283128783;5892.469677729025;5902.4097590240635;5932.7330270137945;5619.971900140473;5899.528037756969;5906.49794767441;5948.672822994777;5976.103584462278;6095.6952152392205;6113.20528331323;6136.631802091889;6166.660833654102;6172.753089876354;5627.409122042291;5783.710814459344;5843.970780146072;5868.882622347443;5884.852878677896;5826.912596310974;5834;5855.03391940325;5882.970585147047;5891.204687367322;5773.884522309614;6110.327863934875;6161.272430179677;6187.381261873777;6213.782517611862;4092.2224777292217;4123.237201117803;4206.894827629334;4240.872773816791;4241.236577415972;5870.677112758839;5877.500412464989;5900.527957763283;5909.734061967308;5913.940860591339;5573.832785016456;5718.428157184248;5736.110902810071;5741.913871292018;5812.389699081536;5641.830745077655;5673.886522269614;5681.659100453986;5697.487226149667;5715.342735585461;5657.482420322916;5683.2895888014;5694.743736531949;5702.287214098238;5702.429757024264;5547.667139971614;5688.488036076773;5716.942830571641;5750.166225897138;5759;5520.420355862577;5546.668799488174;5550.5282051026115;5550.833474995757;5587.357453892691 07:54:28 INFO - PROCESS | 24787 | |5;yui.html;773.369703691491;801.9037715474144;814.157347145704;853.9274161696256;872.9083446238145;14958.850411495881;16407.917960410196;16549.91725041373;16697.749533757004;16875.578110547227;14354.066985645926;14454.494092706758;14516.637084072903;14530.055546389478;15150;644.8678021005707;759.8860170974343;772.9265719756643;778.0313509680456;779.4855395439012;670.7819958513503;738.8522295540887;763.0576238345667;771.7568965775763;771.9575423351713;790.9683612655487;794.9960250198741;795.6857041468617;797.8962734844491;799.1289494451047;792.3265224559136;795.145218889693;795.7334293011847;796.1242633103598;797.4099166616662;575.4159528079003;576.6712973605047;577.3822010448821;578.5082679722244;579.681175353558;15023.173725445096;15079;15893.92053039739;15967.361305547764;16011.27949242287;14248.928755356157;15416.152111633855;15700.921495392564;15714.842851571453;15940.840591594168;12099.092568057344;12253.816192757116;12327.753444931051;12354.876451235463;12365.567205147776;3727.1800203955086;3760.5863355031197;3826.1773718650625;3848.9230215395537;3855.9614403856162;71046.64476677636;72203.63898180528;73027.26972730258;74513.25486745118;75670;11044.613438529614;11221.71945701364;11313.886861131283;11471.197016208953;11714.88285117155;21711.782882170977;21883.781162188494;21896.781032189792;21925.780742192375;21980.120795168015;8118.553479558681;8184.427090103754;8205.466644668197;8399.454035487674;8479.236868681724;4523.276275795857;4658.790354434059;4670.972386075058;4688.8124475021295;4711.340412342275;3677.5035370225214;3772.8681395581766;3803.581606023335;3849.2109117630816;3854.5567259764925;663.2969052804043;672.8418821576926;675.6824292582478;688.7176257734405;690.6857379892137;721.3337191088602;723.1358526560709;723.6345645449014;737.8673735815497;750.91364493084;9660.855087173699;10002.149817265614;10213.948930255301;10396.324238924446;10558.52486638103;685.746273878668;721.6325064003684;727.425333986145;742.3764038207931;788.9585449859977;4741.857744267678;5012.824551140692;5043.3443652325695;5060.924086138711;5071.721055341992;76751.61624191955;77163;77204.22795772082;78877;80227.19772802314;55130;59968;67292.663536682;68191;68541;60467;60817.39182608117;60861;61327;61392.38607613867;9236.907630923604;9514.952425237829;9540.761480962754;9588.289842355736;9642.566084526354;41416.37875431931;41640;42418.78790606027;42692.78653606712;42921.570784291755;50633;50989;51278;52039.73980130227;53675;11022.559097636005;11030.834537481784;11054;11063;11324.490397931948;12308.938455307667;12327.630171094881;12441.191322564004;12575.182613130117;12642;11957.282563046245;12023.158378913393;12160.817587736368;12162.513499459923;12454.626361209179;11231.55073797039;11357.772844542898;11482.770344592895;11673.182877198855;12237.143399961917;11821.586244481747;12160.939195303967;12297.56958506448;12356.752864942831;12357.25856448616;8855.424397414148;8949.910500894908;9061.184493395625;9159.404638698463;9273.489958052372;8883.244924181517;8902.777430564287;8928.285737140883;8937.821243575223;8962.058983806606 07:54:28 INFO - PROCESS | 24787 | __end_tp_report 07:54:28 INFO - PROCESS | 24787 | __start_cc_report 07:54:28 INFO - PROCESS | 24787 | _x_x_mozilla_cycle_collect,322 07:54:28 INFO - PROCESS | 24787 | __end_cc_report 07:54:28 INFO - PROCESS | 24787 | __startTimestamp1484236468832__endTimestamp 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | ------- Summary: start ------- 07:54:28 INFO - PROCESS | 24787 | Number of tests: 6 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | [#0] dojo.html Cycles:165 Average:5457.92 Median:5633.58 stddev:600.32 (10.7%) stddev-sans-first:575.92 07:54:28 INFO - PROCESS | 24787 | Values: 3220.1 3242.8 3252.6 3259.1 3263.6 5340.6 5435.7 5454.6 5489.1 5518.6 5384.6 5414.2 5456.2 5534.5 5535.7 4706.7 4940.6 4978.1 5028.6 5170.7 5092.0 5123.4 5126.2 5131.5 5181.4 4894.6 4939.6 5101.5 5132.4 5145.4 4918.4 4941.7 5007.0 5031.4 5082.4 4941.1 4947.7 4949.2 4955.9 4973.2 5351.1 5360.5 5437.1 5444.1 5449.9 5746.3 5768.0 5828.3 5831.0 5927.4 5906.0 5913.5 5915.3 5916.1 5918.0 5536.2 5539.6 5541.5 5542.5 5542.7 5795.3 5857.6 5912.0 5931.7 5980.3 5748.4 5752.8 5785.3 5803.6 5844.9 5738.7 5805.2 5849.2 5873.9 5898.4 5772.9 5807.9 5865.7 5870.8 5994.7 5928.4 5931.8 5932.9 5933.3 5933.6 4619.4 4623.6 4634.6 4640.1 4681.9 3984.9 4009.7 4028.3 4053.0 4083.8 5545.6 5554.6 5567.4 5571.2 5614.3 5807.2 5827.8 5869.2 5882.7 5894.1 5371.8 5471.2 5478.9 5526.8 5541.7 5046.8 5056.4 5057.4 5084.6 5108.8 6119.0 6150.3 6173.5 6173.5 6177.4 5807.8 5819.9 5858.3 5912.2 5918.1 6053.5 6125.2 6131.4 6155.6 6155.9 5734.0 5777.1 5795.7 5816.7 5826.8 5742.7 5790.2 5834.8 5906.8 5918.9 5663.9 5692.5 5699.4 5734.7 5804.2 5716.2 5721.4 5723.4 5734.7 5734.8 5457.4 5542.6 5550.5 5729.1 5735.7 5728.6 5750.1 5777.8 5801.0 5827.8 5596.0 5621.3 5627.4 5632.7 5633.6 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | [#1] ext.html Cycles:180 Average:54882.03 Median:203058.72 stddev:100901.85 (49.7%) stddev-sans-first:101102.46 07:54:28 INFO - PROCESS | 24787 | Values: 555.3 584.6 585.0 611.5 625.4 40344.4 46064.5 46268.1 46332.8 46345.5 46149.8 46741.6 46784.5 46895.1 46993.0 8853.0 9022.6 9045.9 10205.7 10565.7 10230.4 10332.3 10359.1 10376.0 10395.5 10326.4 10355.7 10376.4 10412.9 10426.6 10289.3 10313.2 10363.7 10381.7 10409.6 10100.7 10110.5 10172.5 10181.3 10197.5 39805.8 39845.8 39970.6 40152.4 40185.0 4180.0 4249.0 4271.9 4282.6 4438.9 30025.7 30040.8 30117.7 30185.5 30191.7 4288.5 4488.1 4567.5 4643.2 4666.6 318158.0 320020.0 321310.0 321334.0 321921.0 55187.4 55550.2 55634.7 55641.7 55702.7 57431.0 57574.4 57592.4 57600.7 57862.4 15633.0 15807.5 15814.7 15870.4 15938.8 11277.3 11508.7 12070.4 12221.6 12261.3 17947.3 17972.0 18029.3 18118.9 18156.3 7157.2 7210.6 7217.6 7247.9 7330.8 928.2 946.0 953.7 969.7 974.6 30705.2 30726.7 31521.4 31889.5 32149.8 1090.5 1144.9 1146.3 1171.6 1186.2 16131.8 16664.3 16980.4 17254.4 17353.0 444380.0 447484.0 448724.0 448728.0 451109.0 64290.4 65131.3 65132.3 65483.0 65553.7 1484.3 1493.9 1499.4 1516.6 1521.9 31104.7 31677.0 31857.8 31940.8 32878.8 55417.0 55621.0 56112.7 56173.2 56574.4 368210.0 368807.0 369199.0 370105.0 370660.0 25965.0 26817.3 26981.5 28169.2 28725.6 43910.3 44046.8 44203.0 44876.1 45545.8 36283.7 37202.3 37884.9 38111.6 39136.8 36918.4 37048.3 37268.8 37342.3 37373.0 37300.8 37781.4 37876.8 38450.0 38497.2 31872.8 33872.3 34196.5 34241.0 34420.5 26014.9 26028.0 26214.2 26336.3 26499.3 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | [#2] jquery.html Cycles:180 Average:34660.73 Median:14392.67 stddev:105030.38 (729.7%) stddev-sans-first:105293.55 07:54:28 INFO - PROCESS | 24787 | Values: 423.9 427.4 433.5 433.6 447.4 20619.6 20799.4 21482.9 21514.5 21607.6 20360.4 20716.7 20744.8 20761.0 20945.8 5706.6 5953.9 5955.6 5956.4 5966.7 5670.3 5791.5 5863.2 5865.4 5896.5 5785.3 5804.0 5831.8 5845.9 5873.0 5722.6 5805.2 5876.6 5901.1 5910.2 5228.6 5277.2 5282.2 5321.4 5323.0 24813.1 25211.4 25242.4 25506.0 25637.5 3147.8 3157.1 3178.9 3227.7 3248.8 15443.7 15455.7 15774.8 16216.3 16462.4 1977.5 1987.3 1998.9 2004.6 2016.7 86923.0 88701.6 88913.6 89173.0 90012.5 11486.1 11531.4 11644.7 11731.7 12033.0 16094.0 16137.9 16190.8 16204.2 16261.3 8360.7 8671.0 8691.3 8699.1 8795.6 8162.6 8203.8 8399.7 8436.0 8459.3 7347.5 7363.2 7425.9 7435.5 7452.8 2013.9 2080.1 2080.7 2088.4 2098.1 924.3 935.8 939.7 940.3 943.6 19355.8 19948.5 22251.9 22365.3 22474.0 994.2 1013.0 1013.2 1042.6 1052.1 10551.4 10990.8 11032.7 11071.1 11110.6 627317.0 634274.0 638963.0 641469.0 654542.0 86290.8 99837.5 100805.0 112467.0 119814.0 1149.0 1153.8 1183.2 1194.2 1203.3 18164.9 18550.4 18573.2 18608.6 18889.6 44588.8 45645.8 45768.5 45973.5 46862.5 57770.0 61775.7 65240.7 65952.7 66723.0 6364.2 9033.0 9097.8 9360.0 9507.5 9143.6 12340.6 13142.9 14398.5 14573.3 11459.8 12334.3 12626.0 13068.6 13281.9 12374.6 12490.8 12554.4 12659.4 13128.2 12762.1 12919.4 13002.0 13311.8 13575.8 8062.0 8197.3 9074.0 9102.8 9126.4 12484.8 12511.3 12579.2 12644.7 12792.3 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | [#3] mootools.html Cycles:180 Average:5681.72 Median:4709.71 stddev:3192.87 (67.8%) stddev-sans-first:3186.27 07:54:28 INFO - PROCESS | 24787 | Values: 1488.0 1510.0 1515.3 1515.5 1522.1 7939.0 8218.9 8396.8 8807.4 8847.8 8452.0 8685.7 8686.5 8837.3 8861.6 2326.7 2341.1 2374.6 2376.0 2381.7 2310.5 2320.9 2344.4 2352.5 2355.9 2312.0 2314.4 2333.1 2335.2 2349.3 2233.3 2264.2 2279.2 2290.9 2297.2 2276.6 2286.5 2290.7 2306.2 2307.0 8401.2 8489.5 8494.0 8514.0 8605.6 5157.5 5283.0 5284.0 5284.5 5289.3 3141.9 3193.1 3348.1 3412.2 3419.1 1330.8 1336.2 1340.8 1395.5 1400.0 12005.9 12025.2 12060.4 12067.6 12129.6 4406.5 4625.9 4677.7 4690.3 4729.1 10271.3 10285.6 10322.5 10342.3 10361.1 5332.2 5339.0 5341.2 5348.8 5359.5 4255.6 4257.0 4758.9 4783.7 4794.4 3788.0 3863.3 3870.3 3930.4 3952.9 1284.6 1298.0 1304.2 1311.6 1320.4 1003.6 1013.4 1019.7 1028.9 1041.2 5749.1 5772.0 5775.2 5812.2 5828.2 1032.5 1046.5 1081.5 1082.3 1095.6 3644.4 3850.0 3873.5 3880.6 4101.4 10479.6 10716.8 10774.0 10786.7 10790.7 10536.2 10637.8 10670.1 10672.3 10675.6 8019.6 8206.4 8350.4 8356.6 8412.6 5512.9 5549.7 5652.1 5752.3 5758.0 9519.8 9587.8 9607.0 9676.5 9722.8 9539.7 9676.6 9681.6 9687.5 9905.3 7189.1 7262.7 7287.5 7506.9 7557.1 8503.3 8563.6 8565.1 8586.7 8592.1 7483.4 7621.0 7645.4 7652.3 7900.3 7433.0 7482.5 7503.4 7512.8 7561.4 6345.4 6396.2 6426.9 6435.7 6450.1 4956.5 4958.5 5010.4 5018.6 5199.0 4863.2 4890.2 4932.3 4950.5 4960.8 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | [#4] prototype.html Cycles:180 Average:4794.89 Median:5392.01 stddev:1401.31 (26.0%) stddev-sans-first:1365.44 07:54:28 INFO - PROCESS | 24787 | Values: 376.6 394.2 395.6 407.3 408.2 5268.9 5377.7 5493.1 5511.9 5549.7 5331.0 5370.4 5406.3 5434.4 5440.5 4260.8 4262.8 4279.8 4286.8 4309.4 4012.9 4243.2 4245.5 4260.1 4262.8 4217.6 4229.4 4245.3 4258.8 4274.2 4255.3 4271.4 4275.9 4277.7 4346.9 3578.9 3812.3 3815.1 3826.6 3828.2 5230.7 5249.2 5250.2 5252.5 5254.9 4863.2 4868.8 4879.5 4887.4 4896.4 5518.7 5650.6 5727.6 5728.2 5766.0 4116.8 4117.3 4121.7 4140.8 4143.9 5938.4 5944.5 5953.4 5968.0 5990.6 4093.8 4202.5 4218.2 4254.3 4258.3 4232.3 4276.3 4278.8 4279.3 4288.2 4832.5 4873.2 4884.4 4892.5 4895.6 5657.3 5774.8 5780.4 5781.2 5794.1 1425.7 1431.2 1433.5 1435.4 1448.1 946.2 984.1 985.5 1004.1 1006.4 5185.4 5239.7 5248.7 5256.9 5277.7 5611.7 5641.7 5670.2 5724.7 5735.2 4984.2 5220.7 5256.9 5290.2 5294.4 2996.4 3011.4 3015.6 3017.4 3019.7 5742.9 5889.6 5892.5 5902.4 5932.7 5620.0 5899.5 5906.5 5948.7 5976.1 6095.7 6113.2 6136.6 6166.7 6172.8 5627.4 5783.7 5844.0 5868.9 5884.9 5826.9 5834.0 5855.0 5883.0 5891.2 5773.9 6110.3 6161.3 6187.4 6213.8 4092.2 4123.2 4206.9 4240.9 4241.2 5870.7 5877.5 5900.5 5909.7 5913.9 5573.8 5718.4 5736.1 5741.9 5812.4 5641.8 5673.9 5681.7 5697.5 5715.3 5657.5 5683.3 5694.7 5702.3 5702.4 5547.7 5688.5 5716.9 5750.2 5759.0 5520.4 5546.7 5550.5 5550.8 5587.4 07:54:28 INFO - PROCESS | 24787 | 07:54:28 INFO - PROCESS | 24787 | [#5] yui.html Cycles:180 Average:16855.00 Median:51133.50 stddev:21437.18 (41.9%) stddev-sans-first:21463.30 07:54:28 INFO - PROCESS | 24787 | Values: 773.4 801.9 814.2 853.9 872.9 14958.9 16407.9 16549.9 16697.7 16875.6 14354.1 14454.5 14516.6 14530.1 15150.0 644.9 759.9 772.9 778.0 779.5 670.8 738.9 763.1 771.8 772.0 791.0 795.0 795.7 797.9 799.1 792.3 795.1 795.7 796.1 797.4 575.4 576.7 577.4 578.5 579.7 15023.2 15079.0 15893.9 15967.4 16011.3 14248.9 15416.2 15700.9 15714.8 15940.8 12099.1 12253.8 12327.8 12354.9 12365.6 3727.2 3760.6 3826.2 3848.9 3856.0 71046.6 72203.6 73027.3 74513.3 75670.0 11044.6 11221.7 11313.9 11471.2 11714.9 21711.8 21883.8 21896.8 21925.8 21980.1 8118.6 8184.4 8205.5 8399.5 8479.2 4523.3 4658.8 4671.0 4688.8 4711.3 3677.5 3772.9 3803.6 3849.2 3854.6 663.3 672.8 675.7 688.7 690.7 721.3 723.1 723.6 737.9 750.9 9660.9 10002.1 10213.9 10396.3 10558.5 685.7 721.6 727.4 742.4 789.0 4741.9 5012.8 5043.3 5060.9 5071.7 76751.6 77163.0 77204.2 78877.0 80227.2 55130.0 59968.0 67292.7 68191.0 68541.0 60467.0 60817.4 60861.0 61327.0 61392.4 9236.9 9515.0 9540.8 9588.3 9642.6 41416.4 41640.0 42418.8 42692.8 42921.6 50633.0 50989.0 51278.0 52039.7 53675.0 11022.6 11030.8 11054.0 11063.0 11324.5 12308.9 12327.6 12441.2 12575.2 12642.0 11957.3 12023.2 12160.8 12162.5 12454.6 11231.6 11357.8 11482.8 11673.2 12237.1 11821.6 12160.9 12297.6 12356.8 12357.3 8855.4 8949.9 9061.2 9159.4 9273.5 8883.2 8902.8 8928.3 8937.8 8962.1 07:54:28 INFO - PROCESS | 24787 | -------- Summary: end -------- 07:54:28 INFO - PROCESS | 24787 | 07:54:29 INFO - TEST-INFO | 24787: exit 0 07:54:29 INFO - TEST-OK | dromaeo_css | took 1113222ms 07:54:29 INFO - TEST-START | kraken 07:54:29 INFO - operating with platform_type : linux_ 07:54:29 INFO - Initialising browser for kraken test... 07:54:29 INFO - TEST-INFO | started process 25139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPiR5sx/profile http://localhost:37027/getInfo.html) 07:54:33 INFO - PROCESS | 25139 | __metrics Screen width/height:1600/1200 07:54:33 INFO - PROCESS | 25139 | colorDepth:24 07:54:33 INFO - PROCESS | 25139 | Browser inner width/height: 1024/697 07:54:33 INFO - PROCESS | 25139 | __metrics 07:54:34 ERROR - PROCESS | 25139 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 07:54:35 INFO - TEST-INFO | 25139: exit 0 07:54:35 INFO - Browser initialized. 07:54:35 INFO - Running cycle 1/1 for kraken test... 07:54:35 INFO - TEST-INFO | started process 25264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPiR5sx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:47 INFO - PROCESS | 25264 | RSS: Main: 155533312 07:54:47 INFO - PROCESS | 25264 | 07:54:49 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:50 INFO - PROCESS | 25264 | RSS: Main: 161906688 07:54:50 INFO - PROCESS | 25264 | 07:54:53 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-dft) 07:54:53 INFO - PROCESS | 25264 | RSS: Main: 160796672 07:54:53 INFO - PROCESS | 25264 | 07:54:56 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-fft) 07:54:57 INFO - PROCESS | 25264 | RSS: Main: 156962816 07:54:57 INFO - PROCESS | 25264 | 07:54:59 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-oscillator) 07:54:59 INFO - PROCESS | 25264 | RSS: Main: 158130176 07:54:59 INFO - PROCESS | 25264 | 07:55:02 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:02 INFO - PROCESS | 25264 | RSS: Main: 158515200 07:55:02 INFO - PROCESS | 25264 | 07:55:05 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:06 INFO - PROCESS | 25264 | RSS: Main: 162410496 07:55:06 INFO - PROCESS | 25264 | 07:55:09 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:10 INFO - PROCESS | 25264 | RSS: Main: 160591872 07:55:10 INFO - PROCESS | 25264 | 07:55:13 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37027/tests/kraken/driver.html?testName=json-parse-financial) 07:55:13 INFO - PROCESS | 25264 | RSS: Main: 160124928 07:55:13 INFO - PROCESS | 25264 | 07:55:15 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:16 INFO - PROCESS | 25264 | RSS: Main: 161005568 07:55:16 INFO - PROCESS | 25264 | 07:55:17 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:18 INFO - PROCESS | 25264 | RSS: Main: 161046528 07:55:18 INFO - PROCESS | 25264 | 07:55:20 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:21 INFO - PROCESS | 25264 | RSS: Main: 160915456 07:55:21 INFO - PROCESS | 25264 | 07:55:24 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:24 INFO - PROCESS | 25264 | RSS: Main: 160804864 07:55:24 INFO - PROCESS | 25264 | 07:55:27 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:28 INFO - PROCESS | 25264 | RSS: Main: 161042432 07:55:28 INFO - PROCESS | 25264 | 07:55:29 INFO - PROCESS | 25264 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37027/tests/kraken/driver.html?testName=ai-astar) 07:55:30 INFO - PROCESS | 25264 | RSS: Main: 163155968 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | __start_tp_report 07:55:30 INFO - PROCESS | 25264 | _x_x_mozilla_page_load 07:55:30 INFO - PROCESS | 25264 | _x_x_mozilla_page_load_details 07:55:30 INFO - PROCESS | 25264 | |i|pagename|runs| 07:55:30 INFO - PROCESS | 25264 | |0;ai-astar;104;114;113;113;113;112;111;114;111;112 07:55:30 INFO - PROCESS | 25264 | |1;audio-beat-detection;156;121;121;165;121;124;124;119;139;118 07:55:30 INFO - PROCESS | 25264 | |2;audio-dft;163;164;163;163;161;164;172;170;163;164 07:55:30 INFO - PROCESS | 25264 | |3;audio-fft;76;76;75;93;77;77;75;75;91;76 07:55:30 INFO - PROCESS | 25264 | |4;audio-oscillator;84;84;103;84;85;84;95;84;83;111 07:55:30 INFO - PROCESS | 25264 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;118;119 07:55:30 INFO - PROCESS | 25264 | |6;imaging-darkroom;148;148;153;147;148;147;147;148;148;149 07:55:30 INFO - PROCESS | 25264 | |7;imaging-desaturate;97;97;97;97;96;97;97;97;98;97 07:55:30 INFO - PROCESS | 25264 | |8;json-parse-financial;61;57;58;57;59;59;58;60;58;57 07:55:30 INFO - PROCESS | 25264 | |9;json-stringify-tinderbox;69;70;69;70;69;73;68;69;70;70 07:55:30 INFO - PROCESS | 25264 | |10;stanford-crypto-aes;83;85;83;85;82;84;84;88;85;86 07:55:30 INFO - PROCESS | 25264 | |11;stanford-crypto-ccm;138;130;125;138;128;128;128;139;171;131 07:55:30 INFO - PROCESS | 25264 | |12;stanford-crypto-pbkdf2;171;170;170;169;170;170;181;172;171;171 07:55:30 INFO - PROCESS | 25264 | |13;stanford-crypto-sha256-iterative;64;64;63;69;64;64;65;63;63;63 07:55:30 INFO - PROCESS | 25264 | __end_tp_report 07:55:30 INFO - PROCESS | 25264 | __start_cc_report 07:55:30 INFO - PROCESS | 25264 | _x_x_mozilla_cycle_collect,738 07:55:30 INFO - PROCESS | 25264 | __end_cc_report 07:55:30 INFO - PROCESS | 25264 | __startTimestamp1484236530162__endTimestamp 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | ------- Summary: start ------- 07:55:30 INFO - PROCESS | 25264 | Number of tests: 14 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:2.91 (2.6%) stddev-sans-first:1.13 07:55:30 INFO - PROCESS | 25264 | Values: 104.0 114.0 113.0 113.0 113.0 112.0 111.0 114.0 111.0 112.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:124.00 stddev:16.85 (13.6%) stddev-sans-first:15.21 07:55:30 INFO - PROCESS | 25264 | Values: 156.0 121.0 121.0 165.0 121.0 124.0 124.0 119.0 139.0 118.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.47 (2.1%) stddev-sans-first:3.62 07:55:30 INFO - PROCESS | 25264 | Values: 163.0 164.0 163.0 163.0 161.0 164.0 172.0 170.0 163.0 164.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#3] audio-fft Cycles:10 Average:79.10 Median:76.50 stddev:6.85 (9.0%) stddev-sans-first:7.18 07:55:30 INFO - PROCESS | 25264 | Values: 76.0 76.0 75.0 93.0 77.0 77.0 75.0 75.0 91.0 76.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:84.00 stddev:9.93 (11.8%) stddev-sans-first:10.32 07:55:30 INFO - PROCESS | 25264 | Values: 84.0 84.0 103.0 84.0 85.0 84.0 95.0 84.0 83.0 111.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:55:30 INFO - PROCESS | 25264 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 119.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.77 (1.2%) stddev-sans-first:1.87 07:55:30 INFO - PROCESS | 25264 | Values: 148.0 148.0 153.0 147.0 148.0 147.0 147.0 148.0 148.0 149.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:55:30 INFO - PROCESS | 25264 | Values: 97.0 97.0 97.0 97.0 96.0 97.0 97.0 97.0 98.0 97.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:1.35 (2.3%) stddev-sans-first:1.05 07:55:30 INFO - PROCESS | 25264 | Values: 61.0 57.0 58.0 57.0 59.0 59.0 58.0 60.0 58.0 57.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.39 07:55:30 INFO - PROCESS | 25264 | Values: 69.0 70.0 69.0 70.0 69.0 73.0 68.0 69.0 70.0 70.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.72 (2.0%) stddev-sans-first:1.73 07:55:30 INFO - PROCESS | 25264 | Values: 83.0 85.0 83.0 85.0 82.0 84.0 84.0 88.0 85.0 86.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:134.50 stddev:13.39 (10.0%) stddev-sans-first:14.18 07:55:30 INFO - PROCESS | 25264 | Values: 138.0 130.0 125.0 138.0 128.0 128.0 128.0 139.0 171.0 131.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:171.00 stddev:3.44 (2.0%) stddev-sans-first:3.64 07:55:30 INFO - PROCESS | 25264 | Values: 171.0 170.0 170.0 169.0 170.0 170.0 181.0 172.0 171.0 171.0 07:55:30 INFO - PROCESS | 25264 | 07:55:30 INFO - PROCESS | 25264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.81 (2.8%) stddev-sans-first:1.92 07:55:30 INFO - PROCESS | 25264 | Values: 64.0 64.0 63.0 69.0 64.0 64.0 65.0 63.0 63.0 63.0 07:55:30 INFO - PROCESS | 25264 | -------- Summary: end -------- 07:55:30 INFO - PROCESS | 25264 | 07:55:31 INFO - TEST-INFO | 25264: exit 0 07:55:31 INFO - TEST-OK | kraken | took 61644ms 07:55:31 INFO - SUITE-END | took 1174s 07:55:31 INFO - Completed test suite (00:19:34) 07:55:31 INFO - javascript benchmark 07:55:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7321.907409730303, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3220.146661134799, 3242.7892187007856, 3252.577164968553, 3259.054874086515, 3263.592050993626, 5340.572754179666, 5435.673859568424, 5454.563634909207, 5489.121740521512, 5518.641288316257, 5384.6499977501435, 5414.214938833867, 5456.181572764087, 5534.501894829465, 5535.723213839312, 4706.74112923789, 4940.629452791055, 4978.103941290576, 5028.572571331441, 5170.715610641413, 5092.0, 5123.359580052494, 5126.154184559562, 5131.512506311894, 5181.378234611851, 4894.632902532288, 4939.5554400104165, 5101.51535604117, 5132.40977287613, 5145.382554093514, 4918.434380046305, 4941.678790878582, 5006.974965125188, 5031.421386540558, 5082.390113186404, 4941.110600091982, 4947.703137811707, 4949.208126699711, 4955.851324460272, 4973.179425394842, 5351.063563876306, 5360.490753378423, 5437.102878025121, 5444.101723215665, 5449.891002179934, 5746.339170995348, 5768.0, 5828.271466066742, 5830.970845145789, 5927.3776253493625, 5905.970470147622, 5913.46778789911, 5915.349311575723, 5916.142159386908, 5917.993941030035, 5536.197251398525, 5539.584531160179, 5541.473560011793, 5542.501174894239, 5542.722863856831, 5795.333536643256, 5857.58996870215, 5912.024515954905, 5931.673757943355, 5980.312264089598, 5748.425157484302, 5752.798652047159, 5785.27684039495, 5803.622764520293, 5844.853878653068, 5738.713064346849, 5805.216295800097, 5849.151872978479, 5873.911891321633, 5898.351181370046, 5772.884542309131, 5807.854803629859, 5865.736041878125, 5870.765169393262, 5994.670293133832, 5928.436798504135, 5931.762729490858, 5932.911006334908, 5933.288005439289, 5933.554983376264, 4619.3994780678295, 4623.606993405599, 4634.629229661619, 4640.141573808856, 4681.859544213679, 3984.86052988144, 4009.659178969762, 4028.295048366524, 4053.047533829548, 4083.816228269735, 5545.584081193927, 5554.611177217556, 5567.4432556744005, 5571.164325351229, 5614.2701448811395, 5807.216025836543, 5827.825165245049, 5869.236999190078, 5882.735276912549, 5894.115882617642, 5371.758270877742, 5471.179323101566, 5478.890422191534, 5526.751296191601, 5541.725403157297, 5046.823361182341, 5056.367954005749, 5057.443681195065, 5084.593232541388, 5108.846734597893, 6119.0, 6150.323464418911, 6173.506119510428, 6173.536984726164, 6177.413145751147, 5807.796727114531, 5819.883602328015, 5858.2677165354335, 5912.172295878494, 5918.082697181943, 6053.4551890330085, 6125.203723515914, 6131.437835141539, 6155.569110162246, 6155.907661385172, 5734.0, 5777.133429985536, 5795.652260864362, 5816.73824677882, 5826.766929322949, 5742.655440673573, 5790.247267855152, 5834.795782147605, 5906.793262235973, 5918.852028699317, 5663.886722265449, 5692.544596432358, 5699.373068962494, 5734.655920644775, 5804.245448091721, 5716.199732037435, 5721.399253078367, 5723.399043100581, 5734.713264336683, 5734.827955161351, 5457.426970168234, 5542.584306176972, 5550.47270509301, 5729.1119876419225, 5735.7418916148035, 5728.570357223141, 5750.079987202028, 5777.826665200051, 5801.0, 5827.76688932438, 5595.972020139873, 5621.325440947113, 5627.409122042291, 5632.690202038763, 5633.577481688808], "value": 5419.036088533091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.2587295959893, 584.5703407995123, 585.0259318235138, 611.461913516106, 625.412112614143, 40344.39483407747, 46064.539354606444, 46268.07463850721, 46332.76833615831, 46345.536544634546, 46149.76925115378, 46741.597752067406, 46784.53215467844, 46895.062098758004, 46993.0, 8852.999999999984, 9022.593983270735, 9045.864312035292, 10205.693829185098, 10565.735856603607, 10230.43732594707, 10332.276740628158, 10359.067683908446, 10376.0, 10395.532201050972, 10326.43204623749, 10355.689329320096, 10376.377417354945, 10412.895871041268, 10426.635067772591, 10289.3311934724, 10313.174946004301, 10363.740906477324, 10381.688549343531, 10409.583616655362, 10100.747481312952, 10110.545025473872, 10172.491375431198, 10181.28730988831, 10197.541110650038, 39805.80097099496, 39845.80077099596, 39970.60029399698, 40152.39771403431, 40185.0, 4179.97910010448, 4249.0, 4271.8718438446895, 4282.614564689162, 4438.866833994953, 30025.699743002726, 30040.8497957511, 30117.69882301171, 30185.547216791765, 30191.69808301911, 4288.485381754178, 4488.147252022105, 4567.474740404863, 4643.210654188796, 4666.556677115668, 318158.0, 320020.0, 321310.0, 321334.0, 321921.0, 55187.44812551823, 55550.16723244082, 55634.72182639142, 55641.72179139078, 55702.72148639231, 57431.0, 57574.42425575691, 57592.42407575955, 57600.71199644059, 57862.4213757857, 15633.0, 15807.525774226791, 15814.68370632581, 15870.429153440384, 15938.760918586231, 11277.266977646426, 11508.712282193012, 12070.396480175956, 12221.633350999306, 12261.264324140402, 17947.282108715506, 17972.0, 18029.27882884696, 18118.909405452887, 18156.273749050153, 7157.24848890859, 7210.603416812126, 7217.566945983258, 7247.855042899112, 7330.753771858796, 928.215657769184, 945.9783433891381, 953.6662168241198, 969.6993931880999, 974.6247694637616, 30705.232369190504, 30726.69273307283, 31521.36957260842, 31889.521657175163, 32149.839250804063, 1090.4983707494482, 1144.9084073274119, 1146.3351256271342, 1171.5840876488894, 1186.1993154620598, 16131.838681613268, 16664.33342666304, 16980.40568580094, 17254.396096136574, 17353.0, 444380.0, 447484.0, 448724.0, 448728.0, 451109.0, 64290.35709642844, 65131.34868651348, 65132.348676513575, 65483.0, 65553.67223163949, 1484.2578710644677, 1493.9253037348305, 1499.4002399040253, 1516.5601975427003, 1521.9467318643794, 31104.68895311018, 31677.0, 31857.8407107963, 31940.840295799302, 32878.83560582182, 55417.0, 55621.0, 56112.719436402556, 56173.15740263981, 56574.43425565692, 368210.0, 368807.0, 369199.0, 370105.0, 370660.0, 25964.975428808564, 26817.329566760985, 26981.460370792865, 28169.15492535227, 28725.56911646285, 43910.34134488049, 44046.77976610096, 44203.0, 44876.10247795091, 45545.772271138434, 36283.74012029711, 37202.25595488129, 37884.86345409642, 38111.61888381192, 39136.80431597824, 36918.44622330721, 37048.25903481969, 37268.813655931546, 37342.2531549362, 37373.0, 37300.81349593234, 37781.43327850029, 37876.81061594674, 38450.0, 38497.2300553993, 31872.840635796674, 33872.32255354928, 34196.48705269473, 34241.0, 34420.48369274513, 26014.86992565025, 26028.0, 26214.213573592824, 26336.34159146037, 26499.337516562242], "value": 20057.263079005115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.8961454443662, 427.38141857755477, 433.4971433137561, 433.56859924375243, 447.4183561370218, 20619.587608247824, 20799.376018719442, 21482.89258553705, 21514.462138446546, 21607.56784864302, 20360.389188324338, 20716.689249661267, 20744.792552074476, 20761.0, 20945.790542094575, 5706.572007099474, 5953.940460595403, 5955.583109182359, 5956.404359564052, 5966.701664916758, 5670.262865827437, 5791.478766910977, 5863.179154918314, 5865.384134665863, 5896.498797602188, 5785.334686511063, 5804.0, 5831.766729330821, 5845.8830823383505, 5872.9706351468185, 5722.570807189478, 5805.216295800076, 5876.588638795265, 5901.114832775075, 5910.202122713422, 5228.607854410896, 5277.155655095166, 5282.2340760589495, 5321.361436627591, 5322.973385133088, 24813.131540396, 25211.369715757068, 25242.368940776443, 25506.0, 25637.48725025489, 3147.8497955136945, 3157.1160075178987, 3178.9205269868207, 3227.693369129929, 3248.7888287261253, 15443.679608884144, 15455.690886182214, 15774.763378549216, 16216.270267837976, 16462.42381516653, 1977.4561995451222, 1987.3044434447827, 1998.8500862435376, 2004.5690176611952, 2016.6773316269328, 86923.0, 88701.55649221777, 88913.55543222242, 89173.0, 90012.54993724989, 11486.138539609396, 11531.365774882293, 11644.70888227784, 11731.706707332214, 12033.0, 16094.0, 16137.919310403608, 16190.838091619169, 16204.189790510427, 16261.349546018027, 8360.665573377119, 8671.0, 8691.261242794308, 8699.086595907338, 8795.560221989002, 8162.551059691774, 8203.8359232815, 8399.706010289732, 8435.95782021086, 8459.280961118251, 7347.5224110432655, 7363.15323737777, 7425.888611670829, 7435.51669141504, 7452.813679657944, 2013.9295124670566, 2080.1055546115012, 2080.6774949882792, 2088.363049269987, 2098.0768461876723, 924.3021518753433, 935.7988032573029, 939.727479031087, 940.3135710930922, 943.6178347769164, 19355.80644193568, 19948.50128746764, 22251.887405629655, 22365.32904012882, 22474.0, 994.1847684898459, 1013.0, 1013.1742629756725, 1042.629866397418, 1052.084686322904, 10551.366917984946, 10990.835137472945, 11032.669019929415, 11071.114310855111, 11110.61112861046, 627317.0, 634274.0, 638963.0, 641469.0, 654542.0, 86290.84272893227, 99837.50081249693, 100805.0, 112467.0, 119814.0, 1148.9655310340704, 1153.763478486908, 1183.230899915062, 1194.1581185264367, 1203.2780331801025, 18164.90917545404, 18550.44348669542, 18573.164207610418, 18608.627827443644, 18889.622207556047, 44588.777056114515, 45645.771771140935, 45768.54231457776, 45973.54026459692, 46862.531374685816, 57770.0, 61775.69112154411, 65240.67379663071, 65952.67023664851, 66723.0, 6364.204474440695, 9033.0, 9097.81728375307, 9359.953200233955, 9507.524623768646, 9143.63425462974, 12340.580833203938, 13142.868571314164, 14398.499802999346, 14573.344199511259, 11459.770804584028, 12334.259944403364, 12626.0, 13068.607941761762, 13281.867181328449, 12374.62876113718, 12490.751664700441, 12554.372281386077, 12659.430325635552, 13128.212307261594, 12762.106652534234, 12919.354032298535, 13001.95984321271, 13311.80032299497, 13575.79636305476, 8062.0, 8197.303229225345, 9073.954630226806, 9102.817943640957, 9126.406783559047, 12484.812727808909, 12511.311877846805, 12579.182353147016, 12644.747105058032, 12792.296423696785], "value": 10079.612189822648, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.9776803347945, 1509.9924500377497, 1515.265096428232, 1515.54533639908, 1522.1323845408115, 7938.960305198466, 8218.91781082189, 8396.790080247989, 8807.383483156182, 8847.823043539125, 8452.0, 8685.696000639979, 8686.522241276727, 8837.293016558677, 8861.556922153883, 2326.68589740385, 2341.1337805012167, 2374.5844477216506, 2376.049580167938, 2381.714194296678, 2310.4685922237895, 2320.872352020638, 2344.37873963399, 2352.517733864562, 2355.9057637694473, 2312.0289478419104, 2314.3982564533258, 2333.0667732906804, 2335.2177020698086, 2349.283468542094, 2233.2630232023557, 2264.1622599638076, 2279.2364557873134, 2290.874001929885, 2297.173017713622, 2276.5674521840965, 2286.451251699597, 2290.713660792401, 2306.1813056364917, 2307.042577330406, 8401.159884011611, 8489.533075680834, 8494.023187333474, 8514.0, 8605.569721513963, 5157.535821776059, 5283.0, 5284.0, 5284.5243928046275, 5289.259503669489, 3141.921451963696, 3193.0899693587216, 3348.1462227131924, 3412.2493051528872, 3419.076849250688, 1330.7671157547488, 1336.245021562814, 1340.8390993080893, 1395.4906459142442, 1400.0479673821796, 12005.879941200563, 12025.218360806519, 12060.396980150957, 12067.577634782829, 12129.636110916686, 4406.537313582092, 4625.918336748477, 4677.695949763254, 4690.296455531629, 4729.125111854318, 10271.281010329205, 10285.588576456857, 10322.535485903152, 10342.27604067723, 10361.119304859021, 5332.200169974457, 5339.038972984822, 5341.225522299323, 5348.786048558092, 5359.517643412111, 4255.595718406808, 4256.9996050928, 4758.928616070762, 4783.6651434399255, 4794.4486384065585, 3788.0, 3863.30460517104, 3870.283997460479, 3930.449737036817, 3952.8616498422416, 1284.5825106840127, 1298.0459362368651, 1304.1979182802509, 1311.5934060441293, 1320.4454129265732, 1003.6336737090909, 1013.4426065663855, 1019.7348689340677, 1028.93311934724, 1041.1774697988503, 5749.137629355547, 5771.971140144273, 5775.16260142277, 5812.186293918855, 5828.213191219216, 1032.4785983078498, 1046.5238316565944, 1081.534939975818, 1082.2748758331936, 1095.638439315024, 3644.3804553226014, 3849.9615003849603, 3873.535175778868, 3880.592537783492, 4101.384792281182, 10479.580816767397, 10716.78566428667, 10774.030337269684, 10786.730331741612, 10790.67627971162, 10536.209784266211, 10637.787244255072, 10670.093042091354, 10672.252942293964, 10675.626353077605, 8019.639116239667, 8206.384521160937, 8350.373721970755, 8356.623951922056, 8412.579371031425, 5512.91730624049, 5549.694766787866, 5652.123920792284, 5752.252207213203, 5757.971210143923, 9519.762005949906, 9587.808243835223, 9607.0, 9676.452666593446, 9722.75693107678, 9539.666111686058, 9676.564554595201, 9681.612735490784, 9687.51562421862, 9905.257105716955, 7189.065421495172, 7262.745803896838, 7287.453440991841, 7506.887396688945, 7557.05536807899, 8503.277221436247, 8563.61463734121, 8565.100664430145, 8586.65653373858, 8592.140785921609, 7483.363914067365, 7621.0, 7645.350145237717, 7652.273034061978, 7900.2889739923685, 7433.0, 7482.476226664299, 7503.399728021855, 7512.849743005, 7561.432892532972, 6345.428911397997, 6396.232452105777, 6426.935730642634, 6435.742570297136, 6450.064740612679, 4956.454789973028, 4958.504149585013, 5010.423801262901, 5018.648694591344, 5199.0, 4863.2461968394955, 4890.24201248807, 4932.2601609757385, 4950.45544990058, 4960.7767650456535], "value": 4603.051886084728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.64783427495274, 394.22337994151513, 395.6261333040278, 407.329942245007, 408.2060392536516, 5268.868278293045, 5377.731113444327, 5493.148561972896, 5511.889762204759, 5549.722513874301, 5330.973345133269, 5370.382406023308, 5406.297181366417, 5434.402215756273, 5440.510354068133, 4260.829566817323, 4262.808173632178, 4279.801655536455, 4286.82852685893, 4309.4397728295435, 4012.8996775080564, 4243.236217480852, 4245.511766146902, 4260.1266740318315, 4262.78686065697, 4217.557156498554, 4229.429027081335, 4245.341971994346, 4258.808353624095, 4274.187904298174, 4255.255330317197, 4271.402003719466, 4275.893102672427, 4277.679174061957, 4346.891972239832, 3578.874739384135, 3812.2756676231706, 3815.103450689086, 3826.559945606263, 3828.2152158807376, 5230.686158830483, 5249.1627930224495, 5250.212468129773, 5252.501012403815, 5254.947450525522, 4863.24619683946, 4868.78090485929, 4879.512048795127, 4887.437944636376, 4896.36347274852, 5518.696471694056, 5650.63270887391, 5727.627704199213, 5728.22668939692, 5765.971170144165, 4116.814743336557, 4117.258893399187, 4121.690873184493, 4140.8136633851545, 4143.948745371031, 5938.435848594377, 5944.464998150187, 5953.404659534012, 5968.0465213872385, 5990.580659353847, 4093.8157782899243, 4202.495700515958, 4218.198542276958, 4254.319308910622, 4258.318669012943, 4232.280512312914, 4276.31578947367, 4278.7860606969525, 4279.293916503742, 4288.2281189385585, 4832.4684284728655, 4873.244647079709, 4884.3650325458175, 4892.486288939681, 4895.583875370562, 5657.302809157236, 5774.769009239667, 5780.364159942403, 5781.248437703071, 5794.101914203306, 1425.736238795826, 1431.205680847119, 1433.5054406229833, 1435.404307212495, 1448.1311213271952, 946.1910066892708, 984.07988530724, 985.5072463768116, 1004.1013293102632, 1006.3609607899036, 5185.351831021122, 5239.711815850089, 5248.6588371755715, 5256.869772998747, 5277.736113194325, 5611.663300202001, 5641.717914104278, 5670.206171136044, 5724.742386592613, 5735.1970724098655, 4984.22744474607, 5220.660657057279, 5256.948610277883, 5290.1800220965815, 5294.444083371268, 2996.3557835065567, 3011.4428830666398, 3015.577819105327, 3017.3814368054495, 3019.698030196963, 5742.885142297131, 5889.558283128783, 5892.469677729025, 5902.4097590240635, 5932.7330270137945, 5619.971900140473, 5899.528037756969, 5906.49794767441, 5948.672822994777, 5976.103584462278, 6095.6952152392205, 6113.20528331323, 6136.631802091889, 6166.660833654102, 6172.753089876354, 5627.409122042291, 5783.710814459344, 5843.970780146072, 5868.882622347443, 5884.852878677896, 5826.912596310974, 5834.0, 5855.03391940325, 5882.970585147047, 5891.204687367322, 5773.884522309614, 6110.327863934875, 6161.272430179677, 6187.381261873777, 6213.782517611862, 4092.2224777292217, 4123.237201117803, 4206.894827629334, 4240.872773816791, 4241.236577415972, 5870.677112758839, 5877.500412464989, 5900.527957763283, 5909.734061967308, 5913.940860591339, 5573.832785016456, 5718.428157184248, 5736.110902810071, 5741.913871292018, 5812.389699081536, 5641.830745077655, 5673.886522269614, 5681.659100453986, 5697.487226149667, 5715.342735585461, 5657.482420322916, 5683.2895888014, 5694.743736531949, 5702.287214098238, 5702.429757024264, 5547.667139971614, 5688.488036076773, 5716.942830571641, 5750.166225897138, 5759.0, 5520.420355862577, 5546.668799488174, 5550.5282051026115, 5550.833474995757, 5587.357453892691], "value": 4363.348240249165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.369703691491, 801.9037715474144, 814.157347145704, 853.9274161696256, 872.9083446238145, 14958.850411495881, 16407.917960410196, 16549.91725041373, 16697.749533757004, 16875.578110547227, 14354.066985645926, 14454.494092706758, 14516.637084072903, 14530.055546389478, 15150.0, 644.8678021005707, 759.8860170974343, 772.9265719756643, 778.0313509680456, 779.4855395439012, 670.7819958513503, 738.8522295540887, 763.0576238345667, 771.7568965775763, 771.9575423351713, 790.9683612655487, 794.9960250198741, 795.6857041468617, 797.8962734844491, 799.1289494451047, 792.3265224559136, 795.145218889693, 795.7334293011847, 796.1242633103598, 797.4099166616662, 575.4159528079003, 576.6712973605047, 577.3822010448821, 578.5082679722244, 579.681175353558, 15023.173725445096, 15079.0, 15893.92053039739, 15967.361305547764, 16011.27949242287, 14248.928755356157, 15416.152111633855, 15700.921495392564, 15714.842851571453, 15940.840591594168, 12099.092568057344, 12253.816192757116, 12327.753444931051, 12354.876451235463, 12365.567205147776, 3727.1800203955086, 3760.5863355031197, 3826.1773718650625, 3848.9230215395537, 3855.9614403856162, 71046.64476677636, 72203.63898180528, 73027.26972730258, 74513.25486745118, 75670.0, 11044.613438529614, 11221.71945701364, 11313.886861131283, 11471.197016208953, 11714.88285117155, 21711.782882170977, 21883.781162188494, 21896.781032189792, 21925.780742192375, 21980.120795168015, 8118.553479558681, 8184.427090103754, 8205.466644668197, 8399.454035487674, 8479.236868681724, 4523.276275795857, 4658.790354434059, 4670.972386075058, 4688.8124475021295, 4711.340412342275, 3677.5035370225214, 3772.8681395581766, 3803.581606023335, 3849.2109117630816, 3854.5567259764925, 663.2969052804043, 672.8418821576926, 675.6824292582478, 688.7176257734405, 690.6857379892137, 721.3337191088602, 723.1358526560709, 723.6345645449014, 737.8673735815497, 750.91364493084, 9660.855087173699, 10002.149817265614, 10213.948930255301, 10396.324238924446, 10558.52486638103, 685.746273878668, 721.6325064003684, 727.425333986145, 742.3764038207931, 788.9585449859977, 4741.857744267678, 5012.824551140692, 5043.3443652325695, 5060.924086138711, 5071.721055341992, 76751.61624191955, 77163.0, 77204.22795772082, 78877.0, 80227.19772802314, 55130.0, 59968.0, 67292.663536682, 68191.0, 68541.0, 60467.0, 60817.39182608117, 60861.0, 61327.0, 61392.38607613867, 9236.907630923604, 9514.952425237829, 9540.761480962754, 9588.289842355736, 9642.566084526354, 41416.37875431931, 41640.0, 42418.78790606027, 42692.78653606712, 42921.570784291755, 50633.0, 50989.0, 51278.0, 52039.73980130227, 53675.0, 11022.559097636005, 11030.834537481784, 11054.0, 11063.0, 11324.490397931948, 12308.938455307667, 12327.630171094881, 12441.191322564004, 12575.182613130117, 12642.0, 11957.282563046245, 12023.158378913393, 12160.817587736368, 12162.513499459923, 12454.626361209179, 11231.55073797039, 11357.772844542898, 11482.770344592895, 11673.182877198855, 12237.143399961917, 11821.586244481747, 12160.939195303967, 12297.56958506448, 12356.752864942831, 12357.25856448616, 8855.424397414148, 8949.910500894908, 9061.184493395625, 9159.404638698463, 9273.489958052372, 8883.244924181517, 8902.777430564287, 8928.285737140883, 8937.821243575223, 8962.058983806606], "value": 7001.5987727398915, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 113.0, 113.0, 112.0, 111.0, 114.0, 111.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 121.0, 165.0, 121.0, 124.0, 124.0, 119.0, 139.0, 118.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 161.0, 164.0, 172.0, 170.0, 163.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 93.0, 77.0, 77.0, 75.0, 75.0, 91.0, 76.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 103.0, 84.0, 85.0, 84.0, 95.0, 84.0, 83.0, 111.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 153.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 98.0, 97.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 58.0, 57.0, 59.0, 59.0, 58.0, 60.0, 58.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 70.0, 69.0, 73.0, 68.0, 69.0, 70.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 85.0, 82.0, 84.0, 84.0, 88.0, 85.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 125.0, 138.0, 128.0, 128.0, 128.0, 139.0, 171.0, 131.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 170.0, 169.0, 170.0, 170.0, 181.0, 172.0, 171.0, 171.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 69.0, 64.0, 64.0, 65.0, 63.0, 63.0, 63.0], "value": 64.2, "unit": "score"}]}]} 07:55:31 INFO - Return code: 0 07:55:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:31 ERROR - # TBPL SUCCESS # 07:55:31 INFO - Running post-action listener: _resource_record_post_action 07:55:31 INFO - [mozharness: 2017-01-12 15:55:31.457919Z] Finished run-tests step (success) 07:55:31 INFO - Running post-run listener: _resource_record_post_run 07:55:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409366528; Read time: 16; Write time: 324344 07:55:31 INFO - TinderboxPrint: CPU usage
13.4% 07:55:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:55:31 INFO - TinderboxPrint: I/O write bytes / time
409,366,528 / 324,344 07:55:31 INFO - TinderboxPrint: CPU idle
8,246.3 (86.6%) 07:55:31 INFO - TinderboxPrint: CPU user
1,213.1 (12.7%) 07:55:31 INFO - TinderboxPrint: Swap in / out
0 / 0 07:55:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 77225984; Read time: 0; Write time: 101636 07:55:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296259584; Read time: 16; Write time: 213884 07:55:32 INFO - Running post-run listener: _upload_blobber_files 07:55:32 INFO - Blob upload gear active. 07:55:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55: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 07:55: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'] 07:55: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 07:55:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:33 INFO - (blobuploader) - INFO - Done attempting. 07:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:37 INFO - (blobuploader) - INFO - Done attempting. 07:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:37 INFO - (blobuploader) - INFO - Done attempting. 07:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:38 INFO - (blobuploader) - INFO - Done attempting. 07:55:38 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:38 INFO - Return code: 0 07:55:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ed2a64427a1871cec26e51b145bd978eabc39f002eea88c0c3166ed68a9a51ed0d9dea2db0e895acad4eb284dd1b80a0c4a3a754912b64eb5a5cc870ea62b3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08b34d11022e8f799c8617842011115a007004ca869e3bda65266ae74840c56d1e70af1528e71a017bc8d0858c175206edf76f4203a9fd175e01ba18b40a6366", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/711af3a2caaf78aa5d8dac2289e4b1bc858216db2d443162a2eb8affd465919f75b5af5ee9acf3aaf4c93698c8e668b99da57798cebfa7ca810178bebd62e649", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/738dc1d3839d929638b8a9fa33af3f69b97c0de70e7a96fae6eb346ceece6558f526bd0785d712b72a2b800b5f551af4ddab41eeadbe0eaf3c360a6367acf985"} 07:55:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:38 INFO - Contents: 07:55:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ed2a64427a1871cec26e51b145bd978eabc39f002eea88c0c3166ed68a9a51ed0d9dea2db0e895acad4eb284dd1b80a0c4a3a754912b64eb5a5cc870ea62b3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08b34d11022e8f799c8617842011115a007004ca869e3bda65266ae74840c56d1e70af1528e71a017bc8d0858c175206edf76f4203a9fd175e01ba18b40a6366", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/711af3a2caaf78aa5d8dac2289e4b1bc858216db2d443162a2eb8affd465919f75b5af5ee9acf3aaf4c93698c8e668b99da57798cebfa7ca810178bebd62e649", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/738dc1d3839d929638b8a9fa33af3f69b97c0de70e7a96fae6eb346ceece6558f526bd0785d712b72a2b800b5f551af4ddab41eeadbe0eaf3c360a6367acf985"} 07:55:38 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:38 INFO - Copying logs to upload dir... 07:55:38 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.286510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-01-12 07:55:38.169572) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 07:55:38.174911) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772 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/0ed2a64427a1871cec26e51b145bd978eabc39f002eea88c0c3166ed68a9a51ed0d9dea2db0e895acad4eb284dd1b80a0c4a3a754912b64eb5a5cc870ea62b3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08b34d11022e8f799c8617842011115a007004ca869e3bda65266ae74840c56d1e70af1528e71a017bc8d0858c175206edf76f4203a9fd175e01ba18b40a6366", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/711af3a2caaf78aa5d8dac2289e4b1bc858216db2d443162a2eb8affd465919f75b5af5ee9acf3aaf4c93698c8e668b99da57798cebfa7ca810178bebd62e649", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/738dc1d3839d929638b8a9fa33af3f69b97c0de70e7a96fae6eb346ceece6558f526bd0785d712b72a2b800b5f551af4ddab41eeadbe0eaf3c360a6367acf985"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484228514/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/0ed2a64427a1871cec26e51b145bd978eabc39f002eea88c0c3166ed68a9a51ed0d9dea2db0e895acad4eb284dd1b80a0c4a3a754912b64eb5a5cc870ea62b3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/08b34d11022e8f799c8617842011115a007004ca869e3bda65266ae74840c56d1e70af1528e71a017bc8d0858c175206edf76f4203a9fd175e01ba18b40a6366", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/711af3a2caaf78aa5d8dac2289e4b1bc858216db2d443162a2eb8affd465919f75b5af5ee9acf3aaf4c93698c8e668b99da57798cebfa7ca810178bebd62e649", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/738dc1d3839d929638b8a9fa33af3f69b97c0de70e7a96fae6eb346ceece6558f526bd0785d712b72a2b800b5f551af4ddab41eeadbe0eaf3c360a6367acf985"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 07:55:38.200340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:55:38.200652) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1484234801.497357-473583772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:55:38.285173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 07:55:38.285466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 07:55:38.285750) ========= ========= Total master_lag: 0.16 =========