builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1484604761.99 results: success (0) buildid: 20170116141217 builduid: 3b60062855e6480e944e6acf4b4b46ec revision: 96b9fad20c92f638a7ef03bcff262ca0563090bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:41.995136) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:41.995557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:41.995827) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.024019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.024313) ========= 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=db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-16 14:12:42-- 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% 42.7M=0s 2017-01-16 14:12:42 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.166629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.166939) ========= 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=db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017858 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.216429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.219805) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 96b9fad20c92f638a7ef03bcff262ca0563090bc --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 96b9fad20c92f638a7ef03bcff262ca0563090bc --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=db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-16 14:12:42,362 truncating revision to first 12 chars 2017-01-16 14:12:42,362 Setting DEBUG logging. 2017-01-16 14:12:42,362 attempt 1/10 2017-01-16 14:12:42,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/96b9fad20c92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 14:12:42,666 unpacking tar archive at: mozilla-inbound-96b9fad20c92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.899086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.899363) ========= script_repo_revision: 96b9fad20c92f638a7ef03bcff262ca0563090bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.902764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.903032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:12:42.915930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-16 14:12:42.916194) ========= /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=db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:12:43 INFO - MultiFileLogger online at 20170116 14:12:43 in /builds/slave/test 14:12:43 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 14:12:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:12:43 INFO - {'append_to_log': False, 14:12:43 INFO - 'base_work_dir': '/builds/slave/test', 14:12:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:12:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:12:43 INFO - 'branch': 'Mozilla-Inbound', 14:12:43 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:43 INFO - 'config_files': ('talos/linux_config.py',), 14:12:43 INFO - 'default_actions': ('clobber', 14:12:43 INFO - 'read-buildbot-config', 14:12:43 INFO - 'download-and-extract', 14:12:43 INFO - 'populate-webroot', 14:12:43 INFO - 'create-virtualenv', 14:12:43 INFO - 'install', 14:12:43 INFO - 'run-tests'), 14:12:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:43 INFO - 'download_minidump_stackwalk': True, 14:12:43 INFO - 'download_symbols': 'ondemand', 14:12:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:43 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:43 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:43 INFO - 'installer_path': 'installer.exe', 14:12:43 INFO - 'log_level': 'info', 14:12:43 INFO - 'log_name': 'talos', 14:12:43 INFO - 'log_to_console': True, 14:12:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:12:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:12:43 INFO - 'opt_config_files': (), 14:12:43 INFO - 'pip_index': False, 14:12:43 INFO - 'sps_profile': False, 14:12:43 INFO - 'sps_profile_interval': 0, 14:12:43 INFO - 'suite': 'dromaeojs', 14:12:43 INFO - 'system_bits': '32', 14:12:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:43 INFO - 'title': 'talos-linux64-ix-031', 14:12:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:43 INFO - 'use_talos_json': True, 14:12:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:12:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:43 INFO - 'work_dir': 'build'} 14:12:43 INFO - [mozharness: 2017-01-16 22:12:43.155596Z] Running clobber step. 14:12:43 INFO - Running pre-action listener: _resource_record_pre_action 14:12:43 INFO - Running main action method: clobber 14:12:43 INFO - rmtree: /builds/slave/test/build 14:12:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:12:44 INFO - Running post-action listener: _resource_record_post_action 14:12:44 INFO - [mozharness: 2017-01-16 22:12:44.142118Z] Finished clobber step (success) 14:12:44 INFO - [mozharness: 2017-01-16 22:12:44.142216Z] Running read-buildbot-config step. 14:12:44 INFO - Running pre-action listener: _resource_record_pre_action 14:12:44 INFO - Running main action method: read_buildbot_config 14:12:44 INFO - Using buildbot properties: 14:12:44 INFO - { 14:12:44 INFO - "project": "", 14:12:44 INFO - "product": "firefox", 14:12:44 INFO - "script_repo_revision": "production", 14:12:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 14:12:44 INFO - "repository": "", 14:12:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 14:12:44 INFO - "buildid": "20170116141217", 14:12:44 INFO - "stage_platform": "linux64-pgo", 14:12:44 INFO - "basedir": "/builds/slave/test", 14:12:44 INFO - "buildnumber": 3243, 14:12:44 INFO - "platform": "ubuntu64_hw", 14:12:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:12:44 INFO - "slavebuilddir": "test", 14:12:44 INFO - "branch": "mozilla-inbound", 14:12:44 INFO - "revision": "96b9fad20c92f638a7ef03bcff262ca0563090bc", 14:12:44 INFO - "slavename": "talos-linux64-ix-031", 14:12:44 INFO - "builduid": "3b60062855e6480e944e6acf4b4b46ec", 14:12:44 INFO - "repo_path": "integration/mozilla-inbound" 14:12:44 INFO - } 14:12:44 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:12:44 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 14:12:44 INFO - Running post-action listener: _resource_record_post_action 14:12:44 INFO - [mozharness: 2017-01-16 22:12:44.144587Z] Finished read-buildbot-config step (success) 14:12:44 INFO - [mozharness: 2017-01-16 22:12:44.144679Z] Running download-and-extract step. 14:12:44 INFO - Running pre-action listener: _resource_record_pre_action 14:12:44 INFO - Running main action method: download_and_extract 14:12:44 INFO - mkdir: /builds/slave/test/build/tests 14:12:44 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')]} 14:12:44 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:12:44 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/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 14:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/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 14:12:44 INFO - Downloaded 1361 bytes. 14:12:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:12:44 INFO - Using the following test package requirements: 14:12:44 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:12:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:12:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'jsshell-linux-x86_64.zip'], 14:12:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:12:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:12:44 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:12:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:12:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:44 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:12:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:12: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/1484597251/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:12: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/1484597251/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:12:44 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:12:44 INFO - Expected file size: 21864770 14:12:44 INFO - Obtained file size: 21864770 14:12:48 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 14:12:48 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/1484597251/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:12:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:12:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:12:48 INFO - Expected file size: 21864770 14:12:48 INFO - Obtained file size: 21864770 14:12:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:12:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:12:53 INFO - Expected file size: 14403463 14:12:53 INFO - Obtained file size: 14403463 14:12: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')]} 14:12:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:12:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/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 14:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/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 14:12:54 INFO - Downloaded 61739585 bytes. 14:12:54 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:12:54 INFO - mkdir: /builds/slave/test/properties 14:12:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:12:54 INFO - Writing to file /builds/slave/test/properties/build_url 14:12:54 INFO - Contents: 14:12:54 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:12:54 INFO - Running post-action listener: _resource_record_post_action 14:12:54 INFO - Running post-action listener: set_extra_try_arguments 14:12:54 INFO - [mozharness: 2017-01-16 22:12:54.608010Z] Finished download-and-extract step (success) 14:12:54 INFO - [mozharness: 2017-01-16 22:12:54.608109Z] Running populate-webroot step. 14:12:54 INFO - Running pre-action listener: _resource_record_pre_action 14:12:54 INFO - Running main action method: populate_webroot 14:12:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:54 INFO - '--tppagecycles', 14:12:54 INFO - '7'], 14:12:54 INFO - 'tests': ['tsvgm']}}, 14:12:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:12:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:12:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:12:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['damp', 'tps']}, 14:12:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'tests': ['damp', 'tps']}, 14:12:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['dromaeo_dom']}, 14:12:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['basic_compositor_video']}, 14:12:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:12:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['a11yr', 14:12:54 INFO - 'ts_paint', 14:12:54 INFO - 'tpaint', 14:12:54 INFO - 'sessionrestore', 14:12:54 INFO - 'sessionrestore_no_auto_restore', 14:12:54 INFO - 'tabpaint']}, 14:12:54 INFO - 'other-e10s': {'tests': ['a11yr', 14:12:54 INFO - 'ts_paint', 14:12:54 INFO - 'tpaint', 14:12:54 INFO - 'sessionrestore', 14:12:54 INFO - 'sessionrestore_no_auto_restore', 14:12:54 INFO - 'tabpaint']}, 14:12:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:12:54 INFO - 'ts_paint', 14:12:54 INFO - 'tpaint', 14:12:54 INFO - 'sessionrestore', 14:12:54 INFO - 'sessionrestore_no_auto_restore', 14:12:54 INFO - 'tabpaint']}, 14:12:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:12:54 INFO - 'ts_paint', 14:12:54 INFO - 'tpaint', 14:12:54 INFO - 'sessionrestore', 14:12:54 INFO - 'sessionrestore_no_auto_restore', 14:12:54 INFO - 'tabpaint']}, 14:12:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['a11yr', 14:12:54 INFO - 'ts_paint', 14:12:54 INFO - 'tpaint', 14:12:54 INFO - 'sessionrestore', 14:12:54 INFO - 'sessionrestore_no_auto_restore', 14:12:54 INFO - 'tabpaint']}, 14:12:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['a11yr', 14:12:54 INFO - 'ts_paint', 14:12:54 INFO - 'tpaint', 14:12:54 INFO - 'sessionrestore', 14:12:54 INFO - 'sessionrestore_no_auto_restore', 14:12:54 INFO - 'tabpaint']}, 14:12:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['tsvgx', 14:12:54 INFO - 'tsvgr_opacity', 14:12:54 INFO - 'tart', 14:12:54 INFO - 'tscrollx', 14:12:54 INFO - 'cart', 14:12:54 INFO - 'tsvg_static']}, 14:12:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:12:54 INFO - 'tsvgr_opacity', 14:12:54 INFO - 'tart', 14:12:54 INFO - 'tscrollx', 14:12:54 INFO - 'cart', 14:12:54 INFO - 'tsvg_static']}, 14:12:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'talos_options': ['--disable-e10s'], 14:12:54 INFO - 'tests': ['tp5o']}, 14:12:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:12:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'talos_options': ['--disable-e10s', 14:12:54 INFO - '--xperf_path', 14:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:54 INFO - 'tests': ['tp5n']}, 14:12:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:12:54 INFO - 'talos_options': ['--xperf_path', 14:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:54 INFO - 'tests': ['tp5n']}}, 14:12:54 INFO - 'talos.zip': {'path': '', 14:12:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:54 INFO - Running post-action listener: _resource_record_post_action 14:12:54 INFO - [mozharness: 2017-01-16 22:12:54.626291Z] Finished populate-webroot step (success) 14:12:54 INFO - [mozharness: 2017-01-16 22:12:54.626380Z] Running create-virtualenv step. 14:12:54 INFO - Running pre-action listener: _resource_record_pre_action 14:12:54 INFO - Running main action method: create_virtualenv 14:12:54 INFO - Creating virtualenv /builds/slave/test/build/venv 14:12:54 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 14:12:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:12:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:54 INFO - Using real prefix '/usr' 14:12:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:12:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:57 INFO - Installing pip.................done. 14:12:57 INFO - Return code: 0 14:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:12:57 INFO - Reading from file tmpfile_stdout 14:12:57 INFO - Output received: 14:12:57 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) 14:12:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:12:57 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')]} 14:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:57 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')]} 14:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:57 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:12:57 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 14:12:57 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 14:12:57 INFO - Using env: {'DISPLAY': ':0', 14:12:57 INFO - 'HOME': '/home/cltbld', 14:12:57 INFO - 'LANG': 'en_US.UTF-8', 14:12:57 INFO - 'LANGUAGE': 'en_US:en', 14:12:57 INFO - 'LOGNAME': 'cltbld', 14:12:57 INFO - 'MAIL': '/var/mail/cltbld', 14:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:57 INFO - 'MOZ_NO_REMOTE': '1', 14:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:57 INFO - 'NO_EM_RESTART': '1', 14:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:57 INFO - 'PWD': '/builds/slave/test', 14:12:57 INFO - 'SHELL': '/bin/bash', 14:12:57 INFO - 'SHLVL': '1', 14:12:57 INFO - 'TERM': 'linux', 14:12:57 INFO - 'TMOUT': '86400', 14:12:57 INFO - 'USER': 'cltbld', 14:12:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:57 INFO - '_': '/tools/buildbot/bin/python'} 14:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:57 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 14:12:57 INFO - Cleaning up... 14:12:57 INFO - Return code: 0 14:12:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:12:57 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')]} 14:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:57 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')]} 14:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:57 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:12:57 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 14:12:57 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 14:12:57 INFO - Using env: {'DISPLAY': ':0', 14:12:57 INFO - 'HOME': '/home/cltbld', 14:12:57 INFO - 'LANG': 'en_US.UTF-8', 14:12:57 INFO - 'LANGUAGE': 'en_US:en', 14:12:57 INFO - 'LOGNAME': 'cltbld', 14:12:57 INFO - 'MAIL': '/var/mail/cltbld', 14:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:57 INFO - 'MOZ_NO_REMOTE': '1', 14:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:57 INFO - 'NO_EM_RESTART': '1', 14:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:57 INFO - 'PWD': '/builds/slave/test', 14:12:57 INFO - 'SHELL': '/bin/bash', 14:12:57 INFO - 'SHLVL': '1', 14:12:57 INFO - 'TERM': 'linux', 14:12:57 INFO - 'TMOUT': '86400', 14:12:57 INFO - 'USER': 'cltbld', 14:12:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:57 INFO - '_': '/tools/buildbot/bin/python'} 14:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:57 INFO - Downloading/unpacking psutil>=3.1.1 14:12:57 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 14:12:57 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 14:12:57 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 14:12:57 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 14:12:57 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 14:12:57 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 14:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:59 INFO - Installing collected packages: psutil 14:12:59 INFO - Running setup.py install for psutil 14:13:00 INFO - building 'psutil._psutil_linux' extension 14:13:00 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 14:13:00 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 14:13:00 INFO - building 'psutil._psutil_posix' extension 14:13:00 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 14:13:00 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 14:13:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:00 INFO - Successfully installed psutil 14:13:00 INFO - Cleaning up... 14:13:00 INFO - Return code: 0 14:13:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:13:00 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')]} 14:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:00 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')]} 14:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:00 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:00 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 14:13:00 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 14:13:00 INFO - Using env: {'DISPLAY': ':0', 14:13:00 INFO - 'HOME': '/home/cltbld', 14:13:00 INFO - 'LANG': 'en_US.UTF-8', 14:13:00 INFO - 'LANGUAGE': 'en_US:en', 14:13:00 INFO - 'LOGNAME': 'cltbld', 14:13:00 INFO - 'MAIL': '/var/mail/cltbld', 14:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:00 INFO - 'MOZ_NO_REMOTE': '1', 14:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:00 INFO - 'NO_EM_RESTART': '1', 14:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:00 INFO - 'PWD': '/builds/slave/test', 14:13:00 INFO - 'SHELL': '/bin/bash', 14:13:00 INFO - 'SHLVL': '1', 14:13:00 INFO - 'TERM': 'linux', 14:13:00 INFO - 'TMOUT': '86400', 14:13:00 INFO - 'USER': 'cltbld', 14:13:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:00 INFO - '_': '/tools/buildbot/bin/python'} 14:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:13:00 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 14:13:00 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 14:13:00 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 14:13:00 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 14:13:00 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 14:13:00 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 14:13:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:13:02 INFO - Installing collected packages: mozsystemmonitor 14:13:02 INFO - Running setup.py install for mozsystemmonitor 14:13:02 INFO - Successfully installed mozsystemmonitor 14:13:02 INFO - Cleaning up... 14:13:02 INFO - Return code: 0 14:13:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:02 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:02 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 14:13:02 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 14:13:02 INFO - Using env: {'DISPLAY': ':0', 14:13:02 INFO - 'HOME': '/home/cltbld', 14:13:02 INFO - 'LANG': 'en_US.UTF-8', 14:13:02 INFO - 'LANGUAGE': 'en_US:en', 14:13:02 INFO - 'LOGNAME': 'cltbld', 14:13:02 INFO - 'MAIL': '/var/mail/cltbld', 14:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:02 INFO - 'MOZ_NO_REMOTE': '1', 14:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:02 INFO - 'NO_EM_RESTART': '1', 14:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:02 INFO - 'PWD': '/builds/slave/test', 14:13:02 INFO - 'SHELL': '/bin/bash', 14:13:02 INFO - 'SHLVL': '1', 14:13:02 INFO - 'TERM': 'linux', 14:13:02 INFO - 'TMOUT': '86400', 14:13:02 INFO - 'USER': 'cltbld', 14:13:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:02 INFO - '_': '/tools/buildbot/bin/python'} 14:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:03 INFO - Downloading/unpacking jsonschema==2.5.1 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:13:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:13:05 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 14:13:05 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 14:13:05 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 14:13:05 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 14:13:05 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 14:13:05 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 14:13:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:13:05 INFO - warning: no files found matching '*.txt' 14:13:05 INFO - no previously-included directories found matching 'build' 14:13:05 INFO - no previously-included directories found matching 'dist' 14:13:05 INFO - no previously-included directories found matching '.git*' 14:13:05 INFO - Installing collected packages: jsonschema, functools32 14:13:05 INFO - Running setup.py install for functools32 14:13:05 INFO - warning: no files found matching '*.txt' 14:13:05 INFO - no previously-included directories found matching 'build' 14:13:05 INFO - no previously-included directories found matching 'dist' 14:13:05 INFO - no previously-included directories found matching '.git*' 14:13:05 INFO - Successfully installed jsonschema functools32 14:13:05 INFO - Cleaning up... 14:13:05 INFO - Return code: 0 14:13:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:05 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:05 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 14:13:05 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 14:13:05 INFO - Using env: {'DISPLAY': ':0', 14:13:05 INFO - 'HOME': '/home/cltbld', 14:13:05 INFO - 'LANG': 'en_US.UTF-8', 14:13:05 INFO - 'LANGUAGE': 'en_US:en', 14:13:05 INFO - 'LOGNAME': 'cltbld', 14:13:05 INFO - 'MAIL': '/var/mail/cltbld', 14:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:05 INFO - 'MOZ_NO_REMOTE': '1', 14:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:05 INFO - 'NO_EM_RESTART': '1', 14:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:05 INFO - 'PWD': '/builds/slave/test', 14:13:05 INFO - 'SHELL': '/bin/bash', 14:13:05 INFO - 'SHLVL': '1', 14:13:05 INFO - 'TERM': 'linux', 14:13:05 INFO - 'TMOUT': '86400', 14:13:05 INFO - 'USER': 'cltbld', 14:13:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:05 INFO - '_': '/tools/buildbot/bin/python'} 14:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:13:05 INFO - Cleaning up... 14:13:05 INFO - Return code: 0 14:13:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:05 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:05 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 14:13:05 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 14:13:05 INFO - Using env: {'DISPLAY': ':0', 14:13:05 INFO - 'HOME': '/home/cltbld', 14:13:05 INFO - 'LANG': 'en_US.UTF-8', 14:13:05 INFO - 'LANGUAGE': 'en_US:en', 14:13:05 INFO - 'LOGNAME': 'cltbld', 14:13:05 INFO - 'MAIL': '/var/mail/cltbld', 14:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:05 INFO - 'MOZ_NO_REMOTE': '1', 14:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:05 INFO - 'NO_EM_RESTART': '1', 14:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:05 INFO - 'PWD': '/builds/slave/test', 14:13:05 INFO - 'SHELL': '/bin/bash', 14:13:05 INFO - 'SHLVL': '1', 14:13:05 INFO - 'TERM': 'linux', 14:13:05 INFO - 'TMOUT': '86400', 14:13:05 INFO - 'USER': 'cltbld', 14:13:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:05 INFO - '_': '/tools/buildbot/bin/python'} 14:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:13:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:13:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 INFO - Downloading docopt-0.6.1.tar.gz 14:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:13:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:13:08 INFO - Running setup.py install for blobuploader 14:13:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:13:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:13:09 INFO - Running setup.py install for requests 14:13:09 INFO - Running setup.py install for docopt 14:13:09 INFO - Successfully installed blobuploader requests docopt 14:13:09 INFO - Cleaning up... 14:13:09 INFO - Return code: 0 14:13:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:09 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:09 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 14:13:09 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 14:13:09 INFO - Using env: {'DISPLAY': ':0', 14:13:09 INFO - 'HOME': '/home/cltbld', 14:13:09 INFO - 'LANG': 'en_US.UTF-8', 14:13:09 INFO - 'LANGUAGE': 'en_US:en', 14:13:09 INFO - 'LOGNAME': 'cltbld', 14:13:09 INFO - 'MAIL': '/var/mail/cltbld', 14:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:09 INFO - 'MOZ_NO_REMOTE': '1', 14:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:09 INFO - 'NO_EM_RESTART': '1', 14:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:09 INFO - 'PWD': '/builds/slave/test', 14:13:09 INFO - 'SHELL': '/bin/bash', 14:13:09 INFO - 'SHLVL': '1', 14:13:09 INFO - 'TERM': 'linux', 14:13:09 INFO - 'TMOUT': '86400', 14:13:09 INFO - 'USER': 'cltbld', 14:13:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:09 INFO - '_': '/tools/buildbot/bin/python'} 14:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:09 INFO - Running setup.py (path:/tmp/pip-wugZge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:09 INFO - Running setup.py (path:/tmp/pip-5x1ahS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:09 INFO - Running setup.py (path:/tmp/pip-6iX0LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:09 INFO - Running setup.py (path:/tmp/pip-YCWN36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:10 INFO - Running setup.py (path:/tmp/pip-V6avNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:10 INFO - Running setup.py (path:/tmp/pip-kIHW4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:10 INFO - Running setup.py (path:/tmp/pip-yedzg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:10 INFO - Running setup.py (path:/tmp/pip-sLd6KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:10 INFO - Running setup.py (path:/tmp/pip-Na2_Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:10 INFO - Running setup.py (path:/tmp/pip-YW1Yu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:10 INFO - Running setup.py (path:/tmp/pip-Kt_nU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:10 INFO - Running setup.py (path:/tmp/pip-1JBd5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:10 INFO - Running setup.py (path:/tmp/pip-P4pXPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:13:10 INFO - Running setup.py (path:/tmp/pip-iGNSMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:10 INFO - Running setup.py (path:/tmp/pip-ed3Zmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:13:10 INFO - Running setup.py (path:/tmp/pip-Wftwp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:13:10 INFO - Running setup.py (path:/tmp/pip-xA48Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:13:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:13:10 INFO - Running setup.py install for manifestparser 14:13:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Running setup.py install for mozcrash 14:13:11 INFO - Running setup.py install for mozdebug 14:13:11 INFO - Running setup.py install for mozdevice 14:13:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Running setup.py install for mozfile 14:13:11 INFO - Running setup.py install for mozhttpd 14:13:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Running setup.py install for mozinfo 14:13:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Running setup.py install for mozInstall 14:13:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:13:11 INFO - Running setup.py install for mozleak 14:13:11 INFO - Running setup.py install for mozlog 14:13:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Running setup.py install for moznetwork 14:13:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Running setup.py install for mozprocess 14:13:12 INFO - Running setup.py install for mozprofile 14:13:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Running setup.py install for mozrunner 14:13:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Running setup.py install for mozscreenshot 14:13:12 INFO - Running setup.py install for moztest 14:13:12 INFO - Running setup.py install for mozversion 14:13:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:13:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:13:12 INFO - Cleaning up... 14:13:12 INFO - Return code: 0 14:13:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:12 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:12 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 14:13:12 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 14:13:12 INFO - Using env: {'DISPLAY': ':0', 14:13:12 INFO - 'HOME': '/home/cltbld', 14:13:12 INFO - 'LANG': 'en_US.UTF-8', 14:13:12 INFO - 'LANGUAGE': 'en_US:en', 14:13:12 INFO - 'LOGNAME': 'cltbld', 14:13:12 INFO - 'MAIL': '/var/mail/cltbld', 14:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:12 INFO - 'MOZ_NO_REMOTE': '1', 14:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:12 INFO - 'NO_EM_RESTART': '1', 14:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:12 INFO - 'PWD': '/builds/slave/test', 14:13:12 INFO - 'SHELL': '/bin/bash', 14:13:12 INFO - 'SHLVL': '1', 14:13:12 INFO - 'TERM': 'linux', 14:13:12 INFO - 'TMOUT': '86400', 14:13:12 INFO - 'USER': 'cltbld', 14:13:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:12 INFO - '_': '/tools/buildbot/bin/python'} 14:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:12 INFO - Running setup.py (path:/tmp/pip-4mjYS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:13 INFO - Running setup.py (path:/tmp/pip-vY9_Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:13 INFO - Running setup.py (path:/tmp/pip-Cog_wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:13 INFO - Running setup.py (path:/tmp/pip-I62Xgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:13 INFO - Running setup.py (path:/tmp/pip-ZLHrKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:13 INFO - Running setup.py (path:/tmp/pip-xBSUIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:13 INFO - Running setup.py (path:/tmp/pip-YQvIOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:13 INFO - Running setup.py (path:/tmp/pip-4AVdOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:13 INFO - Running setup.py (path:/tmp/pip-2JfKEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:13 INFO - Running setup.py (path:/tmp/pip-gU3rx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:13 INFO - Running setup.py (path:/tmp/pip-xNFzYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:13 INFO - Running setup.py (path:/tmp/pip-cuBUgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:13 INFO - Running setup.py (path:/tmp/pip-zNu9dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:13:13 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)) 14:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:13:13 INFO - Running setup.py (path:/tmp/pip-Su5fk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:13:14 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)) 14:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:14 INFO - Running setup.py (path:/tmp/pip-j8cC6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:14 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)) 14:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:13:14 INFO - Running setup.py (path:/tmp/pip-zdYw0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:13:14 INFO - Running setup.py (path:/tmp/pip-yF00wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:13:14 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)) 14:13:14 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)) 14:13:14 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)) 14:13:14 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)) 14:13:14 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)) 14:13:14 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)) 14:13:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:16 INFO - Downloading blessings-1.6.tar.gz 14:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:13:16 INFO - Installing collected packages: blessings 14:13:16 INFO - Running setup.py install for blessings 14:13:16 INFO - Successfully installed blessings 14:13:16 INFO - Cleaning up... 14:13:16 INFO - Return code: 0 14:13:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:16 INFO - Reading from file tmpfile_stdout 14:13:16 INFO - Current package versions: 14:13:16 INFO - argparse == 1.2.1 14:13:16 INFO - blessings == 1.6 14:13:16 INFO - blobuploader == 1.2.4 14:13:16 INFO - docopt == 0.6.1 14:13:16 INFO - functools32 == 3.2.3-2 14:13:16 INFO - jsonschema == 2.5.1 14:13:16 INFO - manifestparser == 1.1 14:13:16 INFO - mozInstall == 1.12 14:13:16 INFO - mozcrash == 1.0 14:13:16 INFO - mozdebug == 0.1 14:13:16 INFO - mozdevice == 0.49 14:13:16 INFO - mozfile == 1.2 14:13:16 INFO - mozhttpd == 0.7 14:13:16 INFO - mozinfo == 0.9 14:13:16 INFO - mozleak == 0.1 14:13:16 INFO - mozlog == 3.4 14:13:16 INFO - moznetwork == 0.27 14:13:16 INFO - mozprocess == 0.24 14:13:16 INFO - mozprofile == 0.28 14:13:16 INFO - mozrunner == 6.13 14:13:16 INFO - mozscreenshot == 0.1 14:13:16 INFO - mozsystemmonitor == 0.3 14:13:16 INFO - moztest == 0.8 14:13:16 INFO - mozversion == 1.4 14:13:16 INFO - psutil == 3.1.1 14:13:16 INFO - requests == 1.2.3 14:13:16 INFO - wsgiref == 0.1.2 14:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:16 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')]} 14:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:16 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')]} 14:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:16 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:16 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 14:13:16 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 14:13:16 INFO - Using env: {'DISPLAY': ':0', 14:13:16 INFO - 'HOME': '/home/cltbld', 14:13:16 INFO - 'LANG': 'en_US.UTF-8', 14:13:16 INFO - 'LANGUAGE': 'en_US:en', 14:13:16 INFO - 'LOGNAME': 'cltbld', 14:13:16 INFO - 'MAIL': '/var/mail/cltbld', 14:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:16 INFO - 'MOZ_NO_REMOTE': '1', 14:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:16 INFO - 'NO_EM_RESTART': '1', 14:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:16 INFO - 'PWD': '/builds/slave/test', 14:13:16 INFO - 'SHELL': '/bin/bash', 14:13:16 INFO - 'SHLVL': '1', 14:13:16 INFO - 'TERM': 'linux', 14:13:16 INFO - 'TMOUT': '86400', 14:13:16 INFO - 'USER': 'cltbld', 14:13:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:16 INFO - '_': '/tools/buildbot/bin/python'} 14:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 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)) 14:13:16 INFO - Cleaning up... 14:13:16 INFO - Return code: 0 14:13:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:13:16 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')]} 14:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:16 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')]} 14:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:16 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 0xa081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb18a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, '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': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', '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 14:13:16 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 14:13:16 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 14:13:16 INFO - Using env: {'DISPLAY': ':0', 14:13:16 INFO - 'HOME': '/home/cltbld', 14:13:16 INFO - 'LANG': 'en_US.UTF-8', 14:13:16 INFO - 'LANGUAGE': 'en_US:en', 14:13:16 INFO - 'LOGNAME': 'cltbld', 14:13:16 INFO - 'MAIL': '/var/mail/cltbld', 14:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:16 INFO - 'MOZ_NO_REMOTE': '1', 14:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:16 INFO - 'NO_EM_RESTART': '1', 14:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:16 INFO - 'PWD': '/builds/slave/test', 14:13:16 INFO - 'SHELL': '/bin/bash', 14:13:16 INFO - 'SHLVL': '1', 14:13:16 INFO - 'TERM': 'linux', 14:13:16 INFO - 'TMOUT': '86400', 14:13:16 INFO - 'USER': 'cltbld', 14:13:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:16 INFO - '_': '/tools/buildbot/bin/python'} 14:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:13:17 INFO - Cleaning up... 14:13:17 INFO - Return code: 0 14:13:17 INFO - Running post-action listener: _resource_record_post_action 14:13:17 INFO - Running post-action listener: _start_resource_monitoring 14:13:17 INFO - Starting resource monitoring. 14:13:17 INFO - [mozharness: 2017-01-16 22:13:17.208203Z] Finished create-virtualenv step (success) 14:13:17 INFO - [mozharness: 2017-01-16 22:13:17.208735Z] Running install step. 14:13:17 INFO - Running pre-action listener: _resource_record_pre_action 14:13:17 INFO - Running main action method: install 14:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:17 INFO - Reading from file tmpfile_stdout 14:13:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:13:17 INFO - Reading from file tmpfile_stdout 14:13:17 INFO - Output received: 14:13:17 INFO - Usage: mozinstall [options] installer 14:13:17 INFO - Options: 14:13:17 INFO - -h, --help show this help message and exit 14:13:17 INFO - -d DEST, --destination=DEST 14:13:17 INFO - Directory to install application into. [default: 14:13:17 INFO - "/builds/slave/test"] 14:13:17 INFO - --app=APP Application being installed. [default: firefox] 14:13:17 INFO - mkdir: /builds/slave/test/build/application 14:13:17 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'] 14:13:17 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 14:13:34 INFO - Reading from file tmpfile_stdout 14:13:34 INFO - Output received: 14:13:34 INFO - /builds/slave/test/build/application/firefox/firefox 14:13:34 INFO - Running post-action listener: _resource_record_post_action 14:13:34 INFO - [mozharness: 2017-01-16 22:13:34.961710Z] Finished install step (success) 14:13:34 INFO - [mozharness: 2017-01-16 22:13:34.961983Z] Running run-tests step. 14:13:34 INFO - Running pre-action listener: _resource_record_pre_action 14:13:34 INFO - Running main action method: run_tests 14:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:13:34 INFO - Python 2.7.3 14:13:34 INFO - Return code: 0 14:13:34 INFO - grabbing minidump binary from tooltool 14:13:34 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')]} 14:13:34 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 0xe03850>, '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 0xd786d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd78b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:13:34 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 14:13:34 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 14:13:34 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 14:13:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:13:35 INFO - Return code: 0 14:13:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:13:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:13:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:13:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:13:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:13:35 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/1484597251/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:13:35 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/1484597251/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 14:13:35 INFO - Using env: {'DISPLAY': ':0', 14:13:35 INFO - 'HOME': '/home/cltbld', 14:13:35 INFO - 'LANG': 'en_US.UTF-8', 14:13:35 INFO - 'LANGUAGE': 'en_US:en', 14:13:35 INFO - 'LOGNAME': 'cltbld', 14:13:35 INFO - 'MAIL': '/var/mail/cltbld', 14:13:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:13:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:35 INFO - 'MOZ_NO_REMOTE': '1', 14:13:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:35 INFO - 'NO_EM_RESTART': '1', 14:13:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:35 INFO - 'PWD': '/builds/slave/test', 14:13:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:13:35 INFO - 'SHELL': '/bin/bash', 14:13:35 INFO - 'SHLVL': '1', 14:13:35 INFO - 'TERM': 'linux', 14:13:35 INFO - 'TMOUT': '86400', 14:13:35 INFO - 'USER': 'cltbld', 14:13:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324', 14:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:35 INFO - '_': '/tools/buildbot/bin/python'} 14:13:35 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/1484597251/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:13:35 INFO - mozversion application_buildid: 20170116120731 14:13:35 INFO - mozversion application_changeset: 96b9fad20c92f638a7ef03bcff262ca0563090bc 14:13:35 INFO - mozversion application_display_name: Nightly 14:13:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:13:35 INFO - mozversion application_name: Firefox 14:13:35 INFO - mozversion application_remotingname: firefox 14:13:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:13:35 INFO - mozversion application_vendor: Mozilla 14:13:35 INFO - mozversion application_version: 53.0a1 14:13:35 INFO - mozversion platform_buildid: 20170116120731 14:13:35 INFO - mozversion platform_changeset: 96b9fad20c92f638a7ef03bcff262ca0563090bc 14:13:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:13:35 INFO - mozversion platform_version: 53.0a1 14:13:35 INFO - using testdate: 1484604815 14:13:35 INFO - actual date: 1484604815 14:13:35 INFO - starting webserver on 'localhost:60300' 14:13:35 INFO - SUITE-START | Running 2 tests 14:13:35 INFO - TEST-START | dromaeo_css 14:13:35 INFO - operating with platform_type : linux_ 14:13:35 INFO - Initialising browser for dromaeo_css test... 14:13:35 INFO - TEST-INFO | started process 26693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DHPTl/profile http://localhost:60300/getInfo.html) 14:13:39 INFO - PROCESS | 26693 | __metrics Screen width/height:1600/1200 14:13:39 INFO - PROCESS | 26693 | colorDepth:24 14:13:39 INFO - PROCESS | 26693 | Browser inner width/height: 1024/697 14:13:39 INFO - PROCESS | 26693 | __metrics 14:13:39 INFO - PROCESS | 26693 | 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" 14:13:39 INFO - PROCESS | 26693 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:13:40 INFO - PROCESS | 26693 | console.error: 14:13:40 INFO - PROCESS | 26693 | Message: Error: Connection closed before committing the transaction. 14:13:40 INFO - PROCESS | 26693 | Stack: 14:13:40 INFO - PROCESS | 26693 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 14:13:40 INFO - PROCESS | 26693 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 14:13:40 INFO - PROCESS | 26693 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 14:13:40 INFO - PROCESS | 26693 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 14:13:40 INFO - PROCESS | 26693 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 14:13:40 INFO - PROCESS | 26693 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 14:13:40 INFO - PROCESS | 26693 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 14:13:40 INFO - PROCESS | 26693 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 14:13:40 INFO - PROCESS | 26693 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 14:13:40 INFO - PROCESS | 26693 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 14:13:40 INFO - PROCESS | 26693 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 14:13:40 INFO - PROCESS | 26693 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 14:13:40 INFO - PROCESS | 26693 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 14:13:40 INFO - PROCESS | 26693 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 14:13:40 INFO - PROCESS | 26693 | 14:13:40 INFO - PROCESS | 26693 | console.error: PushService: 14:13:40 INFO - PROCESS | 26693 | stateChangeProcessEnqueue: Error transitioning state 14:13:40 INFO - PROCESS | 26693 | UnknownError 14:13:41 INFO - TEST-INFO | 26693: exit 0 14:13:41 INFO - Browser initialized. 14:13:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:13:41 INFO - TEST-INFO | started process 26776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DHPTl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:53 INFO - PROCESS | 26776 | RSS: Main: 147738624 14:13:53 INFO - PROCESS | 26776 | 14:16:53 INFO - PROCESS | 26776 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60300/tests/dromaeo/cssquery-ext.html) 14:16:55 INFO - PROCESS | 26776 | RSS: Main: 334909440 14:16:55 INFO - PROCESS | 26776 | 14:18:43 INFO - PROCESS | 26776 | ************************* 14:18:43 INFO - PROCESS | 26776 | A coding exception was thrown and uncaught in a Task. 14:18:43 INFO - PROCESS | 26776 | 14:18:43 ERROR - PROCESS | 26776 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:18:43 INFO - PROCESS | 26776 | Full stack: 14:18:43 INFO - PROCESS | 26776 | ************************* 14:19:58 INFO - PROCESS | 26776 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-ext.html (next: http://localhost:60300/tests/dromaeo/cssquery-jquery.html) 14:19:58 INFO - PROCESS | 26776 | RSS: Main: 244359168 14:19:58 INFO - PROCESS | 26776 | 14:23:00 INFO - PROCESS | 26776 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60300/tests/dromaeo/cssquery-mootools.html) 14:23:01 INFO - PROCESS | 26776 | RSS: Main: 179126272 14:23:01 INFO - PROCESS | 26776 | 14:26:03 INFO - PROCESS | 26776 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60300/tests/dromaeo/cssquery-prototype.html) 14:26:03 INFO - PROCESS | 26776 | RSS: Main: 214781952 14:26:03 INFO - PROCESS | 26776 | 14:29:06 INFO - PROCESS | 26776 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60300/tests/dromaeo/cssquery-yui.html) 14:29:07 INFO - PROCESS | 26776 | RSS: Main: 181825536 14:29:07 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-yui.html (next: http://localhost:60300/tests/dromaeo/cssquery-dojo.html) 14:32:10 INFO - PROCESS | 26776 | RSS: Main: 268877824 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | __start_tp_report 14:32:10 INFO - PROCESS | 26776 | _x_x_mozilla_page_load 14:32:10 INFO - PROCESS | 26776 | _x_x_mozilla_page_load_details 14:32:10 INFO - PROCESS | 26776 | |i|pagename|runs| 14:32:10 INFO - PROCESS | 26776 | |0;dojo.html;3160.604924384452;3185.490321548553;3206.038188543437;3221.0497903118576;3226.33860058688;5144.17693169093;5201.8439446816565;5281.973590132049;5380.461953804623;5394.568434525238;5309.495597918201;5320.281761962134;5349.491798279158;5356.143017117262;5419.864503387407;4805.471398146201;4809.398825146856;4820.132376172288;4881.145799485093;4997.60019198465;4530.254513463524;4781.474037855833;4934.605231581483;4955.1080805455;4995.275685025669;4737.218358970766;4758.976205118952;4906;4947.406311242638;4968.726720030397;4805.159097158018;4820.927686084711;4837.129316722989;4873.8781530461665;4920.138975679241;4839.806407743686;4850.102730994778;4860.416749989989;4869.464358920516;4905.509449055102;5134.204198349262;5258.894822103536;5315.069862773999;5318.5213330800025;5336.172893201521;5584.91622625661;5687.601867869251;5693.4875861172695;5722.628029178131;5723.942760572424;5786.0742281235225;5804.59367844251;5818.1272809078555;5862.032764593837;5862.355140934494;5428.212909128154;5432;5435.1847222916485;5436.755346009479;5436.809711660152;5517.69652669107;5657.745401456944;5934.258217722699;5940.70296485174;5944.583879128506;5482.616216864782;5489.094299440628;5492.286002819687;5564.1931919871395;5596.748146333425;5596.076647353222;5649.802256921071;5656.773729050792;5660.405657405995;5666.008448521492;5472;5503.642263252876;5510.0632892408385;5545.362283337387;5600.0759874620235;5562.582806289544;5562.805301814417;5564.721763911788;5653.971730141323;5668.008098582814;4416.955830441654;4419.734815911055;4455.532169122195;4460.576245256695;4461.397711308931;3945.349017412095;3952.6837852971694;3957.426173204869;3958.44581758554;3987.063040185554;5170.069387510209;5223.3209682741;5308.23030660552;5322.0952438085615;5360.758765855546;5651.152327150878;5674.716264186774;5730.312362516442;5757.9424205757405;5776.249087618583;5343.492368225013;5392.245085688007;5395.73021348931;5400.810971615974;5405.567554595702;4847.466778654345;4876.707397556158;4978.4025916890205;4978.551930326288;5015.3480047593575;5885.293764748258;5897.321807992136;5923.7926672566255;6025.487833534024;6028.457438830526;5790;5797.884042319214;5804.419558044162;5807.593468457168;5848.181254624271;5972.193753843176;5972.25346831646;5973.253343332083;5974.074018527135;5976.641401515923;5476.041692703681;5487.780488780564;5558.944410555842;5583.35791383996;5700.5154561861045;5722.084466485342;5726.112452569859;5726.5418766499415;5728.1694154348215;5755.827325180251;5590.636608620427;5592.133219351007;5597.972010139923;5598.048331783525;5598.3282006159525;5454.836354909359;5495.752691128989;5534.723263836872;5586.413426590149;5599.720013999366;5563.972180139073;5572.359178694502;5574.888502229852;5577.721113944205;5583.190437386637;5567.55459563242;5599.468050535193;5604.467575580314;5608.242887210337;5611.270534830446;5410.1343784994215;5515.834524964257;5523.392426832965;5554.805581804618;5567.638103523258 14:32:10 INFO - PROCESS | 26776 | |1;ext.html;525.3851516368654;587.673841018235;609.0681257675755;613.595027281994;652.5106170372221;32742.67257327426;42865.142697146075;43905.78047109768;43953.340699889486;44005.7799711001;47513.287300690434;47643.761781191046;47958;48013;48030.51969480304;8591.441556298852;8787.560621968907;8934.776630584221;9127.041660625639;9130.452172869649;10640.255182137253;10944.56221751129;10951.069159121444;11367.147463940197;11377.2035957483;10684.679459616224;10719.088877445427;10758.892411075907;10762.085222756075;10768.24622276441;10870.456477176149;10897.727556811144;10928.071113955324;10939.617113401033;10972.561097556088;10741.946290268577;10805.297655652435;10827.512761925733;10830.187735919837;10830.241883068189;43670.781646091884;43975.560244397464;44027.11945761067;44039.33940990888;44064.11871762547;4277.572242775728;4292.763897985609;4313.547077556843;4360.934585981213;4418.977905110486;32216.83891580527;33032.83483582567;33393.6660633393;33396.6660333396;34085.829570852235;4261.424707664457;4385.6710746694125;4423.778811059434;4447.688661793676;4584.954150458486;322578.83896254544;324889;326274.9999999976;327218;328384;59777.402225978054;59936.700316498136;59996.700016499635;60123.39876601265;60192.39807601868;63438.36561634417;63461;63472.36527634757;63581.682091589246;63583.913286936935;17618.383356582457;17982.37061702834;17990.640187196183;17997.460076197734;18015.72976405355;12615.93692031534;12976.935115324362;13242.404091815699;13558.11872228302;13710.17738935667;16948.661026779395;17003.809733318798;17031.82968170327;17036.27419612856;17338;6282.937170628326;6292.590981586274;6395.904061439082;6400.647964361911;6469.5794773339585;923.9214666753401;947.2942657720042;960.644561512245;978.6917121106828;989.1246247071393;31880.681193188237;31994.360112797614;32079.679203208136;32235.35529289401;32614.673853261163;1040.8022475729588;1125.5272785430138;1133.5862410220375;1134.194721747552;1172.050638982427;16930.492085237463;17192.91403542974;17232.224549895283;17237.31050757981;17355.21901514435;490233;494101;495286;495904;497940;62787.68606157031;62936.18893354934;62944.68527657424;63122.68438657777;63192;1420.7229590229806;1472.0799500312305;1472.2050092949687;1473.2854565535706;1490.5379332406987;29569.26076848096;31024.379512410076;31380.372392551566;31445.371092578476;31585.052448426584;52809.20786188133;54289.18566221431;54299;54382.456175437736;54403.72798135984;377790;378486;380252;381418;381746;35023.824880876455;35974.28051439009;38263;40131;41085.58914410818;49004;49048.75475622599;49348.50651493583;49529.752351238014;49702.502974969786;41547.7922610385;41828;41945;42421;43974.340384893614;40258.597414025484;41268.587314127675;41546.376804347354;42640.573594264904;42752.57247427486;41322;41764.791176043924;42120.78939605282;42266.788666057706;42283.15433691248;33696.663033369354;35902.461463077554;36678.63321366859;36689;37031.62968370282;27318.453630926873;27833.304167395978;27897.302567435978;28027.439451210455;28045.719542805127 14:32:10 INFO - PROCESS | 26776 | |2;jquery.html;422.98942526436815;425.2072045265849;432.6884643056999;433.6010869999601;438.9912201755967;19242.440148572507;19711.31010414634;20903.68644470334;21056.789432105674;21207;20451.43979971474;21723.67414488784;21823.890880545616;21958.23146189884;22010.44973875654;5741.138829175616;5976.641401515902;5983.880322393549;5984.88030239395;5991.700414979256;5677.659340439587;5847.093700476433;5858.179854820329;5865.237519122529;5911.704414779244;5868.706564671771;5878.118282257674;5882.14708867214;5883.529317654598;5890.087036509327;5733.55649371736;5837.795677151301;5931;5940.554458415636;5941.940580594203;5289.814856480043;5345.251664766935;5357;5357.008953343644;5361.0618141825025;25191.118310859216;25350.112746053983;25555.872220638965;25601.487970240676;25764.871175644003;2767.7785777137983;2768.4484448624075;2796.734310240524;2817.5632776919406;2851;15020.924895375563;15285.082895026335;15313.157776322298;15324.23378831054;16059.518214453468;1923.6441258367247;1960.137539482623;1964.302672551238;1974.2596526302636;2024.6153230886084;66106.66946665235;68772.6561367195;69027.78749912482;79577.20422795755;89050.55474722585;9193.586288617029;10774.175167815469;10937.070349020423;11090.500927458284;11393.373364465035;16377.543368494582;16389;16394.754078688828;16467.34130634785;16529.917350413172;8996.82006359869;9041.18629323364;9089.954550227207;9205.171534561787;9230.815383692423;8730.738077857675;8777.648894044167;8850.114988501098;8989.190972812348;9049.954750226338;7278.344948954619;7530.359919406912;7565.735199268;7707.922920770833;7737.148913619498;2057.86623869448;2104.6948192512;2129.9041543130597;2139.4330502416874;2154.526004279056;902.6569903436653;920.300571565615;925.1072714830086;938.3712912348607;955.3933252384646;19711.310104146287;19893.303734369227;21019.579608407745;21152.576948460945;21348.466288342916;938.4134915677702;942.6520274460596;956.9234461243084;965.2037069417759;970.694231317147;11388.829167562493;11684.371016521214;11796.233244839059;11819.286203500444;11874.406279685982;601566;611903;613712;615583;629017;78562.6071869637;88958.55520722484;89255.55372223098;90025;90731;1006.8489726540931;1014.5383850348074;1060.5015642647943;1100.9559617615366;1136.1422126294594;18281.725774113133;18633.72049419287;19207.8079219206;19454.513637159183;19495.050494950392;39826.203475930895;40518.59481405148;40952.79523602363;41351.37972930348;41856.79071604623;53634;54554.09060682857;54934.45065549293;55046;55629.44370556243;8507.319414446705;8838.911610883808;9003.864942026006;9098.729519405339;9382.906170938204;13504.729905402033;13583.592492225249;13712.108712933627;13874.583762487142;13944.721105577628;11756.470958806703;12033.518659253532;12072.3360215189;12079.154459187772;12332.630021099381;6161.815145545641;8279.834403312021;11703.824442633197;11711.531538738354;11824.290542567473;11570.59502917394;11622.767544649229;11742.354170520703;12051.57819476314;12411.255324680547;7608;7840.803979900548;8673.739787806377;8809.11908809114;9185.908140918506;11541.538338466367;11860.169788114748;11906;12045.63863084109;12412.317322546985 14:32:10 INFO - PROCESS | 26776 | |3;mootools.html;1482.5700546841404;1482.6515768794338;1484.0650390254139;1498.6403263216826;1502.8046353973982;8050.557219352941;8560.657573697044;8569.057403685598;8575.699850505234;8578.356623253258;7334.743283985062;7592.810179745509;8116.431849770518;8335.958320208405;8369.20492553208;2303.7120359955006;2339.532093581282;2342.3207269891795;2342.7774361435722;2344.003798385679;2237.1498830444407;2266.4447210433386;2276.590213761522;2277.1346888182466;2277.840551161419;2038.7247721557549;2105.6736205888037;2105.7157283766724;2120.0883620043373;2235.228846048119;2249.853759505627;2287.7597852225445;2291.621882389412;2293.9197128100604;2293.9770602294097;2217.6008318502663;2279.350385140227;2296.8392212544964;2301.0450662974845;2301.401635574746;8544.530050847201;8601.913980860174;8616.439931404502;8620.353473489513;8696.739097827076;5150.227465880111;5306.946930530722;5313.57491400687;5313.920291195635;5314.335708036496;3075.169704179881;3205.5351973963643;3364.915877103092;3365.1923538350866;3380.7464440167087;1271.8346614940092;1283.1082397733578;1330.7405056013984;1365.590322903125;1395.553422904671;11304.886951130466;11351.318920864693;11389.145814063979;11390.373529455877;11402.71493212668;4344.913101737948;4528.207563676344;4564.977175114103;4572.0855828834365;4674.579287864109;9887.159591434809;9986.550605222637;9993.200543956611;10001.449920254456;10008;5255.185446255837;5271.683698978073;5281.973590132102;5296.285001524822;5298.258243845865;4715.575598196178;4726.716397016121;4805.927911081337;4954.40547134339;5006.499350065037;3858.1319203179623;3966.464527288779;3969.900752481211;3978.42312864633;4004.2191772604647;1272.4973635414144;1276.189619591566;1291.070429290909;1299.6555912683148;1311.4295281552554;964;970.3401686852867;979.0796651147898;983.3165949665057;996.4818294486827;5512.586556008235;5515.972420137874;5567.693776842231;5621.353544342453;5642.448326710188;558.2101326622783;560.6383882395913;570.0736303506801;573.1173992052193;583.4544700704854;3775.093977445393;3793.430985352219;3794.4498047782918;3810.580836108026;3888.047428380065;9528.761780955532;10090.394576325443;10146.746331341776;10164.28849980509;10208;9766.804663906682;9848.753781155385;10069.949650251701;10087.293889427816;10093.142082923034;7575.886361704579;7950.960245198737;7963.800904977306;7964.004499437686;7965.243301886311;5755.884882302415;5756.827295181151;5807.506361959281;5877.911831322448;6003.369646187262;9511.286653501153;9517.52412379392;9553.808923821623;9586.520673966133;9648.75878103053;9300.813983720423;9888.653897113567;9952.402855828674;9954.950225248827;9956.800863982824;7365.558066515812;7451.3293803557945;7452.739154129579;7460.738874139379;7479.476436649382;7702.768916932501;7829.138794732688;7856.607169641381;7885.5662938538935;7912.28789408956;6995.160580730345;7091.9290807091265;7101.751438699621;7111.573305601681;7126.679299431435;6985.511014228955;7009.544379615309;7082.468814838805;7084.574925504487;7101.041359416619;6359.8092057238355;6438.5171112165835;6443.162388889415;6448.967755161194;6455.289918108911;4802.543758342952;4815.783289752039;4862.149123903232;4925.359703238556;5030.748462576929;4886.853394398174;4909.803607855789;4978.103941290602;4978.800847966041;5010.423801262901 14:32:10 INFO - PROCESS | 26776 | |4;prototype.html;371.32048351516727;372.9813509324533;391.9274934137183;402.3763167091008;406.28493850822554;5096.210087436449;5153.742312884355;5230.189320655295;5250.212468129783;5290.444503327153;5053.671511351759;5159.896802063957;5171.948280517194;5214.895702085956;5232;4245.384419259206;4248.236981652611;4250.789589413504;4254.510731265897;4284.550122237167;4108.52751933527;4182.682455026672;4198.992241861962;4246.087091275375;4292.549282325342;4225.873223803291;4251.659867210616;4259.6805239607;4262;4270.274053410912;4231.830726770925;4246.596573325529;4246.617804397603;4254.212970600418;4294.634956028742;3775.169462718198;3796.3546197146275;3814.809259537012;3824.598417166213;3911.5697273299916;5086.364204474441;5093.083245015896;5120.359955005624;5122.820701275437;5144.485551444863;4799.1601469743;4818.927716084261;4828.879278018043;4840.394950631171;4842.830500932486;5260.790018295814;5491.588130890199;5542.362628297717;5557.527610153142;5569.10894256917;4249.128928569636;4251.723637963522;4253.21315556623;4262.403263543107;4278.871633850989;5780.450857168562;5788.507976821975;5793.623414478046;5796.362400136024;5821.243238378984;4291.592298731615;4342.934855977162;4359.585839345257;4377.5403582624;4390.582894625006;4147.776405960249;4396.142752163298;4415.196350317571;4417.425734654538;4428.844990425319;4713.552212539872;4726.456457507362;4792.736399497991;4798.992211635526;4821.397325334333;5531.419200983839;5546.140348246028;5557.861053473695;5579.69311687861;5588.720563971785;1465.948691795782;1484.5768955847532;1494.886309699281;1501.4894935721907;1503.240863363994;1059.8410238464292;1074.435921141407;1087.8150714378576;1097.226455348993;1101.6805126513382;5086.18621020635;5153.5361817436615;5158.845234642967;5196.870078247998;5202.97398513005;5485.040117979338;5499.807506737245;5508.3114610673665;5510.504054635102;5518.586106041983;4873.415190177201;5104.617153713486;5111.821086261963;5151.150060240094;5171.974140129275;2892.291388609804;2904.520754075596;2910.3160757222035;2912.713519886921;2924.166612515423;5637.520810731134;5641.041023026095;5646.539234005172;5664.26364572603;5688.516476099578;5246.265522826808;5564.582656300794;5585.609007369527;5619.775208991677;5651.943480565142;5690.5447564194765;5691.288588926384;5704.743286552115;5708.8610757200695;5711.286089238928;5225.817096401608;5523.502884740393;5534.236719030937;5556.833295001156;5563.7774489019985;5400.243965844864;5424.376196737426;5427.348718153847;5444.8094316698725;5480.588955828409;5619;5644.8428072245915;5650.180723794944;5652.152177173457;5657.4908258256955;4050.233283046795;4181.372794080912;4188.727732697365;4261.936070958876;4271.380649805823;5368.1679339702405;5417.6478528895495;5489.862753431196;5493.258410114583;5493.752781124939;5324.866878327918;5352.866178345573;5506.421825708403;5521.420250873761;5550.97224513891;5254.527092561688;5474.616776825584;5478.179202301949;5500.642458240201;5506.5682922439655;5397.757100930546;5432.565394768488;5444.782208711607;5455.990641731292;5476.534494568006;5516;5520.199571062093;5521.69630670317;5535.280413546213;5537.058700020925;5256.842294731164;5356.812511562077;5362.881661743668;5383.703896285742;5417.241586177859 14:32:10 INFO - PROCESS | 26776 | |5;yui.html;776.4409625069948;783.925527074928;788.6041706180062;793.9841203175937;836.8284501677157;15683.84316156838;16515.504534863943;17074;17161.485155445356;17256.30974761011;14275.571732848031;14388.352524136413;14698.485553005647;14701.1914344711;15909.681806363866;745.243577768564;761.7067429039804;762.3063012658482;766.4443278622981;768.4121646940096;658.4666420199629;663.575311800448;669.6651674162919;675.9459243260527;766.3868904876105;782.030282449761;809.5709274084744;811.7037281392279;816.5672193737299;817.2277198047847;804.63389157933;805.0259186384482;805.8630032894392;806.1374329467473;806.2300503019632;498.3546307531755;587.2835141127817;587.7942720047992;587.9118132280149;588.020945126364;12944.935275323658;15498.30257638409;15962.521124366287;16022.599435014217;16042.919785401114;15690;15922.60193495172;15993.482248624206;16194.271257793427;16551.337946482246;12457.377131143498;12556.560520381834;12597.811032834516;12644.683882903;12818.166819156819;3719.479272901796;3750.8124593770203;3801.5425394104836;3823.1780167264174;3833.6358045985867;76109.61945190238;77406.61296693537;79084;79838.60080699617;80060;12203.69490762738;12230.816537751942;12284;12323.383830808423;13039.934800325938;23443;23745.287641370785;23825;23907.880460597586;23986.28041158768;8287.709930152416;8389.916100839035;8471;8495.490270583785;8568.443051201652;4413.624841888475;4437.556244375602;4514.232580461329;4539.84110556129;4603.102395033004;3667.8716244931834;3717.20080182762;3744.588095309514;3758.8496460141287;3759.86840460588;643.5784561112479;649.4577028181521;687.8039758668756;701.3617607976716;726.7819654103748;759.2748924776935;767.301755402581;797.7965618767294;808.0787901791962;832.9000519937646;10265.486725663686;10914.672559823219;10920.235583509078;11138.554457821758;11272.830907536394;751.7707099334756;772.9922700773033;776.0958483366927;777.5995362388375;781.941354398411;4869.95130048695;5040.31955685985;5093.541581257705;5158.380994280636;5175.767090480937;75016;75486;76909.61545192238;77066;79792;67892.3210767896;68309.31690683129;68572;68851.31148688549;69200;60394;61492.69253653793;61869;61894.69052654798;64701.676491618186;9875.942109629921;10011.799764004534;10040.297179197387;10058.748531286483;10090.495475226357;42808.35787463253;43217.783911080245;44239.77880110707;44532.77733611311;44674;53745.462545374045;53906.73046634742;54771;54939.72530137324;55126.72436637791;12931;13099.345032748133;13402.865971340161;13494.797578036534;13871.167729936236;14899.180545070125;15102.773458397913;15562.844371556139;15683.686326273639;16228;14431.278436077944;14799.704005919606;15137.62155946066;15306.23468826532;15768.19070183605;14225.573232803032;14448.494302699355;15152.090874547563;15300.846991529943;15397.153156576496;14480.203588802717;14516.274186290431;14634.121952682874;15087.39650414015;15300.923495382453;12050.397480126134;12057.216280941711;12099;12161.39193040362;12361.196522226026;11746.70633234176;11959.641210763692;12195.75608487843;12424.689382765504;12729.236245825281 14:32:10 INFO - PROCESS | 26776 | __end_tp_report 14:32:10 INFO - PROCESS | 26776 | __start_cc_report 14:32:10 INFO - PROCESS | 26776 | _x_x_mozilla_cycle_collect,1740 14:32:10 INFO - PROCESS | 26776 | __end_cc_report 14:32:10 INFO - PROCESS | 26776 | __startTimestamp1484605930616__endTimestamp 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | ------- Summary: start ------- 14:32:10 INFO - PROCESS | 26776 | Number of tests: 6 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | [#0] dojo.html Cycles:165 Average:5302.96 Median:5492.29 stddev:582.40 (10.6%) stddev-sans-first:559.41 14:32:10 INFO - PROCESS | 26776 | Values: 3160.6 3185.5 3206.0 3221.0 3226.3 5144.2 5201.8 5282.0 5380.5 5394.6 5309.5 5320.3 5349.5 5356.1 5419.9 4805.5 4809.4 4820.1 4881.1 4997.6 4530.3 4781.5 4934.6 4955.1 4995.3 4737.2 4759.0 4906.0 4947.4 4968.7 4805.2 4820.9 4837.1 4873.9 4920.1 4839.8 4850.1 4860.4 4869.5 4905.5 5134.2 5258.9 5315.1 5318.5 5336.2 5584.9 5687.6 5693.5 5722.6 5723.9 5786.1 5804.6 5818.1 5862.0 5862.4 5428.2 5432.0 5435.2 5436.8 5436.8 5517.7 5657.7 5934.3 5940.7 5944.6 5482.6 5489.1 5492.3 5564.2 5596.7 5596.1 5649.8 5656.8 5660.4 5666.0 5472.0 5503.6 5510.1 5545.4 5600.1 5562.6 5562.8 5564.7 5654.0 5668.0 4417.0 4419.7 4455.5 4460.6 4461.4 3945.3 3952.7 3957.4 3958.4 3987.1 5170.1 5223.3 5308.2 5322.1 5360.8 5651.2 5674.7 5730.3 5757.9 5776.2 5343.5 5392.2 5395.7 5400.8 5405.6 4847.5 4876.7 4978.4 4978.6 5015.3 5885.3 5897.3 5923.8 6025.5 6028.5 5790.0 5797.9 5804.4 5807.6 5848.2 5972.2 5972.3 5973.3 5974.1 5976.6 5476.0 5487.8 5558.9 5583.4 5700.5 5722.1 5726.1 5726.5 5728.2 5755.8 5590.6 5592.1 5598.0 5598.0 5598.3 5454.8 5495.8 5534.7 5586.4 5599.7 5564.0 5572.4 5574.9 5577.7 5583.2 5567.6 5599.5 5604.5 5608.2 5611.3 5410.1 5515.8 5523.4 5554.8 5567.6 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | [#1] ext.html Cycles:180 Average:57918.23 Median:40672.09 stddev:107156.44 (263.5%) stddev-sans-first:107370.40 14:32:10 INFO - PROCESS | 26776 | Values: 525.4 587.7 609.1 613.6 652.5 32742.7 42865.1 43905.8 43953.3 44005.8 47513.3 47643.8 47958.0 48013.0 48030.5 8591.4 8787.6 8934.8 9127.0 9130.5 10640.3 10944.6 10951.1 11367.1 11377.2 10684.7 10719.1 10758.9 10762.1 10768.2 10870.5 10897.7 10928.1 10939.6 10972.6 10741.9 10805.3 10827.5 10830.2 10830.2 43670.8 43975.6 44027.1 44039.3 44064.1 4277.6 4292.8 4313.5 4360.9 4419.0 32216.8 33032.8 33393.7 33396.7 34085.8 4261.4 4385.7 4423.8 4447.7 4585.0 322578.8 324889.0 326275.0 327218.0 328384.0 59777.4 59936.7 59996.7 60123.4 60192.4 63438.4 63461.0 63472.4 63581.7 63583.9 17618.4 17982.4 17990.6 17997.5 18015.7 12615.9 12976.9 13242.4 13558.1 13710.2 16948.7 17003.8 17031.8 17036.3 17338.0 6282.9 6292.6 6395.9 6400.6 6469.6 923.9 947.3 960.6 978.7 989.1 31880.7 31994.4 32079.7 32235.4 32614.7 1040.8 1125.5 1133.6 1134.2 1172.1 16930.5 17192.9 17232.2 17237.3 17355.2 490233.0 494101.0 495286.0 495904.0 497940.0 62787.7 62936.2 62944.7 63122.7 63192.0 1420.7 1472.1 1472.2 1473.3 1490.5 29569.3 31024.4 31380.4 31445.4 31585.1 52809.2 54289.2 54299.0 54382.5 54403.7 377790.0 378486.0 380252.0 381418.0 381746.0 35023.8 35974.3 38263.0 40131.0 41085.6 49004.0 49048.8 49348.5 49529.8 49702.5 41547.8 41828.0 41945.0 42421.0 43974.3 40258.6 41268.6 41546.4 42640.6 42752.6 41322.0 41764.8 42120.8 42266.8 42283.2 33696.7 35902.5 36678.6 36689.0 37031.6 27318.5 27833.3 27897.3 28027.4 28045.7 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | [#2] jquery.html Cycles:180 Average:32639.69 Median:41604.09 stddev:100486.82 (241.5%) stddev-sans-first:100739.60 14:32:10 INFO - PROCESS | 26776 | Values: 423.0 425.2 432.7 433.6 439.0 19242.4 19711.3 20903.7 21056.8 21207.0 20451.4 21723.7 21823.9 21958.2 22010.4 5741.1 5976.6 5983.9 5984.9 5991.7 5677.7 5847.1 5858.2 5865.2 5911.7 5868.7 5878.1 5882.1 5883.5 5890.1 5733.6 5837.8 5931.0 5940.6 5941.9 5289.8 5345.3 5357.0 5357.0 5361.1 25191.1 25350.1 25555.9 25601.5 25764.9 2767.8 2768.4 2796.7 2817.6 2851.0 15020.9 15285.1 15313.2 15324.2 16059.5 1923.6 1960.1 1964.3 1974.3 2024.6 66106.7 68772.7 69027.8 79577.2 89050.6 9193.6 10774.2 10937.1 11090.5 11393.4 16377.5 16389.0 16394.8 16467.3 16529.9 8996.8 9041.2 9090.0 9205.2 9230.8 8730.7 8777.6 8850.1 8989.2 9050.0 7278.3 7530.4 7565.7 7707.9 7737.1 2057.9 2104.7 2129.9 2139.4 2154.5 902.7 920.3 925.1 938.4 955.4 19711.3 19893.3 21019.6 21152.6 21348.5 938.4 942.7 956.9 965.2 970.7 11388.8 11684.4 11796.2 11819.3 11874.4 601566.0 611903.0 613712.0 615583.0 629017.0 78562.6 88958.6 89255.6 90025.0 90731.0 1006.8 1014.5 1060.5 1101.0 1136.1 18281.7 18633.7 19207.8 19454.5 19495.1 39826.2 40518.6 40952.8 41351.4 41856.8 53634.0 54554.1 54934.5 55046.0 55629.4 8507.3 8838.9 9003.9 9098.7 9382.9 13504.7 13583.6 13712.1 13874.6 13944.7 11756.5 12033.5 12072.3 12079.2 12332.6 6161.8 8279.8 11703.8 11711.5 11824.3 11570.6 11622.8 11742.4 12051.6 12411.3 7608.0 7840.8 8673.7 8809.1 9185.9 11541.5 11860.2 11906.0 12045.6 12412.3 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | [#3] mootools.html Cycles:180 Average:5518.38 Median:5263.43 stddev:3066.93 (58.3%) stddev-sans-first:3060.54 14:32:10 INFO - PROCESS | 26776 | Values: 1482.6 1482.7 1484.1 1498.6 1502.8 8050.6 8560.7 8569.1 8575.7 8578.4 7334.7 7592.8 8116.4 8336.0 8369.2 2303.7 2339.5 2342.3 2342.8 2344.0 2237.1 2266.4 2276.6 2277.1 2277.8 2038.7 2105.7 2105.7 2120.1 2235.2 2249.9 2287.8 2291.6 2293.9 2294.0 2217.6 2279.4 2296.8 2301.0 2301.4 8544.5 8601.9 8616.4 8620.4 8696.7 5150.2 5306.9 5313.6 5313.9 5314.3 3075.2 3205.5 3364.9 3365.2 3380.7 1271.8 1283.1 1330.7 1365.6 1395.6 11304.9 11351.3 11389.1 11390.4 11402.7 4344.9 4528.2 4565.0 4572.1 4674.6 9887.2 9986.6 9993.2 10001.4 10008.0 5255.2 5271.7 5282.0 5296.3 5298.3 4715.6 4726.7 4805.9 4954.4 5006.5 3858.1 3966.5 3969.9 3978.4 4004.2 1272.5 1276.2 1291.1 1299.7 1311.4 964.0 970.3 979.1 983.3 996.5 5512.6 5516.0 5567.7 5621.4 5642.4 558.2 560.6 570.1 573.1 583.5 3775.1 3793.4 3794.4 3810.6 3888.0 9528.8 10090.4 10146.7 10164.3 10208.0 9766.8 9848.8 10069.9 10087.3 10093.1 7575.9 7951.0 7963.8 7964.0 7965.2 5755.9 5756.8 5807.5 5877.9 6003.4 9511.3 9517.5 9553.8 9586.5 9648.8 9300.8 9888.7 9952.4 9955.0 9956.8 7365.6 7451.3 7452.7 7460.7 7479.5 7702.8 7829.1 7856.6 7885.6 7912.3 6995.2 7091.9 7101.8 7111.6 7126.7 6985.5 7009.5 7082.5 7084.6 7101.0 6359.8 6438.5 6443.2 6449.0 6455.3 4802.5 4815.8 4862.1 4925.4 5030.7 4886.9 4909.8 4978.1 4978.8 5010.4 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | [#4] prototype.html Cycles:180 Average:4656.14 Median:5165.92 stddev:1291.88 (25.0%) stddev-sans-first:1254.84 14:32:10 INFO - PROCESS | 26776 | Values: 371.3 373.0 391.9 402.4 406.3 5096.2 5153.7 5230.2 5250.2 5290.4 5053.7 5159.9 5171.9 5214.9 5232.0 4245.4 4248.2 4250.8 4254.5 4284.6 4108.5 4182.7 4199.0 4246.1 4292.5 4225.9 4251.7 4259.7 4262.0 4270.3 4231.8 4246.6 4246.6 4254.2 4294.6 3775.2 3796.4 3814.8 3824.6 3911.6 5086.4 5093.1 5120.4 5122.8 5144.5 4799.2 4818.9 4828.9 4840.4 4842.8 5260.8 5491.6 5542.4 5557.5 5569.1 4249.1 4251.7 4253.2 4262.4 4278.9 5780.5 5788.5 5793.6 5796.4 5821.2 4291.6 4342.9 4359.6 4377.5 4390.6 4147.8 4396.1 4415.2 4417.4 4428.8 4713.6 4726.5 4792.7 4799.0 4821.4 5531.4 5546.1 5557.9 5579.7 5588.7 1465.9 1484.6 1494.9 1501.5 1503.2 1059.8 1074.4 1087.8 1097.2 1101.7 5086.2 5153.5 5158.8 5196.9 5203.0 5485.0 5499.8 5508.3 5510.5 5518.6 4873.4 5104.6 5111.8 5151.2 5172.0 2892.3 2904.5 2910.3 2912.7 2924.2 5637.5 5641.0 5646.5 5664.3 5688.5 5246.3 5564.6 5585.6 5619.8 5651.9 5690.5 5691.3 5704.7 5708.9 5711.3 5225.8 5523.5 5534.2 5556.8 5563.8 5400.2 5424.4 5427.3 5444.8 5480.6 5619.0 5644.8 5650.2 5652.2 5657.5 4050.2 4181.4 4188.7 4261.9 4271.4 5368.2 5417.6 5489.9 5493.3 5493.8 5324.9 5352.9 5506.4 5521.4 5551.0 5254.5 5474.6 5478.2 5500.6 5506.6 5397.8 5432.6 5444.8 5456.0 5476.5 5516.0 5520.2 5521.7 5535.3 5537.1 5256.8 5356.8 5362.9 5383.7 5417.2 14:32:10 INFO - PROCESS | 26776 | 14:32:10 INFO - PROCESS | 26776 | [#5] yui.html Cycles:180 Average:17978.32 Median:23815.70 stddev:22121.46 (92.9%) stddev-sans-first:22145.80 14:32:10 INFO - PROCESS | 26776 | Values: 776.4 783.9 788.6 794.0 836.8 15683.8 16515.5 17074.0 17161.5 17256.3 14275.6 14388.4 14698.5 14701.2 15909.7 745.2 761.7 762.3 766.4 768.4 658.5 663.6 669.7 675.9 766.4 782.0 809.6 811.7 816.6 817.2 804.6 805.0 805.9 806.1 806.2 498.4 587.3 587.8 587.9 588.0 12944.9 15498.3 15962.5 16022.6 16042.9 15690.0 15922.6 15993.5 16194.3 16551.3 12457.4 12556.6 12597.8 12644.7 12818.2 3719.5 3750.8 3801.5 3823.2 3833.6 76109.6 77406.6 79084.0 79838.6 80060.0 12203.7 12230.8 12284.0 12323.4 13039.9 23443.0 23745.3 23825.0 23907.9 23986.3 8287.7 8389.9 8471.0 8495.5 8568.4 4413.6 4437.6 4514.2 4539.8 4603.1 3667.9 3717.2 3744.6 3758.8 3759.9 643.6 649.5 687.8 701.4 726.8 759.3 767.3 797.8 808.1 832.9 10265.5 10914.7 10920.2 11138.6 11272.8 751.8 773.0 776.1 777.6 781.9 4870.0 5040.3 5093.5 5158.4 5175.8 75016.0 75486.0 76909.6 77066.0 79792.0 67892.3 68309.3 68572.0 68851.3 69200.0 60394.0 61492.7 61869.0 61894.7 64701.7 9875.9 10011.8 10040.3 10058.7 10090.5 42808.4 43217.8 44239.8 44532.8 44674.0 53745.5 53906.7 54771.0 54939.7 55126.7 12931.0 13099.3 13402.9 13494.8 13871.2 14899.2 15102.8 15562.8 15683.7 16228.0 14431.3 14799.7 15137.6 15306.2 15768.2 14225.6 14448.5 15152.1 15300.8 15397.2 14480.2 14516.3 14634.1 15087.4 15300.9 12050.4 12057.2 12099.0 12161.4 12361.2 11746.7 11959.6 12195.8 12424.7 12729.2 14:32:10 INFO - PROCESS | 26776 | -------- Summary: end -------- 14:32:10 INFO - PROCESS | 26776 | 14:32:11 INFO - TEST-INFO | 26776: exit 0 14:32:11 INFO - TEST-OK | dromaeo_css | took 1116189ms 14:32:11 INFO - TEST-START | kraken 14:32:11 INFO - operating with platform_type : linux_ 14:32:11 INFO - Initialising browser for kraken test... 14:32:11 INFO - TEST-INFO | started process 27079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOymKLe/profile http://localhost:60300/getInfo.html) 14:32:15 INFO - PROCESS | 27079 | __metrics Screen width/height:1600/1200 14:32:15 INFO - PROCESS | 27079 | colorDepth:24 14:32:15 INFO - PROCESS | 27079 | Browser inner width/height: 1024/697 14:32:15 INFO - PROCESS | 27079 | __metrics 14:32:16 INFO - PROCESS | 27079 | 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" 14:32:16 INFO - PROCESS | 27079 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:32:16 INFO - PROCESS | 27079 | console.error: PushService: 14:32:16 INFO - PROCESS | 27079 | stateChangeProcessEnqueue: Error transitioning state 14:32:16 INFO - PROCESS | 27079 | UnknownError 14:32:17 INFO - TEST-INFO | 27079: exit 0 14:32:17 INFO - Browser initialized. 14:32:17 INFO - Running cycle 1/1 for kraken test... 14:32:17 INFO - TEST-INFO | started process 27161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOymKLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:29 INFO - PROCESS | 27161 | RSS: Main: 147292160 14:32:29 INFO - PROCESS | 27161 | 14:32:31 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-beat-detection) 14:32:32 INFO - PROCESS | 27161 | RSS: Main: 203309056 14:32:32 INFO - PROCESS | 27161 | 14:32:35 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-dft) 14:32:35 INFO - PROCESS | 27161 | RSS: Main: 181669888 14:32:35 INFO - PROCESS | 27161 | 14:32:38 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-fft) 14:32:39 INFO - PROCESS | 27161 | RSS: Main: 263651328 14:32:39 INFO - PROCESS | 27161 | 14:32:41 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-oscillator) 14:32:42 INFO - PROCESS | 27161 | RSS: Main: 174182400 14:32:42 INFO - PROCESS | 27161 | 14:32:44 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:32:44 INFO - PROCESS | 27161 | RSS: Main: 178941952 14:32:44 INFO - PROCESS | 27161 | 14:32:47 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:48 INFO - PROCESS | 27161 | RSS: Main: 218279936 14:32:48 INFO - PROCESS | 27161 | 14:32:51 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:52 INFO - PROCESS | 27161 | RSS: Main: 217882624 14:32:52 INFO - PROCESS | 27161 | 14:32:55 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60300/tests/kraken/driver.html?testName=json-parse-financial) 14:32:55 INFO - PROCESS | 27161 | RSS: Main: 216621056 14:32:55 INFO - PROCESS | 27161 | 14:32:57 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:57 INFO - PROCESS | 27161 | RSS: Main: 178716672 14:32:57 INFO - PROCESS | 27161 | 14:32:59 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:33:00 INFO - PROCESS | 27161 | RSS: Main: 186957824 14:33:00 INFO - PROCESS | 27161 | 14:33:02 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:33:02 INFO - PROCESS | 27161 | RSS: Main: 194625536 14:33:02 INFO - PROCESS | 27161 | 14:33:05 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:33:06 INFO - PROCESS | 27161 | RSS: Main: 204697600 14:33:06 INFO - PROCESS | 27161 | 14:33:08 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:33:09 INFO - PROCESS | 27161 | RSS: Main: 201297920 14:33:09 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60300/tests/kraken/driver.html?testName=ai-astar) 14:33:11 INFO - PROCESS | 27161 | RSS: Main: 252137472 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | __start_tp_report 14:33:11 INFO - PROCESS | 27161 | _x_x_mozilla_page_load 14:33:11 INFO - PROCESS | 27161 | _x_x_mozilla_page_load_details 14:33:11 INFO - PROCESS | 27161 | |i|pagename|runs| 14:33:11 INFO - PROCESS | 27161 | |0;ai-astar;111;112;112;112;112;110;112;112;110;113 14:33:11 INFO - PROCESS | 27161 | |1;audio-beat-detection;144;118;120;151;120;120;119;119;144;119 14:33:11 INFO - PROCESS | 27161 | |2;audio-dft;160;161;161;160;161;159;161;162;162;164 14:33:11 INFO - PROCESS | 27161 | |3;audio-fft;76;75;75;100;76;78;76;76;93;76 14:33:11 INFO - PROCESS | 27161 | |4;audio-oscillator;83;82;114;84;84;82;94;83;83;109 14:33:11 INFO - PROCESS | 27161 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;116 14:33:11 INFO - PROCESS | 27161 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;146;145 14:33:11 INFO - PROCESS | 27161 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;95;96 14:33:11 INFO - PROCESS | 27161 | |8;json-parse-financial;52;52;51;51;52;52;53;52;53;51 14:33:11 INFO - PROCESS | 27161 | |9;json-stringify-tinderbox;66;67;70;66;66;66;66;67;66;67 14:33:11 INFO - PROCESS | 27161 | |10;stanford-crypto-aes;82;81;82;87;84;82;82;82;84;82 14:33:11 INFO - PROCESS | 27161 | |11;stanford-crypto-ccm;128;126;125;124;125;125;132;136;172;124 14:33:11 INFO - PROCESS | 27161 | |12;stanford-crypto-pbkdf2;172;176;170;172;171;176;173;168;176;172 14:33:11 INFO - PROCESS | 27161 | |13;stanford-crypto-sha256-iterative;65;65;63;62;62;63;63;63;61;60 14:33:11 INFO - PROCESS | 27161 | __end_tp_report 14:33:11 INFO - PROCESS | 27161 | __start_cc_report 14:33:11 INFO - PROCESS | 27161 | _x_x_mozilla_cycle_collect,1576 14:33:11 INFO - PROCESS | 27161 | __end_cc_report 14:33:11 INFO - PROCESS | 27161 | __startTimestamp1484605991441__endTimestamp 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | ------- Summary: start ------- 14:33:11 INFO - PROCESS | 27161 | Number of tests: 14 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 14:33:11 INFO - PROCESS | 27161 | Values: 111.0 112.0 112.0 112.0 112.0 110.0 112.0 112.0 110.0 113.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:120.00 stddev:13.22 (11.0%) stddev-sans-first:12.58 14:33:11 INFO - PROCESS | 27161 | Values: 144.0 118.0 120.0 151.0 120.0 120.0 119.0 119.0 144.0 119.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.39 14:33:11 INFO - PROCESS | 27161 | Values: 160.0 161.0 161.0 160.0 161.0 159.0 161.0 162.0 162.0 164.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#3] audio-fft Cycles:10 Average:80.10 Median:76.00 stddev:8.84 (11.6%) stddev-sans-first:9.25 14:33:11 INFO - PROCESS | 27161 | Values: 76.0 75.0 75.0 100.0 76.0 78.0 76.0 76.0 93.0 76.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:12.02 (14.5%) stddev-sans-first:12.49 14:33:11 INFO - PROCESS | 27161 | Values: 83.0 82.0 114.0 84.0 84.0 82.0 94.0 83.0 83.0 109.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:33:11 INFO - PROCESS | 27161 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:33:11 INFO - PROCESS | 27161 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:33:11 INFO - PROCESS | 27161 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 14:33:11 INFO - PROCESS | 27161 | Values: 52.0 52.0 51.0 51.0 52.0 52.0 53.0 52.0 53.0 51.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 14:33:11 INFO - PROCESS | 27161 | Values: 66.0 67.0 70.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:1.75 (2.1%) stddev-sans-first:1.83 14:33:11 INFO - PROCESS | 27161 | Values: 82.0 81.0 82.0 87.0 84.0 82.0 82.0 82.0 84.0 82.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:127.00 stddev:14.69 (11.6%) stddev-sans-first:15.52 14:33:11 INFO - PROCESS | 27161 | Values: 128.0 126.0 125.0 124.0 125.0 125.0 132.0 136.0 172.0 124.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:172.50 stddev:2.72 (1.6%) stddev-sans-first:2.87 14:33:11 INFO - PROCESS | 27161 | Values: 172.0 176.0 170.0 172.0 171.0 176.0 173.0 168.0 176.0 172.0 14:33:11 INFO - PROCESS | 27161 | 14:33:11 INFO - PROCESS | 27161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.42 14:33:11 INFO - PROCESS | 27161 | Values: 65.0 65.0 63.0 62.0 62.0 63.0 63.0 63.0 61.0 60.0 14:33:11 INFO - PROCESS | 27161 | -------- Summary: end -------- 14:33:11 INFO - PROCESS | 27161 | 14:33:12 INFO - TEST-INFO | 27161: exit 0 14:33:12 INFO - TEST-OK | kraken | took 61125ms 14:33:12 INFO - SUITE-END | took 1177s 14:33:12 INFO - Completed test suite (00:19:37) 14:33:12 INFO - javascript benchmark 14:33:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.604924384452, 3185.490321548553, 3206.038188543437, 3221.0497903118576, 3226.33860058688, 5144.17693169093, 5201.8439446816565, 5281.973590132049, 5380.461953804623, 5394.568434525238, 5309.495597918201, 5320.281761962134, 5349.491798279158, 5356.143017117262, 5419.864503387407, 4805.471398146201, 4809.398825146856, 4820.132376172288, 4881.145799485093, 4997.60019198465, 4530.254513463524, 4781.474037855833, 4934.605231581483, 4955.1080805455, 4995.275685025669, 4737.218358970766, 4758.976205118952, 4906.0, 4947.406311242638, 4968.726720030397, 4805.159097158018, 4820.927686084711, 4837.129316722989, 4873.8781530461665, 4920.138975679241, 4839.806407743686, 4850.102730994778, 4860.416749989989, 4869.464358920516, 4905.509449055102, 5134.204198349262, 5258.894822103536, 5315.069862773999, 5318.5213330800025, 5336.172893201521, 5584.91622625661, 5687.601867869251, 5693.4875861172695, 5722.628029178131, 5723.942760572424, 5786.0742281235225, 5804.59367844251, 5818.1272809078555, 5862.032764593837, 5862.355140934494, 5428.212909128154, 5432.0, 5435.1847222916485, 5436.755346009479, 5436.809711660152, 5517.69652669107, 5657.745401456944, 5934.258217722699, 5940.70296485174, 5944.583879128506, 5482.616216864782, 5489.094299440628, 5492.286002819687, 5564.1931919871395, 5596.748146333425, 5596.076647353222, 5649.802256921071, 5656.773729050792, 5660.405657405995, 5666.008448521492, 5472.0, 5503.642263252876, 5510.0632892408385, 5545.362283337387, 5600.0759874620235, 5562.582806289544, 5562.805301814417, 5564.721763911788, 5653.971730141323, 5668.008098582814, 4416.955830441654, 4419.734815911055, 4455.532169122195, 4460.576245256695, 4461.397711308931, 3945.349017412095, 3952.6837852971694, 3957.426173204869, 3958.44581758554, 3987.063040185554, 5170.069387510209, 5223.3209682741, 5308.23030660552, 5322.0952438085615, 5360.758765855546, 5651.152327150878, 5674.716264186774, 5730.312362516442, 5757.9424205757405, 5776.249087618583, 5343.492368225013, 5392.245085688007, 5395.73021348931, 5400.810971615974, 5405.567554595702, 4847.466778654345, 4876.707397556158, 4978.4025916890205, 4978.551930326288, 5015.3480047593575, 5885.293764748258, 5897.321807992136, 5923.7926672566255, 6025.487833534024, 6028.457438830526, 5790.0, 5797.884042319214, 5804.419558044162, 5807.593468457168, 5848.181254624271, 5972.193753843176, 5972.25346831646, 5973.253343332083, 5974.074018527135, 5976.641401515923, 5476.041692703681, 5487.780488780564, 5558.944410555842, 5583.35791383996, 5700.5154561861045, 5722.084466485342, 5726.112452569859, 5726.5418766499415, 5728.1694154348215, 5755.827325180251, 5590.636608620427, 5592.133219351007, 5597.972010139923, 5598.048331783525, 5598.3282006159525, 5454.836354909359, 5495.752691128989, 5534.723263836872, 5586.413426590149, 5599.720013999366, 5563.972180139073, 5572.359178694502, 5574.888502229852, 5577.721113944205, 5583.190437386637, 5567.55459563242, 5599.468050535193, 5604.467575580314, 5608.242887210337, 5611.270534830446, 5410.1343784994215, 5515.834524964257, 5523.392426832965, 5554.805581804618, 5567.638103523258], "value": 5265.82764259548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.3851516368654, 587.673841018235, 609.0681257675755, 613.595027281994, 652.5106170372221, 32742.67257327426, 42865.142697146075, 43905.78047109768, 43953.340699889486, 44005.7799711001, 47513.287300690434, 47643.761781191046, 47958.0, 48013.0, 48030.51969480304, 8591.441556298852, 8787.560621968907, 8934.776630584221, 9127.041660625639, 9130.452172869649, 10640.255182137253, 10944.56221751129, 10951.069159121444, 11367.147463940197, 11377.2035957483, 10684.679459616224, 10719.088877445427, 10758.892411075907, 10762.085222756075, 10768.24622276441, 10870.456477176149, 10897.727556811144, 10928.071113955324, 10939.617113401033, 10972.561097556088, 10741.946290268577, 10805.297655652435, 10827.512761925733, 10830.187735919837, 10830.241883068189, 43670.781646091884, 43975.560244397464, 44027.11945761067, 44039.33940990888, 44064.11871762547, 4277.572242775728, 4292.763897985609, 4313.547077556843, 4360.934585981213, 4418.977905110486, 32216.83891580527, 33032.83483582567, 33393.6660633393, 33396.6660333396, 34085.829570852235, 4261.424707664457, 4385.6710746694125, 4423.778811059434, 4447.688661793676, 4584.954150458486, 322578.83896254544, 324889.0, 326274.9999999976, 327218.0, 328384.0, 59777.402225978054, 59936.700316498136, 59996.700016499635, 60123.39876601265, 60192.39807601868, 63438.36561634417, 63461.0, 63472.36527634757, 63581.682091589246, 63583.913286936935, 17618.383356582457, 17982.37061702834, 17990.640187196183, 17997.460076197734, 18015.72976405355, 12615.93692031534, 12976.935115324362, 13242.404091815699, 13558.11872228302, 13710.17738935667, 16948.661026779395, 17003.809733318798, 17031.82968170327, 17036.27419612856, 17338.0, 6282.937170628326, 6292.590981586274, 6395.904061439082, 6400.647964361911, 6469.5794773339585, 923.9214666753401, 947.2942657720042, 960.644561512245, 978.6917121106828, 989.1246247071393, 31880.681193188237, 31994.360112797614, 32079.679203208136, 32235.35529289401, 32614.673853261163, 1040.8022475729588, 1125.5272785430138, 1133.5862410220375, 1134.194721747552, 1172.050638982427, 16930.492085237463, 17192.91403542974, 17232.224549895283, 17237.31050757981, 17355.21901514435, 490233.0, 494101.0, 495286.0, 495904.0, 497940.0, 62787.68606157031, 62936.18893354934, 62944.68527657424, 63122.68438657777, 63192.0, 1420.7229590229806, 1472.0799500312305, 1472.2050092949687, 1473.2854565535706, 1490.5379332406987, 29569.26076848096, 31024.379512410076, 31380.372392551566, 31445.371092578476, 31585.052448426584, 52809.20786188133, 54289.18566221431, 54299.0, 54382.456175437736, 54403.72798135984, 377790.0, 378486.0, 380252.0, 381418.0, 381746.0, 35023.824880876455, 35974.28051439009, 38263.0, 40131.0, 41085.58914410818, 49004.0, 49048.75475622599, 49348.50651493583, 49529.752351238014, 49702.502974969786, 41547.7922610385, 41828.0, 41945.0, 42421.0, 43974.340384893614, 40258.597414025484, 41268.587314127675, 41546.376804347354, 42640.573594264904, 42752.57247427486, 41322.0, 41764.791176043924, 42120.78939605282, 42266.788666057706, 42283.15433691248, 33696.663033369354, 35902.461463077554, 36678.63321366859, 36689.0, 37031.62968370282, 27318.453630926873, 27833.304167395978, 27897.302567435978, 28027.439451210455, 28045.719542805127], "value": 20875.161282075485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.98942526436815, 425.2072045265849, 432.6884643056999, 433.6010869999601, 438.9912201755967, 19242.440148572507, 19711.31010414634, 20903.68644470334, 21056.789432105674, 21207.0, 20451.43979971474, 21723.67414488784, 21823.890880545616, 21958.23146189884, 22010.44973875654, 5741.138829175616, 5976.641401515902, 5983.880322393549, 5984.88030239395, 5991.700414979256, 5677.659340439587, 5847.093700476433, 5858.179854820329, 5865.237519122529, 5911.704414779244, 5868.706564671771, 5878.118282257674, 5882.14708867214, 5883.529317654598, 5890.087036509327, 5733.55649371736, 5837.795677151301, 5931.0, 5940.554458415636, 5941.940580594203, 5289.814856480043, 5345.251664766935, 5357.0, 5357.008953343644, 5361.0618141825025, 25191.118310859216, 25350.112746053983, 25555.872220638965, 25601.487970240676, 25764.871175644003, 2767.7785777137983, 2768.4484448624075, 2796.734310240524, 2817.5632776919406, 2851.0, 15020.924895375563, 15285.082895026335, 15313.157776322298, 15324.23378831054, 16059.518214453468, 1923.6441258367247, 1960.137539482623, 1964.302672551238, 1974.2596526302636, 2024.6153230886084, 66106.66946665235, 68772.6561367195, 69027.78749912482, 79577.20422795755, 89050.55474722585, 9193.586288617029, 10774.175167815469, 10937.070349020423, 11090.500927458284, 11393.373364465035, 16377.543368494582, 16389.0, 16394.754078688828, 16467.34130634785, 16529.917350413172, 8996.82006359869, 9041.18629323364, 9089.954550227207, 9205.171534561787, 9230.815383692423, 8730.738077857675, 8777.648894044167, 8850.114988501098, 8989.190972812348, 9049.954750226338, 7278.344948954619, 7530.359919406912, 7565.735199268, 7707.922920770833, 7737.148913619498, 2057.86623869448, 2104.6948192512, 2129.9041543130597, 2139.4330502416874, 2154.526004279056, 902.6569903436653, 920.300571565615, 925.1072714830086, 938.3712912348607, 955.3933252384646, 19711.310104146287, 19893.303734369227, 21019.579608407745, 21152.576948460945, 21348.466288342916, 938.4134915677702, 942.6520274460596, 956.9234461243084, 965.2037069417759, 970.694231317147, 11388.829167562493, 11684.371016521214, 11796.233244839059, 11819.286203500444, 11874.406279685982, 601566.0, 611903.0, 613712.0, 615583.0, 629017.0, 78562.6071869637, 88958.55520722484, 89255.55372223098, 90025.0, 90731.0, 1006.8489726540931, 1014.5383850348074, 1060.5015642647943, 1100.9559617615366, 1136.1422126294594, 18281.725774113133, 18633.72049419287, 19207.8079219206, 19454.513637159183, 19495.050494950392, 39826.203475930895, 40518.59481405148, 40952.79523602363, 41351.37972930348, 41856.79071604623, 53634.0, 54554.09060682857, 54934.45065549293, 55046.0, 55629.44370556243, 8507.319414446705, 8838.911610883808, 9003.864942026006, 9098.729519405339, 9382.906170938204, 13504.729905402033, 13583.592492225249, 13712.108712933627, 13874.583762487142, 13944.721105577628, 11756.470958806703, 12033.518659253532, 12072.3360215189, 12079.154459187772, 12332.630021099381, 6161.815145545641, 8279.834403312021, 11703.824442633197, 11711.531538738354, 11824.290542567473, 11570.59502917394, 11622.767544649229, 11742.354170520703, 12051.57819476314, 12411.255324680547, 7608.0, 7840.803979900548, 8673.739787806377, 8809.11908809114, 9185.908140918506, 11541.538338466367, 11860.169788114748, 11906.0, 12045.63863084109, 12412.317322546985], "value": 9756.472532655107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.5700546841404, 1482.6515768794338, 1484.0650390254139, 1498.6403263216826, 1502.8046353973982, 8050.557219352941, 8560.657573697044, 8569.057403685598, 8575.699850505234, 8578.356623253258, 7334.743283985062, 7592.810179745509, 8116.431849770518, 8335.958320208405, 8369.20492553208, 2303.7120359955006, 2339.532093581282, 2342.3207269891795, 2342.7774361435722, 2344.003798385679, 2237.1498830444407, 2266.4447210433386, 2276.590213761522, 2277.1346888182466, 2277.840551161419, 2038.7247721557549, 2105.6736205888037, 2105.7157283766724, 2120.0883620043373, 2235.228846048119, 2249.853759505627, 2287.7597852225445, 2291.621882389412, 2293.9197128100604, 2293.9770602294097, 2217.6008318502663, 2279.350385140227, 2296.8392212544964, 2301.0450662974845, 2301.401635574746, 8544.530050847201, 8601.913980860174, 8616.439931404502, 8620.353473489513, 8696.739097827076, 5150.227465880111, 5306.946930530722, 5313.57491400687, 5313.920291195635, 5314.335708036496, 3075.169704179881, 3205.5351973963643, 3364.915877103092, 3365.1923538350866, 3380.7464440167087, 1271.8346614940092, 1283.1082397733578, 1330.7405056013984, 1365.590322903125, 1395.553422904671, 11304.886951130466, 11351.318920864693, 11389.145814063979, 11390.373529455877, 11402.71493212668, 4344.913101737948, 4528.207563676344, 4564.977175114103, 4572.0855828834365, 4674.579287864109, 9887.159591434809, 9986.550605222637, 9993.200543956611, 10001.449920254456, 10008.0, 5255.185446255837, 5271.683698978073, 5281.973590132102, 5296.285001524822, 5298.258243845865, 4715.575598196178, 4726.716397016121, 4805.927911081337, 4954.40547134339, 5006.499350065037, 3858.1319203179623, 3966.464527288779, 3969.900752481211, 3978.42312864633, 4004.2191772604647, 1272.4973635414144, 1276.189619591566, 1291.070429290909, 1299.6555912683148, 1311.4295281552554, 964.0, 970.3401686852867, 979.0796651147898, 983.3165949665057, 996.4818294486827, 5512.586556008235, 5515.972420137874, 5567.693776842231, 5621.353544342453, 5642.448326710188, 558.2101326622783, 560.6383882395913, 570.0736303506801, 573.1173992052193, 583.4544700704854, 3775.093977445393, 3793.430985352219, 3794.4498047782918, 3810.580836108026, 3888.047428380065, 9528.761780955532, 10090.394576325443, 10146.746331341776, 10164.28849980509, 10208.0, 9766.804663906682, 9848.753781155385, 10069.949650251701, 10087.293889427816, 10093.142082923034, 7575.886361704579, 7950.960245198737, 7963.800904977306, 7964.004499437686, 7965.243301886311, 5755.884882302415, 5756.827295181151, 5807.506361959281, 5877.911831322448, 6003.369646187262, 9511.286653501153, 9517.52412379392, 9553.808923821623, 9586.520673966133, 9648.75878103053, 9300.813983720423, 9888.653897113567, 9952.402855828674, 9954.950225248827, 9956.800863982824, 7365.558066515812, 7451.3293803557945, 7452.739154129579, 7460.738874139379, 7479.476436649382, 7702.768916932501, 7829.138794732688, 7856.607169641381, 7885.5662938538935, 7912.28789408956, 6995.160580730345, 7091.9290807091265, 7101.751438699621, 7111.573305601681, 7126.679299431435, 6985.511014228955, 7009.544379615309, 7082.468814838805, 7084.574925504487, 7101.041359416619, 6359.8092057238355, 6438.5171112165835, 6443.162388889415, 6448.967755161194, 6455.289918108911, 4802.543758342952, 4815.783289752039, 4862.149123903232, 4925.359703238556, 5030.748462576929, 4886.853394398174, 4909.803607855789, 4978.103941290602, 4978.800847966041, 5010.423801262901], "value": 4426.6204469629765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.32048351516727, 372.9813509324533, 391.9274934137183, 402.3763167091008, 406.28493850822554, 5096.210087436449, 5153.742312884355, 5230.189320655295, 5250.212468129783, 5290.444503327153, 5053.671511351759, 5159.896802063957, 5171.948280517194, 5214.895702085956, 5232.0, 4245.384419259206, 4248.236981652611, 4250.789589413504, 4254.510731265897, 4284.550122237167, 4108.52751933527, 4182.682455026672, 4198.992241861962, 4246.087091275375, 4292.549282325342, 4225.873223803291, 4251.659867210616, 4259.6805239607, 4262.0, 4270.274053410912, 4231.830726770925, 4246.596573325529, 4246.617804397603, 4254.212970600418, 4294.634956028742, 3775.169462718198, 3796.3546197146275, 3814.809259537012, 3824.598417166213, 3911.5697273299916, 5086.364204474441, 5093.083245015896, 5120.359955005624, 5122.820701275437, 5144.485551444863, 4799.1601469743, 4818.927716084261, 4828.879278018043, 4840.394950631171, 4842.830500932486, 5260.790018295814, 5491.588130890199, 5542.362628297717, 5557.527610153142, 5569.10894256917, 4249.128928569636, 4251.723637963522, 4253.21315556623, 4262.403263543107, 4278.871633850989, 5780.450857168562, 5788.507976821975, 5793.623414478046, 5796.362400136024, 5821.243238378984, 4291.592298731615, 4342.934855977162, 4359.585839345257, 4377.5403582624, 4390.582894625006, 4147.776405960249, 4396.142752163298, 4415.196350317571, 4417.425734654538, 4428.844990425319, 4713.552212539872, 4726.456457507362, 4792.736399497991, 4798.992211635526, 4821.397325334333, 5531.419200983839, 5546.140348246028, 5557.861053473695, 5579.69311687861, 5588.720563971785, 1465.948691795782, 1484.5768955847532, 1494.886309699281, 1501.4894935721907, 1503.240863363994, 1059.8410238464292, 1074.435921141407, 1087.8150714378576, 1097.226455348993, 1101.6805126513382, 5086.18621020635, 5153.5361817436615, 5158.845234642967, 5196.870078247998, 5202.97398513005, 5485.040117979338, 5499.807506737245, 5508.3114610673665, 5510.504054635102, 5518.586106041983, 4873.415190177201, 5104.617153713486, 5111.821086261963, 5151.150060240094, 5171.974140129275, 2892.291388609804, 2904.520754075596, 2910.3160757222035, 2912.713519886921, 2924.166612515423, 5637.520810731134, 5641.041023026095, 5646.539234005172, 5664.26364572603, 5688.516476099578, 5246.265522826808, 5564.582656300794, 5585.609007369527, 5619.775208991677, 5651.943480565142, 5690.5447564194765, 5691.288588926384, 5704.743286552115, 5708.8610757200695, 5711.286089238928, 5225.817096401608, 5523.502884740393, 5534.236719030937, 5556.833295001156, 5563.7774489019985, 5400.243965844864, 5424.376196737426, 5427.348718153847, 5444.8094316698725, 5480.588955828409, 5619.0, 5644.8428072245915, 5650.180723794944, 5652.152177173457, 5657.4908258256955, 4050.233283046795, 4181.372794080912, 4188.727732697365, 4261.936070958876, 4271.380649805823, 5368.1679339702405, 5417.6478528895495, 5489.862753431196, 5493.258410114583, 5493.752781124939, 5324.866878327918, 5352.866178345573, 5506.421825708403, 5521.420250873761, 5550.97224513891, 5254.527092561688, 5474.616776825584, 5478.179202301949, 5500.642458240201, 5506.5682922439655, 5397.757100930546, 5432.565394768488, 5444.782208711607, 5455.990641731292, 5476.534494568006, 5516.0, 5520.199571062093, 5521.69630670317, 5535.280413546213, 5537.058700020925, 5256.842294731164, 5356.812511562077, 5362.881661743668, 5383.703896285742, 5417.241586177859], "value": 4267.541948066012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.4409625069948, 783.925527074928, 788.6041706180062, 793.9841203175937, 836.8284501677157, 15683.84316156838, 16515.504534863943, 17074.0, 17161.485155445356, 17256.30974761011, 14275.571732848031, 14388.352524136413, 14698.485553005647, 14701.1914344711, 15909.681806363866, 745.243577768564, 761.7067429039804, 762.3063012658482, 766.4443278622981, 768.4121646940096, 658.4666420199629, 663.575311800448, 669.6651674162919, 675.9459243260527, 766.3868904876105, 782.030282449761, 809.5709274084744, 811.7037281392279, 816.5672193737299, 817.2277198047847, 804.63389157933, 805.0259186384482, 805.8630032894392, 806.1374329467473, 806.2300503019632, 498.3546307531755, 587.2835141127817, 587.7942720047992, 587.9118132280149, 588.020945126364, 12944.935275323658, 15498.30257638409, 15962.521124366287, 16022.599435014217, 16042.919785401114, 15690.0, 15922.60193495172, 15993.482248624206, 16194.271257793427, 16551.337946482246, 12457.377131143498, 12556.560520381834, 12597.811032834516, 12644.683882903, 12818.166819156819, 3719.479272901796, 3750.8124593770203, 3801.5425394104836, 3823.1780167264174, 3833.6358045985867, 76109.61945190238, 77406.61296693537, 79084.0, 79838.60080699617, 80060.0, 12203.69490762738, 12230.816537751942, 12284.0, 12323.383830808423, 13039.934800325938, 23443.0, 23745.287641370785, 23825.0, 23907.880460597586, 23986.28041158768, 8287.709930152416, 8389.916100839035, 8471.0, 8495.490270583785, 8568.443051201652, 4413.624841888475, 4437.556244375602, 4514.232580461329, 4539.84110556129, 4603.102395033004, 3667.8716244931834, 3717.20080182762, 3744.588095309514, 3758.8496460141287, 3759.86840460588, 643.5784561112479, 649.4577028181521, 687.8039758668756, 701.3617607976716, 726.7819654103748, 759.2748924776935, 767.301755402581, 797.7965618767294, 808.0787901791962, 832.9000519937646, 10265.486725663686, 10914.672559823219, 10920.235583509078, 11138.554457821758, 11272.830907536394, 751.7707099334756, 772.9922700773033, 776.0958483366927, 777.5995362388375, 781.941354398411, 4869.95130048695, 5040.31955685985, 5093.541581257705, 5158.380994280636, 5175.767090480937, 75016.0, 75486.0, 76909.61545192238, 77066.0, 79792.0, 67892.3210767896, 68309.31690683129, 68572.0, 68851.31148688549, 69200.0, 60394.0, 61492.69253653793, 61869.0, 61894.69052654798, 64701.676491618186, 9875.942109629921, 10011.799764004534, 10040.297179197387, 10058.748531286483, 10090.495475226357, 42808.35787463253, 43217.783911080245, 44239.77880110707, 44532.77733611311, 44674.0, 53745.462545374045, 53906.73046634742, 54771.0, 54939.72530137324, 55126.72436637791, 12931.0, 13099.345032748133, 13402.865971340161, 13494.797578036534, 13871.167729936236, 14899.180545070125, 15102.773458397913, 15562.844371556139, 15683.686326273639, 16228.0, 14431.278436077944, 14799.704005919606, 15137.62155946066, 15306.23468826532, 15768.19070183605, 14225.573232803032, 14448.494302699355, 15152.090874547563, 15300.846991529943, 15397.153156576496, 14480.203588802717, 14516.274186290431, 14634.121952682874, 15087.39650414015, 15300.923495382453, 12050.397480126134, 12057.216280941711, 12099.0, 12161.39193040362, 12361.196522226026, 11746.70633234176, 11959.641210763692, 12195.75608487843, 12424.689382765504, 12729.236245825281], "value": 7469.6748881558315, "unit": "score"}], "name": "dromaeo_css", "value": 7300.147860063073, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 112.0, 110.0, 112.0, 112.0, 110.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 120.0, 151.0, 120.0, 120.0, 119.0, 119.0, 144.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 159.0, 161.0, 162.0, 162.0, 164.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 100.0, 76.0, 78.0, 76.0, 76.0, 93.0, 76.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 84.0, 84.0, 82.0, 94.0, 83.0, 83.0, 109.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 52.0, 52.0, 53.0, 52.0, 53.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 70.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 87.0, 84.0, 82.0, 82.0, 82.0, 84.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 125.0, 124.0, 125.0, 125.0, 132.0, 136.0, 172.0, 124.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 170.0, 172.0, 171.0, 176.0, 173.0, 168.0, 176.0, 172.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 61.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1496.6999999999998, "alertThreshold": 2.0}]} 14:33:12 INFO - Return code: 0 14:33:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:33:12 ERROR - # TBPL SUCCESS # 14:33:12 INFO - Running post-action listener: _resource_record_post_action 14:33:12 INFO - [mozharness: 2017-01-16 22:33:12.754594Z] Finished run-tests step (success) 14:33:12 INFO - Running post-run listener: _resource_record_post_run 14:33:12 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 20480; Write bytes: 417378304; Read time: 76; Write time: 280952 14:33:12 INFO - TinderboxPrint: CPU usage
13.1% 14:33:12 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 76 14:33:12 INFO - TinderboxPrint: I/O write bytes / time
417,378,304 / 280,952 14:33:12 INFO - TinderboxPrint: CPU idle
8,288.7 (86.9%) 14:33:12 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 14:33:12 INFO - TinderboxPrint: Swap in / out
0 / 0 14:33:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 122597376; Read time: 0; Write time: 89636 14:33:12 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 20480; Write bytes: 294215680; Read time: 76; Write time: 191316 14:33:13 INFO - Running post-run listener: _upload_blobber_files 14:33:13 INFO - Blob upload gear active. 14:33:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:33:13 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 14:33:13 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'] 14:33:13 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 14:33:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:33:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:16 INFO - (blobuploader) - INFO - Done attempting. 14:33:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:33:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:33:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:17 INFO - (blobuploader) - INFO - Done attempting. 14:33:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:33:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:33:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:18 INFO - (blobuploader) - INFO - Done attempting. 14:33:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:33:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:33:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:19 INFO - (blobuploader) - INFO - Done attempting. 14:33:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:33:19 INFO - Return code: 0 14:33:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:33:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:33:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e637e5ad6745fe43cbf115196749edfdd9852b4363bae7f3f7aeb3912acc91e2574872c21fc3ab9103d1ced51b83d1e7573e5696f05ef8811b3afde73e3db7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a037852f89e21b301bde7bebad72ffacc854ad760ea578e75437ea345a477df120531847d0a3c4a883ce31b5c0504f179c350a57f6263018f0e991e058409fe", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbdeeaac76eb7b1306a4b50ab2e42e96e86351e7088d46a9682f5b5a7fae718bd49a77547d11b22d8fe26fd5020d1b1678c313aa3acd2d2e780bc5e7cd34f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b5d8fad7763299eb9751f1c8a397eb05a95362e72b81c6813c166267ee5fe13d09a8623b1c2930d4491bf97fcf32d5b64fa7b06b33559ab615b8d4a39a4750c"} 14:33:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:33:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:33:19 INFO - Contents: 14:33:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e637e5ad6745fe43cbf115196749edfdd9852b4363bae7f3f7aeb3912acc91e2574872c21fc3ab9103d1ced51b83d1e7573e5696f05ef8811b3afde73e3db7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a037852f89e21b301bde7bebad72ffacc854ad760ea578e75437ea345a477df120531847d0a3c4a883ce31b5c0504f179c350a57f6263018f0e991e058409fe", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbdeeaac76eb7b1306a4b50ab2e42e96e86351e7088d46a9682f5b5a7fae718bd49a77547d11b22d8fe26fd5020d1b1678c313aa3acd2d2e780bc5e7cd34f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b5d8fad7763299eb9751f1c8a397eb05a95362e72b81c6813c166267ee5fe13d09a8623b1c2930d4491bf97fcf32d5b64fa7b06b33559ab615b8d4a39a4750c"} 14:33:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:33:19 INFO - Copying logs to upload dir... 14:33:19 INFO - mkdir: /builds/slave/test/build/upload/logs 14:33:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.386633 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-16 14:33:19.326784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 14:33:19.330137) ========= 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=db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e637e5ad6745fe43cbf115196749edfdd9852b4363bae7f3f7aeb3912acc91e2574872c21fc3ab9103d1ced51b83d1e7573e5696f05ef8811b3afde73e3db7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a037852f89e21b301bde7bebad72ffacc854ad760ea578e75437ea345a477df120531847d0a3c4a883ce31b5c0504f179c350a57f6263018f0e991e058409fe", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbdeeaac76eb7b1306a4b50ab2e42e96e86351e7088d46a9682f5b5a7fae718bd49a77547d11b22d8fe26fd5020d1b1678c313aa3acd2d2e780bc5e7cd34f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b5d8fad7763299eb9751f1c8a397eb05a95362e72b81c6813c166267ee5fe13d09a8623b1c2930d4491bf97fcf32d5b64fa7b06b33559ab615b8d4a39a4750c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484597251/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e637e5ad6745fe43cbf115196749edfdd9852b4363bae7f3f7aeb3912acc91e2574872c21fc3ab9103d1ced51b83d1e7573e5696f05ef8811b3afde73e3db7f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a037852f89e21b301bde7bebad72ffacc854ad760ea578e75437ea345a477df120531847d0a3c4a883ce31b5c0504f179c350a57f6263018f0e991e058409fe", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fbdeeaac76eb7b1306a4b50ab2e42e96e86351e7088d46a9682f5b5a7fae718bd49a77547d11b22d8fe26fd5020d1b1678c313aa3acd2d2e780bc5e7cd34f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0b5d8fad7763299eb9751f1c8a397eb05a95362e72b81c6813c166267ee5fe13d09a8623b1c2930d4491bf97fcf32d5b64fa7b06b33559ab615b8d4a39a4750c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 14:33:19.355562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:33:19.355854) ========= 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=db0483c52d987ecb441a263b000001ad-1484601765.292240-333416324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:33:19.441129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 14:33:19.441432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 14:33:19.441704) ========= ========= Total master_lag: 0.19 =========