builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1481808698.05 results: success (0) buildid: 20161215052802 builduid: fb9d7a703c514e8fbe3e80aae2c6e0be revision: 7fe29922e32c564ec9a8e551312d0165d5834fec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.047409) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.047849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.048123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.062476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.062792) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 05:31:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-12-15 05:31:38 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.192379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.192696) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014460 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.242184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.242534) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7fe29922e32c564ec9a8e551312d0165d5834fec --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 7fe29922e32c564ec9a8e551312d0165d5834fec --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=a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 05:31:38,731 truncating revision to first 12 chars 2016-12-15 05:31:38,731 Setting DEBUG logging. 2016-12-15 05:31:38,731 attempt 1/10 2016-12-15 05:31:38,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7fe29922e32c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 05:31:39,173 unpacking tar archive at: mozilla-inbound-7fe29922e32c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.986115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.986428) ========= script_repo_revision: 7fe29922e32c564ec9a8e551312d0165d5834fec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.986838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.987097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 05:31:38.994541) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-15 05:31:38.994842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:31:39 INFO - MultiFileLogger online at 20161215 05:31:39 in /builds/slave/test 05:31:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 05:31:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:39 INFO - {'append_to_log': False, 05:31:39 INFO - 'base_work_dir': '/builds/slave/test', 05:31:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:31:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:39 INFO - 'branch': 'Mozilla-Inbound', 05:31:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:39 INFO - 'config_files': ('talos/linux_config.py',), 05:31:39 INFO - 'default_actions': ('clobber', 05:31:39 INFO - 'read-buildbot-config', 05:31:39 INFO - 'download-and-extract', 05:31:39 INFO - 'populate-webroot', 05:31:39 INFO - 'create-virtualenv', 05:31:39 INFO - 'install', 05:31:39 INFO - 'run-tests'), 05:31:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:39 INFO - 'download_minidump_stackwalk': True, 05:31:39 INFO - 'download_symbols': 'ondemand', 05:31:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:39 INFO - 'installer_path': 'installer.exe', 05:31:39 INFO - 'log_level': 'info', 05:31:39 INFO - 'log_name': 'talos', 05:31:39 INFO - 'log_to_console': True, 05:31:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:31:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:31:39 INFO - 'opt_config_files': (), 05:31:39 INFO - 'pip_index': False, 05:31:39 INFO - 'sps_profile': False, 05:31:39 INFO - 'sps_profile_interval': 0, 05:31:39 INFO - 'suite': 'dromaeojs', 05:31:39 INFO - 'system_bits': '32', 05:31:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:39 INFO - 'title': 'talos-linux64-ix-002', 05:31:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:39 INFO - 'use_talos_json': True, 05:31:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:39 INFO - 'work_dir': 'build'} 05:31:39 INFO - [mozharness: 2016-12-15 13:31:39.575368Z] Running clobber step. 05:31:39 INFO - Running pre-action listener: _resource_record_pre_action 05:31:39 INFO - Running main action method: clobber 05:31:39 INFO - rmtree: /builds/slave/test/build 05:31:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:40 INFO - Running post-action listener: _resource_record_post_action 05:31:40 INFO - [mozharness: 2016-12-15 13:31:40.041007Z] Finished clobber step (success) 05:31:40 INFO - [mozharness: 2016-12-15 13:31:40.041106Z] Running read-buildbot-config step. 05:31:40 INFO - Running pre-action listener: _resource_record_pre_action 05:31:40 INFO - Running main action method: read_buildbot_config 05:31:40 INFO - Using buildbot properties: 05:31:40 INFO - { 05:31:40 INFO - "project": "", 05:31:40 INFO - "product": "firefox", 05:31:40 INFO - "script_repo_revision": "production", 05:31:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 05:31:40 INFO - "repository": "", 05:31:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 05:31:40 INFO - "buildid": "20161215052802", 05:31:40 INFO - "stage_platform": "linux64-pgo", 05:31:40 INFO - "basedir": "/builds/slave/test", 05:31:40 INFO - "buildnumber": 2274, 05:31:40 INFO - "platform": "ubuntu64_hw", 05:31:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:31:40 INFO - "slavebuilddir": "test", 05:31:40 INFO - "branch": "mozilla-inbound", 05:31:40 INFO - "revision": "7fe29922e32c564ec9a8e551312d0165d5834fec", 05:31:40 INFO - "slavename": "talos-linux64-ix-002", 05:31:40 INFO - "builduid": "fb9d7a703c514e8fbe3e80aae2c6e0be", 05:31:40 INFO - "repo_path": "integration/mozilla-inbound" 05:31:40 INFO - } 05:31:40 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:31:40 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 05:31:40 INFO - Running post-action listener: _resource_record_post_action 05:31:40 INFO - [mozharness: 2016-12-15 13:31:40.043756Z] Finished read-buildbot-config step (success) 05:31:40 INFO - [mozharness: 2016-12-15 13:31:40.043844Z] Running download-and-extract step. 05:31:40 INFO - Running pre-action listener: _resource_record_pre_action 05:31:40 INFO - Running main action method: download_and_extract 05:31:40 INFO - mkdir: /builds/slave/test/build/tests 05:31:40 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')]} 05:31:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:31:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/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 05:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/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 05:31:40 INFO - Downloaded 1361 bytes. 05:31:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:31:40 INFO - Using the following test package requirements: 05:31:40 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:31:40 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:31:40 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:31:40 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'jsshell-linux-x86_64.zip'], 05:31:40 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:31:40 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:31:40 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:31:40 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:31:40 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:31:40 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:31:40 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:31:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:31:40 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/1481801583/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:31:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:31:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:31:40 INFO - Expected file size: 21776620 05:31:40 INFO - Obtained file size: 21776620 05:31:44 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 05:31:44 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/1481801583/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:31:44 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:31:44 INFO - Expected file size: 21776620 05:31:44 INFO - Obtained file size: 21776620 05:31:49 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/1481801583/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:31:49 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:31:49 INFO - Expected file size: 14409734 05:31:49 INFO - Obtained file size: 14409734 05:31:49 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')]} 05:31:49 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:31:49 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/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 05:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/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 05:31:50 INFO - Downloaded 59760064 bytes. 05:31:50 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:31:50 INFO - mkdir: /builds/slave/test/properties 05:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:50 INFO - Contents: 05:31:50 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:31:50 INFO - Running post-action listener: _resource_record_post_action 05:31:50 INFO - Running post-action listener: set_extra_try_arguments 05:31:50 INFO - [mozharness: 2016-12-15 13:31:50.514558Z] Finished download-and-extract step (success) 05:31:50 INFO - [mozharness: 2016-12-15 13:31:50.514784Z] Running populate-webroot step. 05:31:50 INFO - Running pre-action listener: _resource_record_pre_action 05:31:50 INFO - Running main action method: populate_webroot 05:31:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:50 INFO - '--tppagecycles', 05:31:50 INFO - '7'], 05:31:50 INFO - 'tests': ['tsvgm']}}, 05:31:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:31:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:31:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['damp', 'tps']}, 05:31:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'tests': ['damp', 'tps']}, 05:31:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['dromaeo_dom']}, 05:31:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['basic_compositor_video']}, 05:31:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:31:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['a11yr', 05:31:50 INFO - 'ts_paint', 05:31:50 INFO - 'tpaint', 05:31:50 INFO - 'sessionrestore', 05:31:50 INFO - 'sessionrestore_no_auto_restore', 05:31:50 INFO - 'tabpaint']}, 05:31:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:31:50 INFO - 'ts_paint', 05:31:50 INFO - 'tpaint', 05:31:50 INFO - 'sessionrestore', 05:31:50 INFO - 'sessionrestore_no_auto_restore', 05:31:50 INFO - 'tabpaint']}, 05:31:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:31:50 INFO - 'ts_paint', 05:31:50 INFO - 'tpaint', 05:31:50 INFO - 'sessionrestore', 05:31:50 INFO - 'sessionrestore_no_auto_restore', 05:31:50 INFO - 'tabpaint']}, 05:31:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:31:50 INFO - 'ts_paint', 05:31:50 INFO - 'tpaint', 05:31:50 INFO - 'sessionrestore', 05:31:50 INFO - 'sessionrestore_no_auto_restore', 05:31:50 INFO - 'tabpaint']}, 05:31:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['a11yr', 05:31:50 INFO - 'ts_paint', 05:31:50 INFO - 'tpaint', 05:31:50 INFO - 'sessionrestore', 05:31:50 INFO - 'sessionrestore_no_auto_restore', 05:31:50 INFO - 'tabpaint']}, 05:31:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['a11yr', 05:31:50 INFO - 'ts_paint', 05:31:50 INFO - 'tpaint', 05:31:50 INFO - 'sessionrestore', 05:31:50 INFO - 'sessionrestore_no_auto_restore', 05:31:50 INFO - 'tabpaint']}, 05:31:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['tsvgx', 05:31:50 INFO - 'tsvgr_opacity', 05:31:50 INFO - 'tart', 05:31:50 INFO - 'tscrollx', 05:31:50 INFO - 'cart', 05:31:50 INFO - 'tsvg_static']}, 05:31:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:31:50 INFO - 'tsvgr_opacity', 05:31:50 INFO - 'tart', 05:31:50 INFO - 'tscrollx', 05:31:50 INFO - 'cart', 05:31:50 INFO - 'tsvg_static']}, 05:31:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'talos_options': ['--disable-e10s'], 05:31:50 INFO - 'tests': ['tp5o']}, 05:31:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:31:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'talos_options': ['--disable-e10s', 05:31:50 INFO - '--xperf_path', 05:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:50 INFO - 'tests': ['tp5n']}, 05:31:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:31:50 INFO - 'talos_options': ['--xperf_path', 05:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:50 INFO - 'tests': ['tp5n']}}, 05:31:50 INFO - 'talos.zip': {'path': '', 05:31:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:50 INFO - Running post-action listener: _resource_record_post_action 05:31:50 INFO - [mozharness: 2016-12-15 13:31:50.529950Z] Finished populate-webroot step (success) 05:31:50 INFO - [mozharness: 2016-12-15 13:31:50.530038Z] Running create-virtualenv step. 05:31:50 INFO - Running pre-action listener: _resource_record_pre_action 05:31:50 INFO - Running main action method: create_virtualenv 05:31:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:50 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 05:31:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:50 INFO - Using real prefix '/usr' 05:31:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:53 INFO - Installing pip.................done. 05:31:53 INFO - Return code: 0 05:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:31:53 INFO - Reading from file tmpfile_stdout 05:31:53 INFO - Output received: 05:31:53 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) 05:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:53 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:31:53 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 05:31:53 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 05:31:53 INFO - Using env: {'DISPLAY': ':0', 05:31:53 INFO - 'HOME': '/home/cltbld', 05:31:53 INFO - 'LANG': 'en_US.UTF-8', 05:31:53 INFO - 'LANGUAGE': 'en_US:en', 05:31:53 INFO - 'LOGNAME': 'cltbld', 05:31:53 INFO - 'MAIL': '/var/mail/cltbld', 05:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:53 INFO - 'MOZ_NO_REMOTE': '1', 05:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:53 INFO - 'NO_EM_RESTART': '1', 05:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:53 INFO - 'PWD': '/builds/slave/test', 05:31:53 INFO - 'SHELL': '/bin/bash', 05:31:53 INFO - 'SHLVL': '1', 05:31:53 INFO - 'TERM': 'linux', 05:31:53 INFO - 'TMOUT': '86400', 05:31:53 INFO - 'USER': 'cltbld', 05:31:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:53 INFO - '_': '/tools/buildbot/bin/python'} 05:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:53 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 05:31:53 INFO - Cleaning up... 05:31:53 INFO - Return code: 0 05:31:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:53 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:31:53 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 05:31:53 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 05:31:53 INFO - Using env: {'DISPLAY': ':0', 05:31:53 INFO - 'HOME': '/home/cltbld', 05:31:53 INFO - 'LANG': 'en_US.UTF-8', 05:31:53 INFO - 'LANGUAGE': 'en_US:en', 05:31:53 INFO - 'LOGNAME': 'cltbld', 05:31:53 INFO - 'MAIL': '/var/mail/cltbld', 05:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:53 INFO - 'MOZ_NO_REMOTE': '1', 05:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:53 INFO - 'NO_EM_RESTART': '1', 05:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:53 INFO - 'PWD': '/builds/slave/test', 05:31:53 INFO - 'SHELL': '/bin/bash', 05:31:53 INFO - 'SHLVL': '1', 05:31:53 INFO - 'TERM': 'linux', 05:31:53 INFO - 'TMOUT': '86400', 05:31:53 INFO - 'USER': 'cltbld', 05:31:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:53 INFO - '_': '/tools/buildbot/bin/python'} 05:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:53 INFO - Downloading/unpacking psutil>=3.1.1 05:31:53 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 05:31:53 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 05:31:53 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 05:31:53 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 05:31:53 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 05:31:53 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 05:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:55 INFO - Installing collected packages: psutil 05:31:55 INFO - Running setup.py install for psutil 05:31:55 INFO - building 'psutil._psutil_linux' extension 05:31:55 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 05:31:56 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 05:31:56 INFO - building 'psutil._psutil_posix' extension 05:31:56 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 05:31:56 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 05:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:56 INFO - Successfully installed psutil 05:31:56 INFO - Cleaning up... 05:31:56 INFO - Return code: 0 05:31:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:31: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')]} 05:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:56 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:31:56 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 05:31:56 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 05:31:56 INFO - Using env: {'DISPLAY': ':0', 05:31:56 INFO - 'HOME': '/home/cltbld', 05:31:56 INFO - 'LANG': 'en_US.UTF-8', 05:31:56 INFO - 'LANGUAGE': 'en_US:en', 05:31:56 INFO - 'LOGNAME': 'cltbld', 05:31:56 INFO - 'MAIL': '/var/mail/cltbld', 05:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:56 INFO - 'MOZ_NO_REMOTE': '1', 05:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:56 INFO - 'NO_EM_RESTART': '1', 05:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:56 INFO - 'PWD': '/builds/slave/test', 05:31:56 INFO - 'SHELL': '/bin/bash', 05:31:56 INFO - 'SHLVL': '1', 05:31:56 INFO - 'TERM': 'linux', 05:31:56 INFO - 'TMOUT': '86400', 05:31:56 INFO - 'USER': 'cltbld', 05:31:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:56 INFO - '_': '/tools/buildbot/bin/python'} 05:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:31:56 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 05:31:56 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 05:31:56 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 05:31:56 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 05:31:56 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 05:31:56 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 05:31:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:31:58 INFO - Installing collected packages: mozsystemmonitor 05:31:58 INFO - Running setup.py install for mozsystemmonitor 05:31:58 INFO - Successfully installed mozsystemmonitor 05:31:58 INFO - Cleaning up... 05:31:58 INFO - Return code: 0 05:31:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:31: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')]} 05:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:58 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:31:58 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 05:31:58 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 05:31:58 INFO - Using env: {'DISPLAY': ':0', 05:31:58 INFO - 'HOME': '/home/cltbld', 05:31:58 INFO - 'LANG': 'en_US.UTF-8', 05:31:58 INFO - 'LANGUAGE': 'en_US:en', 05:31:58 INFO - 'LOGNAME': 'cltbld', 05:31:58 INFO - 'MAIL': '/var/mail/cltbld', 05:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:58 INFO - 'MOZ_NO_REMOTE': '1', 05:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:58 INFO - 'NO_EM_RESTART': '1', 05:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:58 INFO - 'PWD': '/builds/slave/test', 05:31:58 INFO - 'SHELL': '/bin/bash', 05:31:58 INFO - 'SHLVL': '1', 05:31:58 INFO - 'TERM': 'linux', 05:31:58 INFO - 'TMOUT': '86400', 05:31:58 INFO - 'USER': 'cltbld', 05:31:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:58 INFO - '_': '/tools/buildbot/bin/python'} 05:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:59 INFO - Downloading/unpacking jsonschema==2.5.1 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 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 05:31:59 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 05:32:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:01 INFO - warning: no files found matching '*.txt' 05:32:01 INFO - no previously-included directories found matching 'build' 05:32:01 INFO - no previously-included directories found matching 'dist' 05:32:01 INFO - no previously-included directories found matching '.git*' 05:32:01 INFO - Installing collected packages: jsonschema, functools32 05:32:01 INFO - Running setup.py install for functools32 05:32:01 INFO - warning: no files found matching '*.txt' 05:32:01 INFO - no previously-included directories found matching 'build' 05:32:01 INFO - no previously-included directories found matching 'dist' 05:32:01 INFO - no previously-included directories found matching '.git*' 05:32:01 INFO - Successfully installed jsonschema functools32 05:32:01 INFO - Cleaning up... 05:32:01 INFO - Return code: 0 05:32:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:01 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')]} 05:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:01 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')]} 05:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:01 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:32:01 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 05:32:01 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 05:32:01 INFO - Using env: {'DISPLAY': ':0', 05:32:01 INFO - 'HOME': '/home/cltbld', 05:32:01 INFO - 'LANG': 'en_US.UTF-8', 05:32:01 INFO - 'LANGUAGE': 'en_US:en', 05:32:01 INFO - 'LOGNAME': 'cltbld', 05:32:01 INFO - 'MAIL': '/var/mail/cltbld', 05:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:01 INFO - 'MOZ_NO_REMOTE': '1', 05:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:01 INFO - 'NO_EM_RESTART': '1', 05:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:01 INFO - 'PWD': '/builds/slave/test', 05:32:01 INFO - 'SHELL': '/bin/bash', 05:32:01 INFO - 'SHLVL': '1', 05:32:01 INFO - 'TERM': 'linux', 05:32:01 INFO - 'TMOUT': '86400', 05:32:01 INFO - 'USER': 'cltbld', 05:32:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:01 INFO - '_': '/tools/buildbot/bin/python'} 05:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:01 INFO - Cleaning up... 05:32:01 INFO - Return code: 0 05:32:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:01 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')]} 05:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:01 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')]} 05:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:01 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:32:01 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 05:32:01 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 05:32:01 INFO - Using env: {'DISPLAY': ':0', 05:32:01 INFO - 'HOME': '/home/cltbld', 05:32:01 INFO - 'LANG': 'en_US.UTF-8', 05:32:01 INFO - 'LANGUAGE': 'en_US:en', 05:32:01 INFO - 'LOGNAME': 'cltbld', 05:32:01 INFO - 'MAIL': '/var/mail/cltbld', 05:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:01 INFO - 'MOZ_NO_REMOTE': '1', 05:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:01 INFO - 'NO_EM_RESTART': '1', 05:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:01 INFO - 'PWD': '/builds/slave/test', 05:32:01 INFO - 'SHELL': '/bin/bash', 05:32:01 INFO - 'SHLVL': '1', 05:32:01 INFO - 'TERM': 'linux', 05:32:01 INFO - 'TMOUT': '86400', 05:32:01 INFO - 'USER': 'cltbld', 05:32:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:01 INFO - '_': '/tools/buildbot/bin/python'} 05:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 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 05:32:01 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 05:32:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:03 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 05:32:03 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 05:32:03 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 05:32:03 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 05:32:03 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 05:32:03 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 05:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:04 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 05:32:04 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 05:32:04 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 05:32:04 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 05:32:04 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 05:32:04 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 05:32:04 INFO - Downloading docopt-0.6.1.tar.gz 05:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:04 INFO - Running setup.py install for blobuploader 05:32:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:04 INFO - Running setup.py install for requests 05:32:05 INFO - Running setup.py install for docopt 05:32:05 INFO - Successfully installed blobuploader requests docopt 05:32:05 INFO - Cleaning up... 05:32:05 INFO - Return code: 0 05:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:05 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:32:05 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 05:32:05 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 05:32:05 INFO - Using env: {'DISPLAY': ':0', 05:32:05 INFO - 'HOME': '/home/cltbld', 05:32:05 INFO - 'LANG': 'en_US.UTF-8', 05:32:05 INFO - 'LANGUAGE': 'en_US:en', 05:32:05 INFO - 'LOGNAME': 'cltbld', 05:32:05 INFO - 'MAIL': '/var/mail/cltbld', 05:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:05 INFO - 'MOZ_NO_REMOTE': '1', 05:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:05 INFO - 'NO_EM_RESTART': '1', 05:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:05 INFO - 'PWD': '/builds/slave/test', 05:32:05 INFO - 'SHELL': '/bin/bash', 05:32:05 INFO - 'SHLVL': '1', 05:32:05 INFO - 'TERM': 'linux', 05:32:05 INFO - 'TMOUT': '86400', 05:32:05 INFO - 'USER': 'cltbld', 05:32:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:05 INFO - '_': '/tools/buildbot/bin/python'} 05:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:05 INFO - Running setup.py (path:/tmp/pip-JvrITw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:05 INFO - Running setup.py (path:/tmp/pip-lNLwNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:05 INFO - Running setup.py (path:/tmp/pip-_9H71D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:05 INFO - Running setup.py (path:/tmp/pip-fUVmPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:05 INFO - Running setup.py (path:/tmp/pip-F3mHom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:05 INFO - Running setup.py (path:/tmp/pip-re0bju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:05 INFO - Running setup.py (path:/tmp/pip-WUI27p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:06 INFO - Running setup.py (path:/tmp/pip-LND6fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:06 INFO - Running setup.py (path:/tmp/pip-QTzrwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:06 INFO - Running setup.py (path:/tmp/pip-UJCucr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:06 INFO - Running setup.py (path:/tmp/pip-t2Pgi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:06 INFO - Running setup.py (path:/tmp/pip-QW4AGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:06 INFO - Running setup.py (path:/tmp/pip-pW36S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:06 INFO - Running setup.py (path:/tmp/pip-52Pd0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:06 INFO - Running setup.py (path:/tmp/pip-A12gX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:06 INFO - Running setup.py (path:/tmp/pip-tOJkba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:06 INFO - Running setup.py (path:/tmp/pip-sftXzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:06 INFO - Running setup.py install for manifestparser 05:32:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:06 INFO - Running setup.py install for mozcrash 05:32:06 INFO - Running setup.py install for mozdebug 05:32:07 INFO - Running setup.py install for mozdevice 05:32:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Running setup.py install for mozfile 05:32:07 INFO - Running setup.py install for mozhttpd 05:32:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Running setup.py install for mozinfo 05:32:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Running setup.py install for mozInstall 05:32:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Running setup.py install for mozleak 05:32:07 INFO - Running setup.py install for mozlog 05:32:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Running setup.py install for moznetwork 05:32:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Running setup.py install for mozprocess 05:32:08 INFO - Running setup.py install for mozprofile 05:32:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Running setup.py install for mozrunner 05:32:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Running setup.py install for mozscreenshot 05:32:08 INFO - Running setup.py install for moztest 05:32:08 INFO - Running setup.py install for mozversion 05:32:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:08 INFO - Cleaning up... 05:32:08 INFO - Return code: 0 05:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:08 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')]} 05:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:08 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')]} 05:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:08 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:32:08 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 05:32:08 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 05:32:08 INFO - Using env: {'DISPLAY': ':0', 05:32:08 INFO - 'HOME': '/home/cltbld', 05:32:08 INFO - 'LANG': 'en_US.UTF-8', 05:32:08 INFO - 'LANGUAGE': 'en_US:en', 05:32:08 INFO - 'LOGNAME': 'cltbld', 05:32:08 INFO - 'MAIL': '/var/mail/cltbld', 05:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:08 INFO - 'MOZ_NO_REMOTE': '1', 05:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:08 INFO - 'NO_EM_RESTART': '1', 05:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:08 INFO - 'PWD': '/builds/slave/test', 05:32:08 INFO - 'SHELL': '/bin/bash', 05:32:08 INFO - 'SHLVL': '1', 05:32:08 INFO - 'TERM': 'linux', 05:32:08 INFO - 'TMOUT': '86400', 05:32:08 INFO - 'USER': 'cltbld', 05:32:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:08 INFO - '_': '/tools/buildbot/bin/python'} 05:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:08 INFO - Running setup.py (path:/tmp/pip-XtU0K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:08 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)) 05:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:08 INFO - Running setup.py (path:/tmp/pip-2UeLOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:08 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)) 05:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:08 INFO - Running setup.py (path:/tmp/pip-bdVu3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:09 INFO - Running setup.py (path:/tmp/pip-2Pkdru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:09 INFO - Running setup.py (path:/tmp/pip-i3fbX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:09 INFO - Running setup.py (path:/tmp/pip-nNpE3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:09 INFO - Running setup.py (path:/tmp/pip-reQa8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:09 INFO - Running setup.py (path:/tmp/pip-yyQc8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:09 INFO - Running setup.py (path:/tmp/pip-Jk_4P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:09 INFO - Running setup.py (path:/tmp/pip-ygfqV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:09 INFO - Running setup.py (path:/tmp/pip-2QDHEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:09 INFO - Running setup.py (path:/tmp/pip-eW5IPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:09 INFO - Running setup.py (path:/tmp/pip-8Z7Qgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:09 INFO - Running setup.py (path:/tmp/pip-StTlXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:09 INFO - Running setup.py (path:/tmp/pip-vaNdRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:09 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)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:09 INFO - Running setup.py (path:/tmp/pip-nSm_jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:09 INFO - Running setup.py (path:/tmp/pip-vrUJSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 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)) 05:32:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:10 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 05:32:10 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 05:32:10 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 05:32:10 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 05:32:10 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 05:32:10 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 05:32:12 INFO - Downloading blessings-1.6.tar.gz 05:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:12 INFO - Installing collected packages: blessings 05:32:12 INFO - Running setup.py install for blessings 05:32:12 INFO - Successfully installed blessings 05:32:12 INFO - Cleaning up... 05:32:12 INFO - Return code: 0 05:32:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:12 INFO - Reading from file tmpfile_stdout 05:32:12 INFO - Current package versions: 05:32:12 INFO - argparse == 1.2.1 05:32:12 INFO - blessings == 1.6 05:32:12 INFO - blobuploader == 1.2.4 05:32:12 INFO - docopt == 0.6.1 05:32:12 INFO - functools32 == 3.2.3-2 05:32:12 INFO - jsonschema == 2.5.1 05:32:12 INFO - manifestparser == 1.1 05:32:12 INFO - mozInstall == 1.12 05:32:12 INFO - mozcrash == 1.0 05:32:12 INFO - mozdebug == 0.1 05:32:12 INFO - mozdevice == 0.49 05:32:12 INFO - mozfile == 1.2 05:32:12 INFO - mozhttpd == 0.7 05:32:12 INFO - mozinfo == 0.9 05:32:12 INFO - mozleak == 0.1 05:32:12 INFO - mozlog == 3.4 05:32:12 INFO - moznetwork == 0.27 05:32:12 INFO - mozprocess == 0.23 05:32:12 INFO - mozprofile == 0.28 05:32:12 INFO - mozrunner == 6.13 05:32:12 INFO - mozscreenshot == 0.1 05:32:12 INFO - mozsystemmonitor == 0.3 05:32:12 INFO - moztest == 0.7 05:32:12 INFO - mozversion == 1.4 05:32:12 INFO - psutil == 3.1.1 05:32:12 INFO - requests == 1.2.3 05:32:12 INFO - wsgiref == 0.1.2 05:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:12 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')]} 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:12 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')]} 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:12 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:32:12 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 05:32:12 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 05:32:12 INFO - Using env: {'DISPLAY': ':0', 05:32:12 INFO - 'HOME': '/home/cltbld', 05:32:12 INFO - 'LANG': 'en_US.UTF-8', 05:32:12 INFO - 'LANGUAGE': 'en_US:en', 05:32:12 INFO - 'LOGNAME': 'cltbld', 05:32:12 INFO - 'MAIL': '/var/mail/cltbld', 05:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:12 INFO - 'MOZ_NO_REMOTE': '1', 05:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:12 INFO - 'NO_EM_RESTART': '1', 05:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:12 INFO - 'PWD': '/builds/slave/test', 05:32:12 INFO - 'SHELL': '/bin/bash', 05:32:12 INFO - 'SHLVL': '1', 05:32:12 INFO - 'TERM': 'linux', 05:32:12 INFO - 'TMOUT': '86400', 05:32:12 INFO - 'USER': 'cltbld', 05:32:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:12 INFO - '_': '/tools/buildbot/bin/python'} 05:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 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)) 05:32:12 INFO - Cleaning up... 05:32:12 INFO - Return code: 0 05:32:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:12 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')]} 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:12 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')]} 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:12 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 0x7f855520ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', '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 05:32:12 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 05:32:12 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 05:32:12 INFO - Using env: {'DISPLAY': ':0', 05:32:12 INFO - 'HOME': '/home/cltbld', 05:32:12 INFO - 'LANG': 'en_US.UTF-8', 05:32:12 INFO - 'LANGUAGE': 'en_US:en', 05:32:12 INFO - 'LOGNAME': 'cltbld', 05:32:12 INFO - 'MAIL': '/var/mail/cltbld', 05:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:12 INFO - 'MOZ_NO_REMOTE': '1', 05:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:12 INFO - 'NO_EM_RESTART': '1', 05:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:12 INFO - 'PWD': '/builds/slave/test', 05:32:12 INFO - 'SHELL': '/bin/bash', 05:32:12 INFO - 'SHLVL': '1', 05:32:12 INFO - 'TERM': 'linux', 05:32:12 INFO - 'TMOUT': '86400', 05:32:12 INFO - 'USER': 'cltbld', 05:32:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:12 INFO - '_': '/tools/buildbot/bin/python'} 05:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:12 INFO - Cleaning up... 05:32:12 INFO - Return code: 0 05:32:12 INFO - Running post-action listener: _resource_record_post_action 05:32:12 INFO - Running post-action listener: _start_resource_monitoring 05:32:13 INFO - Starting resource monitoring. 05:32:13 INFO - [mozharness: 2016-12-15 13:32:13.011482Z] Finished create-virtualenv step (success) 05:32:13 INFO - [mozharness: 2016-12-15 13:32:13.011959Z] Running install step. 05:32:13 INFO - Running pre-action listener: _resource_record_pre_action 05:32:13 INFO - Running main action method: install 05:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:13 INFO - Reading from file tmpfile_stdout 05:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:13 INFO - Reading from file tmpfile_stdout 05:32:13 INFO - Output received: 05:32:13 INFO - Usage: mozinstall [options] installer 05:32:13 INFO - Options: 05:32:13 INFO - -h, --help show this help message and exit 05:32:13 INFO - -d DEST, --destination=DEST 05:32:13 INFO - Directory to install application into. [default: 05:32:13 INFO - "/builds/slave/test"] 05:32:13 INFO - --app=APP Application being installed. [default: firefox] 05:32:13 INFO - mkdir: /builds/slave/test/build/application 05:32:13 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'] 05:32:13 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 05:32:30 INFO - Reading from file tmpfile_stdout 05:32:30 INFO - Output received: 05:32:30 INFO - /builds/slave/test/build/application/firefox/firefox 05:32:30 INFO - Running post-action listener: _resource_record_post_action 05:32:30 INFO - [mozharness: 2016-12-15 13:32:30.275129Z] Finished install step (success) 05:32:30 INFO - [mozharness: 2016-12-15 13:32:30.275399Z] Running run-tests step. 05:32:30 INFO - Running pre-action listener: _resource_record_pre_action 05:32:30 INFO - Running main action method: run_tests 05:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:30 INFO - Python 2.7.3 05:32:30 INFO - Return code: 0 05:32:30 INFO - grabbing minidump binary from tooltool 05:32: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')]} 05:32:30 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 0x18ebf20>, '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 0x1858c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:30 INFO - Return code: 0 05:32:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:32:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:32:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:32:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:32:30 INFO - Using env: {'DISPLAY': ':0', 05:32:30 INFO - 'HOME': '/home/cltbld', 05:32:30 INFO - 'LANG': 'en_US.UTF-8', 05:32:30 INFO - 'LANGUAGE': 'en_US:en', 05:32:30 INFO - 'LOGNAME': 'cltbld', 05:32:30 INFO - 'MAIL': '/var/mail/cltbld', 05:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:30 INFO - 'MOZ_NO_REMOTE': '1', 05:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:30 INFO - 'NO_EM_RESTART': '1', 05:32:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:30 INFO - 'PWD': '/builds/slave/test', 05:32:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:30 INFO - 'SHELL': '/bin/bash', 05:32:30 INFO - 'SHLVL': '1', 05:32:30 INFO - 'TERM': 'linux', 05:32:30 INFO - 'TMOUT': '86400', 05:32:30 INFO - 'USER': 'cltbld', 05:32:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271', 05:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:30 INFO - '_': '/tools/buildbot/bin/python'} 05:32:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:32:30 INFO - mozversion application_buildid: 20161215033303 05:32:30 INFO - mozversion application_changeset: 7fe29922e32c564ec9a8e551312d0165d5834fec 05:32:30 INFO - mozversion application_display_name: Nightly 05:32:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:30 INFO - mozversion application_name: Firefox 05:32:30 INFO - mozversion application_remotingname: firefox 05:32:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:32:30 INFO - mozversion application_vendor: Mozilla 05:32:30 INFO - mozversion application_version: 53.0a1 05:32:30 INFO - mozversion platform_buildid: 20161215033303 05:32:30 INFO - mozversion platform_changeset: 7fe29922e32c564ec9a8e551312d0165d5834fec 05:32:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:32:30 INFO - mozversion platform_version: 53.0a1 05:32:30 INFO - using testdate: 1481808750 05:32:30 INFO - actual date: 1481808750 05:32:30 INFO - starting webserver on 'localhost:38598' 05:32:30 INFO - SUITE-START | Running 2 tests 05:32:30 INFO - TEST-START | dromaeo_css 05:32:30 INFO - operating with platform_type : linux_ 05:32:30 INFO - Initialising browser for dromaeo_css test... 05:32:30 INFO - TEST-INFO | started process 19825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI94NVp/profile http://localhost:38598/getInfo.html) 05:32:34 INFO - PROCESS | 19825 | __metrics Screen width/height:1600/1200 05:32:34 INFO - PROCESS | 19825 | colorDepth:24 05:32:34 INFO - PROCESS | 19825 | Browser inner width/height: 1024/697 05:32:34 INFO - PROCESS | 19825 | __metrics 05:32:35 INFO - PROCESS | 19825 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:32:35 INFO - PROCESS | 19825 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:35 INFO - PROCESS | 19825 | console.error: PushService: 05:32:35 INFO - PROCESS | 19825 | stateChangeProcessEnqueue: Error transitioning state 05:32:35 INFO - PROCESS | 19825 | UnknownError 05:32:36 INFO - TEST-INFO | 19825: exit 0 05:32:36 INFO - Browser initialized. 05:32:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:36 INFO - TEST-INFO | started process 19906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI94NVp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:48 INFO - PROCESS | 19906 | RSS: Main: 172126208 05:32:48 INFO - PROCESS | 19906 | 05:33:39 INFO - PROCESS | 19906 | 1481808819683 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:35:51 INFO - PROCESS | 19906 | Cycle 1(1): loaded http://localhost:38598/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38598/tests/dromaeo/cssquery-ext.html) 05:35:52 INFO - PROCESS | 19906 | RSS: Main: 241070080 05:35:52 INFO - PROCESS | 19906 | 05:38:55 INFO - PROCESS | 19906 | Cycle 1(1): loaded http://localhost:38598/tests/dromaeo/cssquery-ext.html (next: http://localhost:38598/tests/dromaeo/cssquery-jquery.html) 05:38:55 INFO - PROCESS | 19906 | RSS: Main: 282525696 05:38:55 INFO - PROCESS | 19906 | 05:41:57 INFO - PROCESS | 19906 | Cycle 1(1): loaded http://localhost:38598/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38598/tests/dromaeo/cssquery-mootools.html) 05:41:58 INFO - PROCESS | 19906 | RSS: Main: 220925952 05:41:58 INFO - PROCESS | 19906 | 05:45:00 INFO - PROCESS | 19906 | Cycle 1(1): loaded http://localhost:38598/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38598/tests/dromaeo/cssquery-prototype.html) 05:45:01 INFO - PROCESS | 19906 | RSS: Main: 276963328 05:45:01 INFO - PROCESS | 19906 | 05:48:03 INFO - PROCESS | 19906 | Cycle 1(1): loaded http://localhost:38598/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38598/tests/dromaeo/cssquery-yui.html) 05:48:04 INFO - PROCESS | 19906 | RSS: Main: 219811840 05:48:04 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | Cycle 1(1): loaded http://localhost:38598/tests/dromaeo/cssquery-yui.html (next: http://localhost:38598/tests/dromaeo/cssquery-dojo.html) 05:51:07 INFO - PROCESS | 19906 | RSS: Main: 314540032 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | __start_tp_report 05:51:07 INFO - PROCESS | 19906 | _x_x_mozilla_page_load 05:51:07 INFO - PROCESS | 19906 | _x_x_mozilla_page_load_details 05:51:07 INFO - PROCESS | 19906 | |i|pagename|runs| 05:51:07 INFO - PROCESS | 19906 | |0;dojo.html;3041.756659467242;3092.5361195820637;3094.0099168266156;3113.2216945763544;3116.0184541869307;5259.474052594738;5286.127788914824;5326.7070311132875;5342.492463215993;5366.382865970415;5435.972820135894;5437.293151890259;5441.238226648273;5443.401225865152;5446.455354464551;4902.191138462158;4928.137575924216;4948.356713627223;4979.60163186946;4992.77532511036;4877.244027175776;4907.165781817082;4940.135476291653;4952.851414457554;4962.801487940496;4902.4852390498845;4906.31311616374;4908.852734417973;4948.8267910623135;4949.307097006422;4926.137925862996;4934.309196712463;4942.703437793743;4945.357103576512;4980.775865086043;4735.479097299294;4742.644301677354;4809.567138957475;4875.780589873429;4903.215485522299;5273.472652734734;5397.109476936301;5398.8920221595345;5419.078756611386;5431.103867861798;5787.942120578782;5792.073268277098;5809.535237181058;5815.73829177688;5816.563757718188;5614.045612245928;5817.040188368914;5848.181254624356;5849.532037437038;5858.912116318259;5301.125314323132;5366.436524164985;5367.704776237305;5369.892602147936;5373.032854086224;5835.912461313083;5842.269716285465;5842.707864606753;5865.061590145556;5898.380670029585;5732.054211055212;5736.68448235351;5754;5754.798582049608;5758.7696492140685;5708.372079071299;5749.338826035059;5756.222909907193;5760.6255593386295;5762.769489220468;5771.163181338767;5776.306843178845;5789.913151302734;5791.044477661223;5796.5072968797285;5511.090670039479;5559.694216818033;5643.40744221859;5674.687892165971;5681.886362272814;4448.199324121624;4448.933266001012;4450.910981780346;4456.064226512404;4457.710248833815;3919.9216015679526;3923.0388554804254;3928.5678575356687;3957.8416863325147;3965.107850733562;5440.102383106743;5442.292501974797;5442.455754424605;5449.5640348772;5449.918251226156;5641.52047075995;5688.772449102073;5701.486866182064;5705.087186050212;5731.398203188689;5412.972935135299;5452.754626041838;5453.672779633234;5454.7272636368025;5488.615796894259;5002.52476014778;5006.374203224597;5007.824726134568;5011.198208286657;5047.899042019212;5682.971585142048;5695.686737229492;5745.425457454221;5797.652140871562;5920.881582368328;5635.88728225425;5737.282839645044;5777.411211916757;5778.133280008033;5779.364269930388;5890.823275301748;5894.2926848778425;5895.734691938787;5898.852528686817;5899.882002359843;5652.236948012131;5654.971725141512;5655.236543066633;5657;5657.26455560791;5527.613067085265;5647.322321321468;5671.602987790815;5693.9715301424885;5719.342275638189;5636.605437619327;5637.126245431965;5637.351704554028;5642.23829782974;5673.290838645169;5571.554275658019;5578.191162281528;5579.69311687861;5581.6930068846605;5584.218209450599;5339.759710812945;5378.811741589026;5457.099578569491;5499.615026948235;5565.638233514808;5693.430656934273;5726.255586773693;5727.914081288701;5750.712464376848;5765.827025189251;5358.303420555303;5388.38033626138;5397.460253974728;5401.081816091195;5593.748281327269 05:51:07 INFO - PROCESS | 19906 | |1;ext.html;514.339074289538;558.9944100558993;562.2578196780249;573.905305624572;578.158778976589;31330.53004204936;39802.40296395553;42499.99999999996;42500.36249456261;45578.772106139426;43242.783786081025;43760.343594846105;43810.56189438105;43871.56128438715;43947.78026109865;7807.96096019522;8588.828223435528;8790.736277911672;8790.86813697795;8798.780030499256;7725.652345644431;10036.447995360253;10329.638462653771;10330.12193963514;10576.841347379795;10364.067233948943;10414.32306900053;10430.426326552037;10432.530536125854;10436;10285;10344.741381465523;10361.171106311514;10383.376997380181;10386.324888882198;10263.948680256626;10326.22553308505;10341.638042668546;10344.5344959477;10345.586176552928;41440.58559414397;41574.37638435426;41684.1663166738;41721.374179387334;41801.372979405336;3397.8980630581123;3403.676650718178;3517.683408493248;3534.204803919123;3986.66113380363;30720.69279307201;31135.06594802137;31142;31361.215969600715;31392.843035784674;4110.095778928631;4225.68307376948;4229.344451610005;4255.957440425587;4307.375430562551;324679;324912;325291;325432;325627;58169;58359;58510.41489585135;58717.41282587205;58830.411695882496;61100.38899610947;61166;61245.38754612486;61304;61348;14514.637134071521;14840.257987100602;14852.183129927958;14870.702585948437;14871.18208498543;10228.48857557134;10522.158227341948;11062.612808551823;11476.081913446904;11574.942125289488;16554.83445165557;17128.74306885398;17266.827331726774;17342.3063077478;17424.564385890455;6540.934590654033;6814.420774234246;6909.723611055501;6922.5154239203775;7019.298070193042;869.9869501957476;955.7909244805327;969.6170012844887;1013.3261381181579;1044.3733759744093;31033.534496982564;31777.68222317747;31842.681573184436;31845.840770795996;32385;1040.9739756505996;1104.7017305327677;1109.5395410904546;1129.7119234595125;1134.0304040045808;16183.919080404523;16533.751993720103;16736.330546777994;16903.239354228845;17003.82996170047;459791;463135;463587.6820615875;464855;464934;56442.15336769952;56472.43527564754;56577;56855.43144568584;56875;1171.3616079236836;1209.727811242481;1257.3650306595293;1275.4643049919057;1316.7629826631107;28814.855925720236;32750.508742368405;32851.50722739113;32976.67023329736;33381.49927751037;48771.5122848767;49452.752736236085;49475;49489;49493;356466;357028;357108;357292;358381;38907;39957.60042399539;40634.593654064265;40679.38980915229;40878.59121408748;41386;42448.78775606102;46247.76876115598;46478.07043859171;46688.53311466978;34020.65979340274;38995.220095598495;39491.80254098711;40505;40742;32797.836010819796;35352;35623.82188089147;35642;37004;35841.46237806383;36148.81925590355;36300.27399451943;36796.63203368039;37149.814250928575;31016.379672406878;31748.365032698755;31871.68128318687;32352.676473235908;32468.188295292806;25483.490330192923;25503;25722.228333150037;25728.59699463059;26127 05:51:07 INFO - PROCESS | 19906 | |2;jquery.html;360.3567631777278;370.1259718287498;385.7858888316984;387.63755888244486;403.10108458138353;14387.352569134388;14425.278736063194;16408.425705100322;19076;19203.615927681472;18119.909400453012;18353.357632482865;18666.06669666518;18697.34559290425;18792.15435305411;5463.043967305725;5673.8297851064535;5725.713714314267;5727.3699893011735;5731.398203188668;4703.623710103184;5553.944460555384;6175;6207.441330280274;6310.968445157768;6218.098375735515;6266;6272.40412160844;6274.090256912745;6274.4353008229255;6116.785912493041;6205.844853878667;6208.161898143738;6220.035894436347;6227.750889964396;4729.929051064202;4949.356583644139;5511.862203444906;5514.641548299348;5518.91721624176;11894.643160705193;12010.519579216909;12117.575884844076;12118.697032574257;12121.575744848888;2020.7373041504657;2153.181790919456;2208.9024858886696;2218.7892150245702;2758.2690586994463;8614.698485553039;8737.60680769367;8781.868271975925;8826.161514656098;9477.147056764925;1808.3128411203659;1813.1750053725523;1848.5286252005787;1850.3523766681553;1874.3065065925696;52769.73615131938;57959;60152;71835;80226;9636.831712864549;10341.896581034094;10777.08394786452;10838.07876330505;10842.728931776612;14480.710385792225;14596.562103136923;14629.853701463062;14696.853031469549;14697.559073227607;7229.638518074075;7295.854082918312;7476.214997425301;7482.738104166328;7549.2073332300415;6692.83267918306;6728.529002969745;6856.086764274828;6944;7309.195988441267;4086.223617512663;4140.171965606891;4550.954490455119;4580.908381832344;4678.742669153161;1736.8610511159077;1890.6502297075085;1896.497428181533;1934.032983508246;1994.9002549872448;892.7054072156172;907.4555266839843;1000.9649662261786;1005.2862467647906;1008.3193844155165;17496.300147994192;18928;18975.33586324472;19225.51936201578;19373.900175971776;921.6405601815297;943.6838659049158;950.6007476859736;983.3018556824592;1010.3230835340339;9339.486328252011;9857.802843943224;10564.524596393181;10577;10587.947060264649;189181;189495;189513;418537;418541;73241;84347;86992;87488;88366;939.1641439119189;1003.4531180506641;1043.956043956044;1056.498163372392;1057.582255009267;16062.759058614363;17055.829441705424;17165.742513862053;17489.475315740547;17518.649627007133;32990.34019319648;33947.05926462908;37953.4306985401;39019.6098039016;39030.82907512779;52414.47585524248;52860.471395287095;53867.73066134644;55279;55396;6985.755498557729;7354.117505899327;7458.47790654649;7594.734184303523;7836.216378362118;9194.95402522983;11509.884901151216;11727.47226374798;12019.63941081769;12187.817182742088;10851.945740271249;10856.837147442637;11042.116630669689;11047.944760276469;11243.212975091665;10470.738231544272;10724.678259652223;10787.029167374974;10936.617218397318;11092.556297748;10882.238243322892;11153.83269250978;11213.327200368005;11264.267822591833;11539.4807233673;7470.701171953061;7617.390608751398;7772.417068719756;7823.960880195563;8080.555569443737;8687.435316704394;10825.621103261348;10914.290571112851;10982.725431864268;11114.88885111171 05:51:07 INFO - PROCESS | 19906 | |3;mootools.html;1301.8698130186988;1354.383755391297;1357.945682172713;1458.2562892924605;1651.364224773462;6776.390124888759;7762.96118519408;7800.414968877342;7808.14110447851;8147.470414423058;7679.424043196755;7809.219078092202;7823.726169584065;7996.920030799704;8028.277455029046;1858.5260758506563;1922.432882299718;2066.4420606436292;2116;2117.8093971542557;2093.9895300523476;2155.7844215578393;2157.805797478227;2166.079416248096;2168.5879682860286;2068.6896965455226;2077.542940553076;2088.33173384517;2088.3943656339643;2090.383336915606;2080.365488525999;2085.2180432337873;2108.5255817441107;2111.102781317941;2114.164904862586;2066.2354928676336;2072.927447539329;2087.3633541769755;2100.023489077571;2102.390306811023;7833.49082309648;7926.048874135141;7929.841403171962;7931.286184243446;7977.840443191161;4703.459102203256;4798.928016079762;4799.2801079837955;4806.8077276909235;4809.519048095198;2953.12882699602;3102.8758849645988;3140.733037691776;3143.669914658951;3190.170555655523;1048.7535429174138;1094.3488624268548;1103.757173421846;1126.9436528173558;1161.7269941563725;10825.350478971286;11089.72275693106;11097.38964356968;11116.44417779116;11118.833217501744;3982.4026396040827;4161.313383291723;4181.498220213533;4239.27932251518;4255.510616279105;9321.813563728687;9329.34694571387;9337.3930694506;9341.859872101924;9344.813103737888;4837.2260438329695;4838.903221935612;4840.6127509799135;4841.2496063110275;4843.830465933675;3619.60184379718;3761.4169803680475;4412.117576484716;4428.092241090569;4457.153140903218;3620.800855952948;3679.68722658577;3733.4586484959527;3765.9435108473394;3794.886153415402;1189.8929096381194;1210.5581462766027;1219.2928101700993;1219.451246938881;1226.3071364679106;767.5739964319745;853.4409961475244;879.9032106468284;894.2443635128307;905.8188362327561;5265.868353291122;5531.059719847635;5549.861253468614;5578.665280083208;5677.630953987978;383.71413297093284;386.94750279240424;393.94681717967705;394.77892380267144;394.9308870947573;3706.5552133744122;3713.8700145494777;3717.9070523237137;3730.421784623388;3877.166409222031;9249.95375023134;9650.179734722487;9729.756756081155;9827.213822894151;9890.357126786736;9846.556904939294;9885.50572471388;9894.257930655229;9896.505174741234;9900.059494348025;7363.963180184065;7451.403887688972;7455.627218639155;7503.287187717049;7517.511361761468;5400.162974738922;5415.300356687625;5452.372977107683;5569.443055694398;5637.8590535236945;8958.417702849294;8962.32782541299;8985.19133277982;9027.4132181408;9055.592498337459;8709.433886797338;8965.327600430124;8977;8986.415882967585;9281.628734850801;6874.690638921161;7065.399441047569;7069.257727938492;7278.454115941219;7424.406047516294;7134.072570565793;7192.892106618509;7328;7485.925140748741;7555.320021198118;6845.726170953106;6926.826829329307;6973.721051157897;6993.475489338218;7013.193482749549;6499.252585952676;6589.47284217271;6821.249662537018;6823.147106611674;6880.243173251039;6503.707333170113;6513.576617519846;6566.573172743756;6630.834229144117;6631.867362652816;4622.468416132053;4626.329182268485;4756.453007904135;4759.6668233223345;4935;4861.149298872754;4948.356713627206;5052.065367906949;5072.619553533426;5130.6152038598 05:51:07 INFO - PROCESS | 19906 | |4;prototype.html;319.87045246675075;331.941910165721;336.56583007919784;337.6066882082374;344.06071425009736;4991.301217829498;5071.797128114876;5122.897542049157;5135.178371460572;5174.586033117351;4985.875353116174;5069.74651267437;5074.898502029966;5087.821926232583;5109.846704598868;4093.035343035345;4099.282625540526;4101.26177288088;4110.362893751459;4124.587541245866;3950.762954222756;4125.113100683352;4144.114427935282;4165.229432554987;4169.708120431571;4097.549269580344;4099.29446565267;4100.79496025199;4125.876223713279;4128.153728485669;4083.530394004698;4083.5508094109623;4102.569230230828;4110.486189226347;4120.866761640543;3688.2623475304777;3688.9157625941525;3696.741228114033;3699.2971335446177;3704.3147017801793;4867.902641947177;5099.71951542665;5113.7471319526585;5127.794968182474;5136.5377116059735;4699.906001879977;4706.152892479352;4707.481497398875;4710.175719249118;4730.455997560256;5392.514673679349;5409.83770486886;5457.208704737831;5459.836204913859;5459.863503412406;3844.38489841624;3965.4646622705854;3993.7204395692315;3999.9400008999887;4060.1473690525027;5560.944390556124;5585;5609.551235901159;5621.3298683125595;5676.176954341598;4048.4332193492933;4066.8576599818866;4072.38914162872;4085;4099.754014759124;4047.615476529784;4048.8380464781667;4053.2704113259897;4156.334986402161;4161.667066634662;4596.517365676623;4596.575061730874;4599.218132917412;4601.148787474328;4605.378273932976;5442.591805614516;5442.986095144822;5460.215290202025;5485.835424937259;5488.231647569343;1323.3184909771476;1346.73065386923;1359.4426285223012;1379.5585412668052;1390.4090761426353;949.7055912667096;975.658519518163;981.9509024548887;990.5938565188238;998.3710262534556;5065.2778055460585;5079.873003174876;5092.770825312869;5098.898022039612;5102.183650615883;5408;5413.188021796762;5418.701971391612;5437.864053398617;5438.755256013489;4763.831243101274;4982.725950072709;5005.974970125126;5032.345795046694;5056.469070747518;2796.203082121586;2799;2832.7960616737805;2839.849860806377;2848.1597928610695;5417.620766546383;5431.474364420564;5443.591730620219;5452.972735136299;5468.28912241414;5324.760385782649;5394.595405344615;5400.29365652143;5468.371137319259;5499.370415525734;5456.399796022434;5476.1666833217705;5505.724713764296;5507.366652834815;5526.613137080446;5268.736563171903;5339.679619222859;5380.354357477127;5406.540444062299;5452.645578037414;5053.797848086182;5233.53461030912;5280.551153152025;5283.682979021271;5307.52232299095;5379.946200537945;5432.049391356418;5436.293281873332;5450.31871016123;5456;3903.3457249070902;3918.1967696622696;3955.3473676843;3992.421098940579;3993.1414745829784;5243.58051355883;5298;5461.235427040297;5476.12382018891;5501.5323697486165;5267.710275934707;5296.3379577552805;5467.425920278313;5474.151506516497;5492.450754924475;5423.29497165366;5429.728513574384;5443.482869127427;5448.210009548672;5472.398036216093;5204.724134664771;5377;5395.433479484597;5401.729913504388;5411;5427;5451.7274136292235;5459.208414779914;5459.235707001102;5489.231507588861;5343.465653434625;5368.785248590013;5368.919466207932;5385.111456609616;5394.460553944574 05:51:07 INFO - PROCESS | 19906 | |5;yui.html;704.6265479295972;725.8548290341932;757.503834988083;783.2011348424603;794.7615715285415;15674;16434.260458279376;16445.342186312548;16464.67070658586;16482.340706371746;15211.847881521182;15424.383024679028;15436.61408464789;15458.681197820333;15475;665.9667016649172;685.8285428642839;774.2489784908657;781.3670926549499;798.2616080125889;791.8812178173263;796.9721059762909;798.5248776977689;802.9397795165356;803.7267329108103;842.9926238145418;844.7127976487993;846.090452763282;846.6444093480723;846.652872322348;834.4951304460775;835.2774849754979;835.5529791561546;835.8871552340447;836.2390224895346;512.3416409913281;527.419838178005;598.1386803003661;612.791650838717;618.4403115180769;14743.926280368636;14771.113733176044;14828.851711482856;14907.478238261609;14959.700805983819;13584;14054.156750594997;14125.858741412558;14152.575422737335;14202.50291239812;11406.42967851604;11655.125865560118;12239.75520489594;12296.323702196376;12579.874201257962;4352.542982986804;4365.236083685342;4367.148406060819;4369.410129632491;4419.42547468827;75182.24817751808;75302.62348688222;75849.62075189588;76788;76984.61507692482;10822.891771082188;10874.18443616732;10979.945100274606;11128.888711112948;11148.494953181216;20289.492762680755;20293.49266268355;20310;20329.390118296476;20333.796662033485;7841.098273698483;7870.094939082079;7995.320397766255;8064.395170362246;8228.42401031934;4365.388845561624;4413.889652758642;4420.977895110504;4478.641708663299;4547.340635607885;3148.4962406015384;3225.1614580208843;3228.0799972007867;3231.935361292808;3232.7413806895393;545.0733752620561;552.3620218647469;554.365251786702;568.903286441306;569.4760820045568;537.8386484054768;589.4194218694582;605.2494906316136;670.6747227594612;686.7870960002415;8476.49141051539;8624.439411438361;8914.197722205032;8975.237104846161;8981.955090224506;560.7392562458476;576.2738948924385;622.0575827621158;675.2133764164792;687.1685260834347;4093.508778946486;4149;4156.688248381383;4314.439122914064;4341.261985462479;77873.61063194647;78117.218827811;79491.20508794839;79894;80403;65852;71741;71998;72902.63548682223;76309.61845190849;63158;63166.684166578874;63259.6837015812;63520.68239658772;64078;7598.088229412506;7723;7749.481418538885;7817.570033648204;7844.529328240324;43937.78031109824;45622.31566526571;46021.76989115033;46246.768766155954;46299.768501157276;49677.751611241714;49712;56336.15495767485;58569.41430585639;60755;12662.556810511587;13193.406296716863;13203.603891883258;13245.40395682216;13574.796378054534;13048.54330098442;13977.790333145214;13992.650183745081;14479.420823166955;14649.633759156106;13072.607821765363;13867.791983120464;14014;14026.573433499578;14783.630409239855;13007.219566826021;13030.609081727564;13362.866371336162;14053.929730351692;14061.296935153407;13715.45138194501;14008.439662413797;14565.344559494637;14626.268686565842;14803.703925921636;10046.397216167054;10133.797324053625;10550.577976880839;10858.031241517037;11145.275557088764;10673.359598423809;11122.499487522919;11200.719982000515;11416.200865939305;11560.768784624091 05:51:07 INFO - PROCESS | 19906 | __end_tp_report 05:51:07 INFO - PROCESS | 19906 | __start_cc_report 05:51:07 INFO - PROCESS | 19906 | _x_x_mozilla_cycle_collect,1460 05:51:07 INFO - PROCESS | 19906 | __end_cc_report 05:51:07 INFO - PROCESS | 19906 | __startTimestamp1481809867701__endTimestamp 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | ------- Summary: start ------- 05:51:07 INFO - PROCESS | 19906 | Number of tests: 6 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | [#0] dojo.html Cycles:165 Average:5334.71 Median:5499.62 stddev:592.97 (10.8%) stddev-sans-first:566.85 05:51:07 INFO - PROCESS | 19906 | Values: 3041.8 3092.5 3094.0 3113.2 3116.0 5259.5 5286.1 5326.7 5342.5 5366.4 5436.0 5437.3 5441.2 5443.4 5446.5 4902.2 4928.1 4948.4 4979.6 4992.8 4877.2 4907.2 4940.1 4952.9 4962.8 4902.5 4906.3 4908.9 4948.8 4949.3 4926.1 4934.3 4942.7 4945.4 4980.8 4735.5 4742.6 4809.6 4875.8 4903.2 5273.5 5397.1 5398.9 5419.1 5431.1 5787.9 5792.1 5809.5 5815.7 5816.6 5614.0 5817.0 5848.2 5849.5 5858.9 5301.1 5366.4 5367.7 5369.9 5373.0 5835.9 5842.3 5842.7 5865.1 5898.4 5732.1 5736.7 5754.0 5754.8 5758.8 5708.4 5749.3 5756.2 5760.6 5762.8 5771.2 5776.3 5789.9 5791.0 5796.5 5511.1 5559.7 5643.4 5674.7 5681.9 4448.2 4448.9 4450.9 4456.1 4457.7 3919.9 3923.0 3928.6 3957.8 3965.1 5440.1 5442.3 5442.5 5449.6 5449.9 5641.5 5688.8 5701.5 5705.1 5731.4 5413.0 5452.8 5453.7 5454.7 5488.6 5002.5 5006.4 5007.8 5011.2 5047.9 5683.0 5695.7 5745.4 5797.7 5920.9 5635.9 5737.3 5777.4 5778.1 5779.4 5890.8 5894.3 5895.7 5898.9 5899.9 5652.2 5655.0 5655.2 5657.0 5657.3 5527.6 5647.3 5671.6 5694.0 5719.3 5636.6 5637.1 5637.4 5642.2 5673.3 5571.6 5578.2 5579.7 5581.7 5584.2 5339.8 5378.8 5457.1 5499.6 5565.6 5693.4 5726.3 5727.9 5750.7 5765.8 5358.3 5388.4 5397.5 5401.1 5593.7 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | [#1] ext.html Cycles:180 Average:54797.68 Median:196054.00 stddev:101921.11 (52.0%) stddev-sans-first:102125.54 05:51:07 INFO - PROCESS | 19906 | Values: 514.3 559.0 562.3 573.9 578.2 31330.5 39802.4 42500.0 42500.4 45578.8 43242.8 43760.3 43810.6 43871.6 43947.8 7808.0 8588.8 8790.7 8790.9 8798.8 7725.7 10036.4 10329.6 10330.1 10576.8 10364.1 10414.3 10430.4 10432.5 10436.0 10285.0 10344.7 10361.2 10383.4 10386.3 10263.9 10326.2 10341.6 10344.5 10345.6 41440.6 41574.4 41684.2 41721.4 41801.4 3397.9 3403.7 3517.7 3534.2 3986.7 30720.7 31135.1 31142.0 31361.2 31392.8 4110.1 4225.7 4229.3 4256.0 4307.4 324679.0 324912.0 325291.0 325432.0 325627.0 58169.0 58359.0 58510.4 58717.4 58830.4 61100.4 61166.0 61245.4 61304.0 61348.0 14514.6 14840.3 14852.2 14870.7 14871.2 10228.5 10522.2 11062.6 11476.1 11574.9 16554.8 17128.7 17266.8 17342.3 17424.6 6540.9 6814.4 6909.7 6922.5 7019.3 870.0 955.8 969.6 1013.3 1044.4 31033.5 31777.7 31842.7 31845.8 32385.0 1041.0 1104.7 1109.5 1129.7 1134.0 16183.9 16533.8 16736.3 16903.2 17003.8 459791.0 463135.0 463587.7 464855.0 464934.0 56442.2 56472.4 56577.0 56855.4 56875.0 1171.4 1209.7 1257.4 1275.5 1316.8 28814.9 32750.5 32851.5 32976.7 33381.5 48771.5 49452.8 49475.0 49489.0 49493.0 356466.0 357028.0 357108.0 357292.0 358381.0 38907.0 39957.6 40634.6 40679.4 40878.6 41386.0 42448.8 46247.8 46478.1 46688.5 34020.7 38995.2 39491.8 40505.0 40742.0 32797.8 35352.0 35623.8 35642.0 37004.0 35841.5 36148.8 36300.3 36796.6 37149.8 31016.4 31748.4 31871.7 32352.7 32468.2 25483.5 25503.0 25722.2 25728.6 26127.0 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | [#2] jquery.html Cycles:180 Average:21523.75 Median:19169.61 stddev:51105.10 (266.6%) stddev-sans-first:51223.76 05:51:07 INFO - PROCESS | 19906 | Values: 360.4 370.1 385.8 387.6 403.1 14387.4 14425.3 16408.4 19076.0 19203.6 18119.9 18353.4 18666.1 18697.3 18792.2 5463.0 5673.8 5725.7 5727.4 5731.4 4703.6 5553.9 6175.0 6207.4 6311.0 6218.1 6266.0 6272.4 6274.1 6274.4 6116.8 6205.8 6208.2 6220.0 6227.8 4729.9 4949.4 5511.9 5514.6 5518.9 11894.6 12010.5 12117.6 12118.7 12121.6 2020.7 2153.2 2208.9 2218.8 2758.3 8614.7 8737.6 8781.9 8826.2 9477.1 1808.3 1813.2 1848.5 1850.4 1874.3 52769.7 57959.0 60152.0 71835.0 80226.0 9636.8 10341.9 10777.1 10838.1 10842.7 14480.7 14596.6 14629.9 14696.9 14697.6 7229.6 7295.9 7476.2 7482.7 7549.2 6692.8 6728.5 6856.1 6944.0 7309.2 4086.2 4140.2 4551.0 4580.9 4678.7 1736.9 1890.7 1896.5 1934.0 1994.9 892.7 907.5 1001.0 1005.3 1008.3 17496.3 18928.0 18975.3 19225.5 19373.9 921.6 943.7 950.6 983.3 1010.3 9339.5 9857.8 10564.5 10577.0 10587.9 189181.0 189495.0 189513.0 418537.0 418541.0 73241.0 84347.0 86992.0 87488.0 88366.0 939.2 1003.5 1044.0 1056.5 1057.6 16062.8 17055.8 17165.7 17489.5 17518.6 32990.3 33947.1 37953.4 39019.6 39030.8 52414.5 52860.5 53867.7 55279.0 55396.0 6985.8 7354.1 7458.5 7594.7 7836.2 9195.0 11509.9 11727.5 12019.6 12187.8 10851.9 10856.8 11042.1 11047.9 11243.2 10470.7 10724.7 10787.0 10936.6 11092.6 10882.2 11153.8 11213.3 11264.3 11539.5 7470.7 7617.4 7772.4 7824.0 8080.6 8687.4 10825.6 10914.3 10982.7 11114.9 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | [#3] mootools.html Cycles:180 Average:5229.02 Median:4941.68 stddev:2956.14 (59.8%) stddev-sans-first:2949.70 05:51:07 INFO - PROCESS | 19906 | Values: 1301.9 1354.4 1357.9 1458.3 1651.4 6776.4 7763.0 7800.4 7808.1 8147.5 7679.4 7809.2 7823.7 7996.9 8028.3 1858.5 1922.4 2066.4 2116.0 2117.8 2094.0 2155.8 2157.8 2166.1 2168.6 2068.7 2077.5 2088.3 2088.4 2090.4 2080.4 2085.2 2108.5 2111.1 2114.2 2066.2 2072.9 2087.4 2100.0 2102.4 7833.5 7926.0 7929.8 7931.3 7977.8 4703.5 4798.9 4799.3 4806.8 4809.5 2953.1 3102.9 3140.7 3143.7 3190.2 1048.8 1094.3 1103.8 1126.9 1161.7 10825.4 11089.7 11097.4 11116.4 11118.8 3982.4 4161.3 4181.5 4239.3 4255.5 9321.8 9329.3 9337.4 9341.9 9344.8 4837.2 4838.9 4840.6 4841.2 4843.8 3619.6 3761.4 4412.1 4428.1 4457.2 3620.8 3679.7 3733.5 3765.9 3794.9 1189.9 1210.6 1219.3 1219.5 1226.3 767.6 853.4 879.9 894.2 905.8 5265.9 5531.1 5549.9 5578.7 5677.6 383.7 386.9 393.9 394.8 394.9 3706.6 3713.9 3717.9 3730.4 3877.2 9250.0 9650.2 9729.8 9827.2 9890.4 9846.6 9885.5 9894.3 9896.5 9900.1 7364.0 7451.4 7455.6 7503.3 7517.5 5400.2 5415.3 5452.4 5569.4 5637.9 8958.4 8962.3 8985.2 9027.4 9055.6 8709.4 8965.3 8977.0 8986.4 9281.6 6874.7 7065.4 7069.3 7278.5 7424.4 7134.1 7192.9 7328.0 7485.9 7555.3 6845.7 6926.8 6973.7 6993.5 7013.2 6499.3 6589.5 6821.2 6823.1 6880.2 6503.7 6513.6 6566.6 6630.8 6631.9 4622.5 4626.3 4756.5 4759.7 4935.0 4861.1 4948.4 5052.1 5072.6 5130.6 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | [#4] prototype.html Cycles:180 Average:4529.45 Median:5118.32 stddev:1294.40 (25.3%) stddev-sans-first:1258.87 05:51:07 INFO - PROCESS | 19906 | Values: 319.9 331.9 336.6 337.6 344.1 4991.3 5071.8 5122.9 5135.2 5174.6 4985.9 5069.7 5074.9 5087.8 5109.8 4093.0 4099.3 4101.3 4110.4 4124.6 3950.8 4125.1 4144.1 4165.2 4169.7 4097.5 4099.3 4100.8 4125.9 4128.2 4083.5 4083.6 4102.6 4110.5 4120.9 3688.3 3688.9 3696.7 3699.3 3704.3 4867.9 5099.7 5113.7 5127.8 5136.5 4699.9 4706.2 4707.5 4710.2 4730.5 5392.5 5409.8 5457.2 5459.8 5459.9 3844.4 3965.5 3993.7 3999.9 4060.1 5560.9 5585.0 5609.6 5621.3 5676.2 4048.4 4066.9 4072.4 4085.0 4099.8 4047.6 4048.8 4053.3 4156.3 4161.7 4596.5 4596.6 4599.2 4601.1 4605.4 5442.6 5443.0 5460.2 5485.8 5488.2 1323.3 1346.7 1359.4 1379.6 1390.4 949.7 975.7 982.0 990.6 998.4 5065.3 5079.9 5092.8 5098.9 5102.2 5408.0 5413.2 5418.7 5437.9 5438.8 4763.8 4982.7 5006.0 5032.3 5056.5 2796.2 2799.0 2832.8 2839.8 2848.2 5417.6 5431.5 5443.6 5453.0 5468.3 5324.8 5394.6 5400.3 5468.4 5499.4 5456.4 5476.2 5505.7 5507.4 5526.6 5268.7 5339.7 5380.4 5406.5 5452.6 5053.8 5233.5 5280.6 5283.7 5307.5 5379.9 5432.0 5436.3 5450.3 5456.0 3903.3 3918.2 3955.3 3992.4 3993.1 5243.6 5298.0 5461.2 5476.1 5501.5 5267.7 5296.3 5467.4 5474.2 5492.5 5423.3 5429.7 5443.5 5448.2 5472.4 5204.7 5377.0 5395.4 5401.7 5411.0 5427.0 5451.7 5459.2 5459.2 5489.2 5343.5 5368.8 5368.9 5385.1 5394.5 05:51:07 INFO - PROCESS | 19906 | 05:51:07 INFO - PROCESS | 19906 | [#5] yui.html Cycles:180 Average:17577.66 Median:25084.83 stddev:22609.49 (90.1%) stddev-sans-first:22637.41 05:51:07 INFO - PROCESS | 19906 | Values: 704.6 725.9 757.5 783.2 794.8 15674.0 16434.3 16445.3 16464.7 16482.3 15211.8 15424.4 15436.6 15458.7 15475.0 666.0 685.8 774.2 781.4 798.3 791.9 797.0 798.5 802.9 803.7 843.0 844.7 846.1 846.6 846.7 834.5 835.3 835.6 835.9 836.2 512.3 527.4 598.1 612.8 618.4 14743.9 14771.1 14828.9 14907.5 14959.7 13584.0 14054.2 14125.9 14152.6 14202.5 11406.4 11655.1 12239.8 12296.3 12579.9 4352.5 4365.2 4367.1 4369.4 4419.4 75182.2 75302.6 75849.6 76788.0 76984.6 10822.9 10874.2 10979.9 11128.9 11148.5 20289.5 20293.5 20310.0 20329.4 20333.8 7841.1 7870.1 7995.3 8064.4 8228.4 4365.4 4413.9 4421.0 4478.6 4547.3 3148.5 3225.2 3228.1 3231.9 3232.7 545.1 552.4 554.4 568.9 569.5 537.8 589.4 605.2 670.7 686.8 8476.5 8624.4 8914.2 8975.2 8982.0 560.7 576.3 622.1 675.2 687.2 4093.5 4149.0 4156.7 4314.4 4341.3 77873.6 78117.2 79491.2 79894.0 80403.0 65852.0 71741.0 71998.0 72902.6 76309.6 63158.0 63166.7 63259.7 63520.7 64078.0 7598.1 7723.0 7749.5 7817.6 7844.5 43937.8 45622.3 46021.8 46246.8 46299.8 49677.8 49712.0 56336.2 58569.4 60755.0 12662.6 13193.4 13203.6 13245.4 13574.8 13048.5 13977.8 13992.7 14479.4 14649.6 13072.6 13867.8 14014.0 14026.6 14783.6 13007.2 13030.6 13362.9 14053.9 14061.3 13715.5 14008.4 14565.3 14626.3 14803.7 10046.4 10133.8 10550.6 10858.0 11145.3 10673.4 11122.5 11200.7 11416.2 11560.8 05:51:07 INFO - PROCESS | 19906 | -------- Summary: end -------- 05:51:07 INFO - PROCESS | 19906 | 05:51:08 INFO - TEST-INFO | 19906: exit 0 05:51:08 INFO - TEST-OK | dromaeo_css | took 1118107ms 05:51:08 INFO - TEST-START | kraken 05:51:08 INFO - operating with platform_type : linux_ 05:51:08 INFO - Initialising browser for kraken test... 05:51:08 INFO - TEST-INFO | started process 20212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGw0ix/profile http://localhost:38598/getInfo.html) 05:51:12 INFO - PROCESS | 20212 | __metrics Screen width/height:1600/1200 05:51:12 INFO - PROCESS | 20212 | colorDepth:24 05:51:12 INFO - PROCESS | 20212 | Browser inner width/height: 1024/697 05:51:12 INFO - PROCESS | 20212 | __metrics 05:51:13 INFO - PROCESS | 20212 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:51:13 INFO - PROCESS | 20212 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:14 INFO - PROCESS | 20212 | console.error: PushService: 05:51:14 INFO - PROCESS | 20212 | stateChangeProcessEnqueue: Error transitioning state 05:51:14 INFO - PROCESS | 20212 | UnknownError 05:51:14 INFO - TEST-INFO | 20212: exit 0 05:51:14 INFO - Browser initialized. 05:51:14 INFO - Running cycle 1/1 for kraken test... 05:51:14 INFO - TEST-INFO | started process 20297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGw0ix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:26 INFO - PROCESS | 20297 | RSS: Main: 172326912 05:51:26 INFO - PROCESS | 20297 | 05:51:29 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38598/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:30 INFO - PROCESS | 20297 | RSS: Main: 234754048 05:51:30 INFO - PROCESS | 20297 | 05:51:33 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38598/tests/kraken/driver.html?testName=audio-dft) 05:51:33 INFO - PROCESS | 20297 | RSS: Main: 217051136 05:51:33 INFO - PROCESS | 20297 | 05:51:36 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38598/tests/kraken/driver.html?testName=audio-fft) 05:51:37 INFO - PROCESS | 20297 | RSS: Main: 299294720 05:51:37 INFO - PROCESS | 20297 | 05:51:39 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38598/tests/kraken/driver.html?testName=audio-oscillator) 05:51:39 INFO - PROCESS | 20297 | RSS: Main: 211419136 05:51:39 INFO - PROCESS | 20297 | 05:51:42 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38598/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:42 INFO - PROCESS | 20297 | RSS: Main: 214122496 05:51:42 INFO - PROCESS | 20297 | 05:51:45 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38598/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:46 INFO - PROCESS | 20297 | RSS: Main: 253198336 05:51:46 INFO - PROCESS | 20297 | 05:51:49 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38598/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:50 INFO - PROCESS | 20297 | RSS: Main: 253583360 05:51:50 INFO - PROCESS | 20297 | 05:51:53 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38598/tests/kraken/driver.html?testName=json-parse-financial) 05:51:53 INFO - PROCESS | 20297 | RSS: Main: 251867136 05:51:53 INFO - PROCESS | 20297 | 05:51:55 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38598/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:55 INFO - PROCESS | 20297 | RSS: Main: 214032384 05:51:55 INFO - PROCESS | 20297 | 05:51:57 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:58 INFO - PROCESS | 20297 | RSS: Main: 221224960 05:51:58 INFO - PROCESS | 20297 | 05:52:00 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:00 INFO - PROCESS | 20297 | RSS: Main: 230023168 05:52:00 INFO - PROCESS | 20297 | 05:52:03 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:04 INFO - PROCESS | 20297 | RSS: Main: 239558656 05:52:04 INFO - PROCESS | 20297 | 05:52:07 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:07 INFO - PROCESS | 20297 | RSS: Main: 235749376 05:52:07 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | Cycle 1(1): loaded http://localhost:38598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38598/tests/kraken/driver.html?testName=ai-astar) 05:52:09 INFO - PROCESS | 20297 | RSS: Main: 287911936 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | __start_tp_report 05:52:09 INFO - PROCESS | 20297 | _x_x_mozilla_page_load 05:52:09 INFO - PROCESS | 20297 | _x_x_mozilla_page_load_details 05:52:09 INFO - PROCESS | 20297 | |i|pagename|runs| 05:52:09 INFO - PROCESS | 20297 | |0;ai-astar;110;114;112;114;115;113;115;113;113;114 05:52:09 INFO - PROCESS | 20297 | |1;audio-beat-detection;161;124;127;179;124;126;122;124;148;136 05:52:09 INFO - PROCESS | 20297 | |2;audio-dft;161;161;163;161;161;161;162;162;164;163 05:52:09 INFO - PROCESS | 20297 | |3;audio-fft;75;75;75;104;77;77;77;75;101;75 05:52:09 INFO - PROCESS | 20297 | |4;audio-oscillator;83;83;105;85;84;84;96;83;84;111 05:52:09 INFO - PROCESS | 20297 | |5;imaging-gaussian-blur;127;127;127;127;127;126;128;127;127;127 05:52:09 INFO - PROCESS | 20297 | |6;imaging-darkroom;147;145;146;146;147;146;145;146;146;146 05:52:09 INFO - PROCESS | 20297 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 05:52:09 INFO - PROCESS | 20297 | |8;json-parse-financial;54;53;55;53;54;56;54;54;54;54 05:52:09 INFO - PROCESS | 20297 | |9;json-stringify-tinderbox;63;63;62;62;63;62;62;63;63;63 05:52:09 INFO - PROCESS | 20297 | |10;stanford-crypto-aes;81;91;83;81;87;79;80;84;81;86 05:52:09 INFO - PROCESS | 20297 | |11;stanford-crypto-ccm;140;132;145;131;139;142;132;133;179;147 05:52:09 INFO - PROCESS | 20297 | |12;stanford-crypto-pbkdf2;175;171;169;170;167;171;169;173;169;164 05:52:09 INFO - PROCESS | 20297 | |13;stanford-crypto-sha256-iterative;65;68;70;65;69;64;68;64;65;63 05:52:09 INFO - PROCESS | 20297 | __end_tp_report 05:52:09 INFO - PROCESS | 20297 | __start_cc_report 05:52:09 INFO - PROCESS | 20297 | _x_x_mozilla_cycle_collect,1659 05:52:09 INFO - PROCESS | 20297 | __end_cc_report 05:52:09 INFO - PROCESS | 20297 | __startTimestamp1481809929721__endTimestamp 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | ------- Summary: start ------- 05:52:09 INFO - PROCESS | 20297 | Number of tests: 14 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.49 (1.3%) stddev-sans-first:1.00 05:52:09 INFO - PROCESS | 20297 | Values: 110.0 114.0 112.0 114.0 115.0 113.0 115.0 113.0 113.0 114.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:131.50 stddev:19.48 (14.8%) stddev-sans-first:18.64 05:52:09 INFO - PROCESS | 20297 | Values: 161.0 124.0 127.0 179.0 124.0 126.0 122.0 124.0 148.0 136.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 05:52:09 INFO - PROCESS | 20297 | Values: 161.0 161.0 163.0 161.0 161.0 161.0 162.0 162.0 164.0 163.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:11.34 (15.1%) stddev-sans-first:11.81 05:52:09 INFO - PROCESS | 20297 | Values: 75.0 75.0 75.0 104.0 77.0 77.0 77.0 75.0 101.0 75.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:84.00 stddev:10.44 (12.4%) stddev-sans-first:10.78 05:52:09 INFO - PROCESS | 20297 | Values: 83.0 83.0 105.0 85.0 84.0 84.0 96.0 83.0 84.0 111.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:52:09 INFO - PROCESS | 20297 | Values: 127.0 127.0 127.0 127.0 127.0 126.0 128.0 127.0 127.0 127.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 05:52:09 INFO - PROCESS | 20297 | Values: 147.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:52:09 INFO - PROCESS | 20297 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 05:52:09 INFO - PROCESS | 20297 | Values: 54.0 53.0 55.0 53.0 54.0 56.0 54.0 54.0 54.0 54.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:52:09 INFO - PROCESS | 20297 | Values: 63.0 63.0 62.0 62.0 63.0 62.0 62.0 63.0 63.0 63.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:3.74 (4.5%) stddev-sans-first:3.88 05:52:09 INFO - PROCESS | 20297 | Values: 81.0 91.0 83.0 81.0 87.0 79.0 80.0 84.0 81.0 86.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:141.00 stddev:14.21 (10.1%) stddev-sans-first:15.06 05:52:09 INFO - PROCESS | 20297 | Values: 140.0 132.0 145.0 131.0 139.0 142.0 132.0 133.0 179.0 147.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.50 stddev:3.05 (1.8%) stddev-sans-first:2.59 05:52:09 INFO - PROCESS | 20297 | Values: 175.0 171.0 169.0 170.0 167.0 171.0 169.0 173.0 169.0 164.0 05:52:09 INFO - PROCESS | 20297 | 05:52:09 INFO - PROCESS | 20297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:2.42 (3.6%) stddev-sans-first:2.54 05:52:09 INFO - PROCESS | 20297 | Values: 65.0 68.0 70.0 65.0 69.0 64.0 68.0 64.0 65.0 63.0 05:52:09 INFO - PROCESS | 20297 | -------- Summary: end -------- 05:52:09 INFO - PROCESS | 20297 | 05:52:10 INFO - TEST-INFO | 20297: exit 0 05:52:10 INFO - TEST-OK | kraken | took 62327ms 05:52:10 INFO - SUITE-END | took 1180s 05:52:11 INFO - Completed test suite (00:19:40) 05:52:11 INFO - javascript benchmark 05:52:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3041.756659467242, 3092.5361195820637, 3094.0099168266156, 3113.2216945763544, 3116.0184541869307, 5259.474052594738, 5286.127788914824, 5326.7070311132875, 5342.492463215993, 5366.382865970415, 5435.972820135894, 5437.293151890259, 5441.238226648273, 5443.401225865152, 5446.455354464551, 4902.191138462158, 4928.137575924216, 4948.356713627223, 4979.60163186946, 4992.77532511036, 4877.244027175776, 4907.165781817082, 4940.135476291653, 4952.851414457554, 4962.801487940496, 4902.4852390498845, 4906.31311616374, 4908.852734417973, 4948.8267910623135, 4949.307097006422, 4926.137925862996, 4934.309196712463, 4942.703437793743, 4945.357103576512, 4980.775865086043, 4735.479097299294, 4742.644301677354, 4809.567138957475, 4875.780589873429, 4903.215485522299, 5273.472652734734, 5397.109476936301, 5398.8920221595345, 5419.078756611386, 5431.103867861798, 5787.942120578782, 5792.073268277098, 5809.535237181058, 5815.73829177688, 5816.563757718188, 5614.045612245928, 5817.040188368914, 5848.181254624356, 5849.532037437038, 5858.912116318259, 5301.125314323132, 5366.436524164985, 5367.704776237305, 5369.892602147936, 5373.032854086224, 5835.912461313083, 5842.269716285465, 5842.707864606753, 5865.061590145556, 5898.380670029585, 5732.054211055212, 5736.68448235351, 5754.0, 5754.798582049608, 5758.7696492140685, 5708.372079071299, 5749.338826035059, 5756.222909907193, 5760.6255593386295, 5762.769489220468, 5771.163181338767, 5776.306843178845, 5789.913151302734, 5791.044477661223, 5796.5072968797285, 5511.090670039479, 5559.694216818033, 5643.40744221859, 5674.687892165971, 5681.886362272814, 4448.199324121624, 4448.933266001012, 4450.910981780346, 4456.064226512404, 4457.710248833815, 3919.9216015679526, 3923.0388554804254, 3928.5678575356687, 3957.8416863325147, 3965.107850733562, 5440.102383106743, 5442.292501974797, 5442.455754424605, 5449.5640348772, 5449.918251226156, 5641.52047075995, 5688.772449102073, 5701.486866182064, 5705.087186050212, 5731.398203188689, 5412.972935135299, 5452.754626041838, 5453.672779633234, 5454.7272636368025, 5488.615796894259, 5002.52476014778, 5006.374203224597, 5007.824726134568, 5011.198208286657, 5047.899042019212, 5682.971585142048, 5695.686737229492, 5745.425457454221, 5797.652140871562, 5920.881582368328, 5635.88728225425, 5737.282839645044, 5777.411211916757, 5778.133280008033, 5779.364269930388, 5890.823275301748, 5894.2926848778425, 5895.734691938787, 5898.852528686817, 5899.882002359843, 5652.236948012131, 5654.971725141512, 5655.236543066633, 5657.0, 5657.26455560791, 5527.613067085265, 5647.322321321468, 5671.602987790815, 5693.9715301424885, 5719.342275638189, 5636.605437619327, 5637.126245431965, 5637.351704554028, 5642.23829782974, 5673.290838645169, 5571.554275658019, 5578.191162281528, 5579.69311687861, 5581.6930068846605, 5584.218209450599, 5339.759710812945, 5378.811741589026, 5457.099578569491, 5499.615026948235, 5565.638233514808, 5693.430656934273, 5726.255586773693, 5727.914081288701, 5750.712464376848, 5765.827025189251, 5358.303420555303, 5388.38033626138, 5397.460253974728, 5401.081816091195, 5593.748281327269], "value": 5295.093132689701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.339074289538, 558.9944100558993, 562.2578196780249, 573.905305624572, 578.158778976589, 31330.53004204936, 39802.40296395553, 42499.99999999996, 42500.36249456261, 45578.772106139426, 43242.783786081025, 43760.343594846105, 43810.56189438105, 43871.56128438715, 43947.78026109865, 7807.96096019522, 8588.828223435528, 8790.736277911672, 8790.86813697795, 8798.780030499256, 7725.652345644431, 10036.447995360253, 10329.638462653771, 10330.12193963514, 10576.841347379795, 10364.067233948943, 10414.32306900053, 10430.426326552037, 10432.530536125854, 10436.0, 10285.0, 10344.741381465523, 10361.171106311514, 10383.376997380181, 10386.324888882198, 10263.948680256626, 10326.22553308505, 10341.638042668546, 10344.5344959477, 10345.586176552928, 41440.58559414397, 41574.37638435426, 41684.1663166738, 41721.374179387334, 41801.372979405336, 3397.8980630581123, 3403.676650718178, 3517.683408493248, 3534.204803919123, 3986.66113380363, 30720.69279307201, 31135.06594802137, 31142.0, 31361.215969600715, 31392.843035784674, 4110.095778928631, 4225.68307376948, 4229.344451610005, 4255.957440425587, 4307.375430562551, 324679.0, 324912.0, 325291.0, 325432.0, 325627.0, 58169.0, 58359.0, 58510.41489585135, 58717.41282587205, 58830.411695882496, 61100.38899610947, 61166.0, 61245.38754612486, 61304.0, 61348.0, 14514.637134071521, 14840.257987100602, 14852.183129927958, 14870.702585948437, 14871.18208498543, 10228.48857557134, 10522.158227341948, 11062.612808551823, 11476.081913446904, 11574.942125289488, 16554.83445165557, 17128.74306885398, 17266.827331726774, 17342.3063077478, 17424.564385890455, 6540.934590654033, 6814.420774234246, 6909.723611055501, 6922.5154239203775, 7019.298070193042, 869.9869501957476, 955.7909244805327, 969.6170012844887, 1013.3261381181579, 1044.3733759744093, 31033.534496982564, 31777.68222317747, 31842.681573184436, 31845.840770795996, 32385.0, 1040.9739756505996, 1104.7017305327677, 1109.5395410904546, 1129.7119234595125, 1134.0304040045808, 16183.919080404523, 16533.751993720103, 16736.330546777994, 16903.239354228845, 17003.82996170047, 459791.0, 463135.0, 463587.6820615875, 464855.0, 464934.0, 56442.15336769952, 56472.43527564754, 56577.0, 56855.43144568584, 56875.0, 1171.3616079236836, 1209.727811242481, 1257.3650306595293, 1275.4643049919057, 1316.7629826631107, 28814.855925720236, 32750.508742368405, 32851.50722739113, 32976.67023329736, 33381.49927751037, 48771.5122848767, 49452.752736236085, 49475.0, 49489.0, 49493.0, 356466.0, 357028.0, 357108.0, 357292.0, 358381.0, 38907.0, 39957.60042399539, 40634.593654064265, 40679.38980915229, 40878.59121408748, 41386.0, 42448.78775606102, 46247.76876115598, 46478.07043859171, 46688.53311466978, 34020.65979340274, 38995.220095598495, 39491.80254098711, 40505.0, 40742.0, 32797.836010819796, 35352.0, 35623.82188089147, 35642.0, 37004.0, 35841.46237806383, 36148.81925590355, 36300.27399451943, 36796.63203368039, 37149.814250928575, 31016.379672406878, 31748.365032698755, 31871.68128318687, 32352.676473235908, 32468.188295292806, 25483.490330192923, 25503.0, 25722.228333150037, 25728.59699463059, 26127.0], "value": 19560.363901845438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.3567631777278, 370.1259718287498, 385.7858888316984, 387.63755888244486, 403.10108458138353, 14387.352569134388, 14425.278736063194, 16408.425705100322, 19076.0, 19203.615927681472, 18119.909400453012, 18353.357632482865, 18666.06669666518, 18697.34559290425, 18792.15435305411, 5463.043967305725, 5673.8297851064535, 5725.713714314267, 5727.3699893011735, 5731.398203188668, 4703.623710103184, 5553.944460555384, 6175.0, 6207.441330280274, 6310.968445157768, 6218.098375735515, 6266.0, 6272.40412160844, 6274.090256912745, 6274.4353008229255, 6116.785912493041, 6205.844853878667, 6208.161898143738, 6220.035894436347, 6227.750889964396, 4729.929051064202, 4949.356583644139, 5511.862203444906, 5514.641548299348, 5518.91721624176, 11894.643160705193, 12010.519579216909, 12117.575884844076, 12118.697032574257, 12121.575744848888, 2020.7373041504657, 2153.181790919456, 2208.9024858886696, 2218.7892150245702, 2758.2690586994463, 8614.698485553039, 8737.60680769367, 8781.868271975925, 8826.161514656098, 9477.147056764925, 1808.3128411203659, 1813.1750053725523, 1848.5286252005787, 1850.3523766681553, 1874.3065065925696, 52769.73615131938, 57959.0, 60152.0, 71835.0, 80226.0, 9636.831712864549, 10341.896581034094, 10777.08394786452, 10838.07876330505, 10842.728931776612, 14480.710385792225, 14596.562103136923, 14629.853701463062, 14696.853031469549, 14697.559073227607, 7229.638518074075, 7295.854082918312, 7476.214997425301, 7482.738104166328, 7549.2073332300415, 6692.83267918306, 6728.529002969745, 6856.086764274828, 6944.0, 7309.195988441267, 4086.223617512663, 4140.171965606891, 4550.954490455119, 4580.908381832344, 4678.742669153161, 1736.8610511159077, 1890.6502297075085, 1896.497428181533, 1934.032983508246, 1994.9002549872448, 892.7054072156172, 907.4555266839843, 1000.9649662261786, 1005.2862467647906, 1008.3193844155165, 17496.300147994192, 18928.0, 18975.33586324472, 19225.51936201578, 19373.900175971776, 921.6405601815297, 943.6838659049158, 950.6007476859736, 983.3018556824592, 1010.3230835340339, 9339.486328252011, 9857.802843943224, 10564.524596393181, 10577.0, 10587.947060264649, 189181.0, 189495.0, 189513.0, 418537.0, 418541.0, 73241.0, 84347.0, 86992.0, 87488.0, 88366.0, 939.1641439119189, 1003.4531180506641, 1043.956043956044, 1056.498163372392, 1057.582255009267, 16062.759058614363, 17055.829441705424, 17165.742513862053, 17489.475315740547, 17518.649627007133, 32990.34019319648, 33947.05926462908, 37953.4306985401, 39019.6098039016, 39030.82907512779, 52414.47585524248, 52860.471395287095, 53867.73066134644, 55279.0, 55396.0, 6985.755498557729, 7354.117505899327, 7458.47790654649, 7594.734184303523, 7836.216378362118, 9194.95402522983, 11509.884901151216, 11727.47226374798, 12019.63941081769, 12187.817182742088, 10851.945740271249, 10856.837147442637, 11042.116630669689, 11047.944760276469, 11243.212975091665, 10470.738231544272, 10724.678259652223, 10787.029167374974, 10936.617218397318, 11092.556297748, 10882.238243322892, 11153.83269250978, 11213.327200368005, 11264.267822591833, 11539.4807233673, 7470.701171953061, 7617.390608751398, 7772.417068719756, 7823.960880195563, 8080.555569443737, 8687.435316704394, 10825.621103261348, 10914.290571112851, 10982.725431864268, 11114.88885111171], "value": 8411.348737648306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.8698130186988, 1354.383755391297, 1357.945682172713, 1458.2562892924605, 1651.364224773462, 6776.390124888759, 7762.96118519408, 7800.414968877342, 7808.14110447851, 8147.470414423058, 7679.424043196755, 7809.219078092202, 7823.726169584065, 7996.920030799704, 8028.277455029046, 1858.5260758506563, 1922.432882299718, 2066.4420606436292, 2116.0, 2117.8093971542557, 2093.9895300523476, 2155.7844215578393, 2157.805797478227, 2166.079416248096, 2168.5879682860286, 2068.6896965455226, 2077.542940553076, 2088.33173384517, 2088.3943656339643, 2090.383336915606, 2080.365488525999, 2085.2180432337873, 2108.5255817441107, 2111.102781317941, 2114.164904862586, 2066.2354928676336, 2072.927447539329, 2087.3633541769755, 2100.023489077571, 2102.390306811023, 7833.49082309648, 7926.048874135141, 7929.841403171962, 7931.286184243446, 7977.840443191161, 4703.459102203256, 4798.928016079762, 4799.2801079837955, 4806.8077276909235, 4809.519048095198, 2953.12882699602, 3102.8758849645988, 3140.733037691776, 3143.669914658951, 3190.170555655523, 1048.7535429174138, 1094.3488624268548, 1103.757173421846, 1126.9436528173558, 1161.7269941563725, 10825.350478971286, 11089.72275693106, 11097.38964356968, 11116.44417779116, 11118.833217501744, 3982.4026396040827, 4161.313383291723, 4181.498220213533, 4239.27932251518, 4255.510616279105, 9321.813563728687, 9329.34694571387, 9337.3930694506, 9341.859872101924, 9344.813103737888, 4837.2260438329695, 4838.903221935612, 4840.6127509799135, 4841.2496063110275, 4843.830465933675, 3619.60184379718, 3761.4169803680475, 4412.117576484716, 4428.092241090569, 4457.153140903218, 3620.800855952948, 3679.68722658577, 3733.4586484959527, 3765.9435108473394, 3794.886153415402, 1189.8929096381194, 1210.5581462766027, 1219.2928101700993, 1219.451246938881, 1226.3071364679106, 767.5739964319745, 853.4409961475244, 879.9032106468284, 894.2443635128307, 905.8188362327561, 5265.868353291122, 5531.059719847635, 5549.861253468614, 5578.665280083208, 5677.630953987978, 383.71413297093284, 386.94750279240424, 393.94681717967705, 394.77892380267144, 394.9308870947573, 3706.5552133744122, 3713.8700145494777, 3717.9070523237137, 3730.421784623388, 3877.166409222031, 9249.95375023134, 9650.179734722487, 9729.756756081155, 9827.213822894151, 9890.357126786736, 9846.556904939294, 9885.50572471388, 9894.257930655229, 9896.505174741234, 9900.059494348025, 7363.963180184065, 7451.403887688972, 7455.627218639155, 7503.287187717049, 7517.511361761468, 5400.162974738922, 5415.300356687625, 5452.372977107683, 5569.443055694398, 5637.8590535236945, 8958.417702849294, 8962.32782541299, 8985.19133277982, 9027.4132181408, 9055.592498337459, 8709.433886797338, 8965.327600430124, 8977.0, 8986.415882967585, 9281.628734850801, 6874.690638921161, 7065.399441047569, 7069.257727938492, 7278.454115941219, 7424.406047516294, 7134.072570565793, 7192.892106618509, 7328.0, 7485.925140748741, 7555.320021198118, 6845.726170953106, 6926.826829329307, 6973.721051157897, 6993.475489338218, 7013.193482749549, 6499.252585952676, 6589.47284217271, 6821.249662537018, 6823.147106611674, 6880.243173251039, 6503.707333170113, 6513.576617519846, 6566.573172743756, 6630.834229144117, 6631.867362652816, 4622.468416132053, 4626.329182268485, 4756.453007904135, 4759.6668233223345, 4935.0, 4861.149298872754, 4948.356713627206, 5052.065367906949, 5072.619553533426, 5130.6152038598], "value": 4126.646128379772, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.87045246675075, 331.941910165721, 336.56583007919784, 337.6066882082374, 344.06071425009736, 4991.301217829498, 5071.797128114876, 5122.897542049157, 5135.178371460572, 5174.586033117351, 4985.875353116174, 5069.74651267437, 5074.898502029966, 5087.821926232583, 5109.846704598868, 4093.035343035345, 4099.282625540526, 4101.26177288088, 4110.362893751459, 4124.587541245866, 3950.762954222756, 4125.113100683352, 4144.114427935282, 4165.229432554987, 4169.708120431571, 4097.549269580344, 4099.29446565267, 4100.79496025199, 4125.876223713279, 4128.153728485669, 4083.530394004698, 4083.5508094109623, 4102.569230230828, 4110.486189226347, 4120.866761640543, 3688.2623475304777, 3688.9157625941525, 3696.741228114033, 3699.2971335446177, 3704.3147017801793, 4867.902641947177, 5099.71951542665, 5113.7471319526585, 5127.794968182474, 5136.5377116059735, 4699.906001879977, 4706.152892479352, 4707.481497398875, 4710.175719249118, 4730.455997560256, 5392.514673679349, 5409.83770486886, 5457.208704737831, 5459.836204913859, 5459.863503412406, 3844.38489841624, 3965.4646622705854, 3993.7204395692315, 3999.9400008999887, 4060.1473690525027, 5560.944390556124, 5585.0, 5609.551235901159, 5621.3298683125595, 5676.176954341598, 4048.4332193492933, 4066.8576599818866, 4072.38914162872, 4085.0, 4099.754014759124, 4047.615476529784, 4048.8380464781667, 4053.2704113259897, 4156.334986402161, 4161.667066634662, 4596.517365676623, 4596.575061730874, 4599.218132917412, 4601.148787474328, 4605.378273932976, 5442.591805614516, 5442.986095144822, 5460.215290202025, 5485.835424937259, 5488.231647569343, 1323.3184909771476, 1346.73065386923, 1359.4426285223012, 1379.5585412668052, 1390.4090761426353, 949.7055912667096, 975.658519518163, 981.9509024548887, 990.5938565188238, 998.3710262534556, 5065.2778055460585, 5079.873003174876, 5092.770825312869, 5098.898022039612, 5102.183650615883, 5408.0, 5413.188021796762, 5418.701971391612, 5437.864053398617, 5438.755256013489, 4763.831243101274, 4982.725950072709, 5005.974970125126, 5032.345795046694, 5056.469070747518, 2796.203082121586, 2799.0, 2832.7960616737805, 2839.849860806377, 2848.1597928610695, 5417.620766546383, 5431.474364420564, 5443.591730620219, 5452.972735136299, 5468.28912241414, 5324.760385782649, 5394.595405344615, 5400.29365652143, 5468.371137319259, 5499.370415525734, 5456.399796022434, 5476.1666833217705, 5505.724713764296, 5507.366652834815, 5526.613137080446, 5268.736563171903, 5339.679619222859, 5380.354357477127, 5406.540444062299, 5452.645578037414, 5053.797848086182, 5233.53461030912, 5280.551153152025, 5283.682979021271, 5307.52232299095, 5379.946200537945, 5432.049391356418, 5436.293281873332, 5450.31871016123, 5456.0, 3903.3457249070902, 3918.1967696622696, 3955.3473676843, 3992.421098940579, 3993.1414745829784, 5243.58051355883, 5298.0, 5461.235427040297, 5476.12382018891, 5501.5323697486165, 5267.710275934707, 5296.3379577552805, 5467.425920278313, 5474.151506516497, 5492.450754924475, 5423.29497165366, 5429.728513574384, 5443.482869127427, 5448.210009548672, 5472.398036216093, 5204.724134664771, 5377.0, 5395.433479484597, 5401.729913504388, 5411.0, 5427.0, 5451.7274136292235, 5459.208414779914, 5459.235707001102, 5489.231507588861, 5343.465653434625, 5368.785248590013, 5368.919466207932, 5385.111456609616, 5394.460553944574], "value": 4121.278216380495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.6265479295972, 725.8548290341932, 757.503834988083, 783.2011348424603, 794.7615715285415, 15674.0, 16434.260458279376, 16445.342186312548, 16464.67070658586, 16482.340706371746, 15211.847881521182, 15424.383024679028, 15436.61408464789, 15458.681197820333, 15475.0, 665.9667016649172, 685.8285428642839, 774.2489784908657, 781.3670926549499, 798.2616080125889, 791.8812178173263, 796.9721059762909, 798.5248776977689, 802.9397795165356, 803.7267329108103, 842.9926238145418, 844.7127976487993, 846.090452763282, 846.6444093480723, 846.652872322348, 834.4951304460775, 835.2774849754979, 835.5529791561546, 835.8871552340447, 836.2390224895346, 512.3416409913281, 527.419838178005, 598.1386803003661, 612.791650838717, 618.4403115180769, 14743.926280368636, 14771.113733176044, 14828.851711482856, 14907.478238261609, 14959.700805983819, 13584.0, 14054.156750594997, 14125.858741412558, 14152.575422737335, 14202.50291239812, 11406.42967851604, 11655.125865560118, 12239.75520489594, 12296.323702196376, 12579.874201257962, 4352.542982986804, 4365.236083685342, 4367.148406060819, 4369.410129632491, 4419.42547468827, 75182.24817751808, 75302.62348688222, 75849.62075189588, 76788.0, 76984.61507692482, 10822.891771082188, 10874.18443616732, 10979.945100274606, 11128.888711112948, 11148.494953181216, 20289.492762680755, 20293.49266268355, 20310.0, 20329.390118296476, 20333.796662033485, 7841.098273698483, 7870.094939082079, 7995.320397766255, 8064.395170362246, 8228.42401031934, 4365.388845561624, 4413.889652758642, 4420.977895110504, 4478.641708663299, 4547.340635607885, 3148.4962406015384, 3225.1614580208843, 3228.0799972007867, 3231.935361292808, 3232.7413806895393, 545.0733752620561, 552.3620218647469, 554.365251786702, 568.903286441306, 569.4760820045568, 537.8386484054768, 589.4194218694582, 605.2494906316136, 670.6747227594612, 686.7870960002415, 8476.49141051539, 8624.439411438361, 8914.197722205032, 8975.237104846161, 8981.955090224506, 560.7392562458476, 576.2738948924385, 622.0575827621158, 675.2133764164792, 687.1685260834347, 4093.508778946486, 4149.0, 4156.688248381383, 4314.439122914064, 4341.261985462479, 77873.61063194647, 78117.218827811, 79491.20508794839, 79894.0, 80403.0, 65852.0, 71741.0, 71998.0, 72902.63548682223, 76309.61845190849, 63158.0, 63166.684166578874, 63259.6837015812, 63520.68239658772, 64078.0, 7598.088229412506, 7723.0, 7749.481418538885, 7817.570033648204, 7844.529328240324, 43937.78031109824, 45622.31566526571, 46021.76989115033, 46246.768766155954, 46299.768501157276, 49677.751611241714, 49712.0, 56336.15495767485, 58569.41430585639, 60755.0, 12662.556810511587, 13193.406296716863, 13203.603891883258, 13245.40395682216, 13574.796378054534, 13048.54330098442, 13977.790333145214, 13992.650183745081, 14479.420823166955, 14649.633759156106, 13072.607821765363, 13867.791983120464, 14014.0, 14026.573433499578, 14783.630409239855, 13007.219566826021, 13030.609081727564, 13362.866371336162, 14053.929730351692, 14061.296935153407, 13715.45138194501, 14008.439662413797, 14565.344559494637, 14626.268686565842, 14803.703925921636, 10046.397216167054, 10133.797324053625, 10550.577976880839, 10858.031241517037, 11145.275557088764, 10673.359598423809, 11122.499487522919, 11200.719982000515, 11416.200865939305, 11560.768784624091], "value": 7037.2725826520455, "unit": "score"}], "name": "dromaeo_css", "value": 6860.667071310986, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 112.0, 114.0, 115.0, 113.0, 115.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 127.0, 179.0, 124.0, 126.0, 122.0, 124.0, 148.0, 136.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 161.0, 161.0, 162.0, 162.0, 164.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 104.0, 77.0, 77.0, 77.0, 75.0, 101.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 85.0, 84.0, 84.0, 96.0, 83.0, 84.0, 111.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 126.0, 128.0, 127.0, 127.0, 127.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 53.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 83.0, 81.0, 87.0, 79.0, 80.0, 84.0, 81.0, 86.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 145.0, 131.0, 139.0, 142.0, 132.0, 133.0, 179.0, 147.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 169.0, 170.0, 167.0, 171.0, 169.0, 173.0, 169.0, 164.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 70.0, 65.0, 69.0, 64.0, 68.0, 64.0, 65.0, 63.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1529.3999999999996, "alertThreshold": 2.0}]} 05:52:11 INFO - Return code: 0 05:52:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:11 INFO - # TBPL SUCCESS # 05:52:11 INFO - Running post-action listener: _resource_record_post_action 05:52:11 INFO - [mozharness: 2016-12-15 13:52:11.513087Z] Finished run-tests step (success) 05:52:11 INFO - Running post-run listener: _resource_record_post_run 05:52:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 393351168; Read time: 0; Write time: 309912 05:52:11 INFO - TinderboxPrint: CPU usage
13.2% 05:52:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:52:11 INFO - TinderboxPrint: I/O write bytes / time
393,351,168 / 309,912 05:52:11 INFO - TinderboxPrint: CPU idle
8,299.8 (86.8%) 05:52:11 INFO - TinderboxPrint: CPU user
1,207.7 (12.6%) 05:52:11 INFO - TinderboxPrint: Swap in / out
0 / 0 05:52:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103907328; Read time: 0; Write time: 92856 05:52:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289443840; Read time: 0; Write time: 217056 05:52:12 INFO - Running post-run listener: _upload_blobber_files 05:52:12 INFO - Blob upload gear active. 05:52:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:12 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 05:52:12 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'] 05:52:12 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 05:52:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:52:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:13 INFO - (blobuploader) - INFO - Done attempting. 05:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:16 INFO - (blobuploader) - INFO - Done attempting. 05:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:17 INFO - (blobuploader) - INFO - Done attempting. 05:52:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:17 INFO - Return code: 0 05:52:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a55e4bb9077ba98df4efeafd6547d50b584177e80fa951be435c36abd611906a5f0beb4099f9c183796c337f3238c6f8c7c9dbebf0e159439a162d14d4fdb009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b685592568caf417df5b333dcf243efe5ff7e6b73e327de0245c89912e74a4f149abbef6b6dbff994dadb236bd29d4a2ff3af27b250844f52e61e96a7d9d242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ed1a2a24153efbc11c5aadcf259e5684d8f35fa36f3fdea0c161b8371532c1f27d8e68d4962a6f3251149d9912fc17f0fed6375d4d8f9e2e382332baa35983"} 05:52:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:17 INFO - Contents: 05:52:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a55e4bb9077ba98df4efeafd6547d50b584177e80fa951be435c36abd611906a5f0beb4099f9c183796c337f3238c6f8c7c9dbebf0e159439a162d14d4fdb009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b685592568caf417df5b333dcf243efe5ff7e6b73e327de0245c89912e74a4f149abbef6b6dbff994dadb236bd29d4a2ff3af27b250844f52e61e96a7d9d242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ed1a2a24153efbc11c5aadcf259e5684d8f35fa36f3fdea0c161b8371532c1f27d8e68d4962a6f3251149d9912fc17f0fed6375d4d8f9e2e382332baa35983"} 05:52:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:17 INFO - Copying logs to upload dir... 05:52:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.213337 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-15 05:52:17.223558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:52:17.226966) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a55e4bb9077ba98df4efeafd6547d50b584177e80fa951be435c36abd611906a5f0beb4099f9c183796c337f3238c6f8c7c9dbebf0e159439a162d14d4fdb009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b685592568caf417df5b333dcf243efe5ff7e6b73e327de0245c89912e74a4f149abbef6b6dbff994dadb236bd29d4a2ff3af27b250844f52e61e96a7d9d242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ed1a2a24153efbc11c5aadcf259e5684d8f35fa36f3fdea0c161b8371532c1f27d8e68d4962a6f3251149d9912fc17f0fed6375d4d8f9e2e382332baa35983"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011743 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481801583/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a55e4bb9077ba98df4efeafd6547d50b584177e80fa951be435c36abd611906a5f0beb4099f9c183796c337f3238c6f8c7c9dbebf0e159439a162d14d4fdb009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b685592568caf417df5b333dcf243efe5ff7e6b73e327de0245c89912e74a4f149abbef6b6dbff994dadb236bd29d4a2ff3af27b250844f52e61e96a7d9d242", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ed1a2a24153efbc11c5aadcf259e5684d8f35fa36f3fdea0c161b8371532c1f27d8e68d4962a6f3251149d9912fc17f0fed6375d4d8f9e2e382332baa35983"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:52:17.252405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:52:17.252735) ========= 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=a0d2d2de893abaa8702a9954000001a7-1481808697.836469-905251271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:52:17.338612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:52:17.338936) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:52:17.339244) ========= ========= Total master_lag: 0.17 =========