builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1481213607.91 results: success (0) buildid: 20161208071757 builduid: 111970e67f32415fb7d5826f7b3e4496 revision: d8f63b2935af0915a6a24b3ea8e27d9a09f66416 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:27.913710) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:27.914299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:27.914620) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:27.930224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:27.930613) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-08 08:13:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.5M=0s 2016-12-08 08:13:28 (68.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.073551 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:28.035815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:28.036182) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:28.086162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 08:13:28.086560) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d8f63b2935af0915a6a24b3ea8e27d9a09f66416 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d8f63b2935af0915a6a24b3ea8e27d9a09f66416 --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=56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-08 08:13:28,373 truncating revision to first 12 chars 2016-12-08 08:13:28,374 Setting DEBUG logging. 2016-12-08 08:13:28,374 attempt 1/10 2016-12-08 08:13:28,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d8f63b2935af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 08:13:29,633 unpacking tar archive at: mozilla-central-d8f63b2935af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.561456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 08:13:29.663212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:29.663613) ========= script_repo_revision: d8f63b2935af0915a6a24b3ea8e27d9a09f66416 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:29.664081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:29.664389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 08:13:29.673891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-08 08:13:29.674200) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:13:30 INFO - MultiFileLogger online at 20161208 08:13:30 in /builds/slave/test 08:13:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:13:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:30 INFO - {'append_to_log': False, 08:13:30 INFO - 'base_work_dir': '/builds/slave/test', 08:13:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:30 INFO - 'branch': 'Firefox-Non-PGO', 08:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:30 INFO - 'config_files': ('talos/linux_config.py',), 08:13:30 INFO - 'default_actions': ('clobber', 08:13:30 INFO - 'read-buildbot-config', 08:13:30 INFO - 'download-and-extract', 08:13:30 INFO - 'populate-webroot', 08:13:30 INFO - 'create-virtualenv', 08:13:30 INFO - 'install', 08:13:30 INFO - 'run-tests'), 08:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:30 INFO - 'download_minidump_stackwalk': True, 08:13:30 INFO - 'download_symbols': 'ondemand', 08:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:30 INFO - 'installer_path': 'installer.exe', 08:13:30 INFO - 'log_level': 'info', 08:13:30 INFO - 'log_name': 'talos', 08:13:30 INFO - 'log_to_console': True, 08:13:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:13:30 INFO - 'opt_config_files': (), 08:13:30 INFO - 'pip_index': False, 08:13:30 INFO - 'sps_profile': False, 08:13:30 INFO - 'sps_profile_interval': 0, 08:13:30 INFO - 'suite': 'dromaeojs', 08:13:30 INFO - 'system_bits': '32', 08:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:30 INFO - 'title': 'talos-linux64-ix-037', 08:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:30 INFO - 'use_talos_json': True, 08:13:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:30 INFO - 'work_dir': 'build'} 08:13:30 INFO - [mozharness: 2016-12-08 16:13:30.059849Z] Running clobber step. 08:13:30 INFO - Running pre-action listener: _resource_record_pre_action 08:13:30 INFO - Running main action method: clobber 08:13:30 INFO - rmtree: /builds/slave/test/build 08:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:30 INFO - Running post-action listener: _resource_record_post_action 08:13:30 INFO - [mozharness: 2016-12-08 16:13:30.559779Z] Finished clobber step (success) 08:13:30 INFO - [mozharness: 2016-12-08 16:13:30.559878Z] Running read-buildbot-config step. 08:13:30 INFO - Running pre-action listener: _resource_record_pre_action 08:13:30 INFO - Running main action method: read_buildbot_config 08:13:30 INFO - Using buildbot properties: 08:13:30 INFO - { 08:13:30 INFO - "project": "", 08:13:30 INFO - "product": "firefox", 08:13:30 INFO - "script_repo_revision": "production", 08:13:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:13:30 INFO - "repository": "", 08:13:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:13:30 INFO - "buildid": "20161208071757", 08:13:30 INFO - "pgo_build": "False", 08:13:30 INFO - "basedir": "/builds/slave/test", 08:13:30 INFO - "buildnumber": 859, 08:13:30 INFO - "slavename": "talos-linux64-ix-037", 08:13:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:13:30 INFO - "platform": "ubuntu64_hw", 08:13:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:13:30 INFO - "branch": "mozilla-central", 08:13:30 INFO - "repo_path": "mozilla-central", 08:13:30 INFO - "revision": "d8f63b2935af0915a6a24b3ea8e27d9a09f66416", 08:13:30 INFO - "stage_platform": "linux64", 08:13:30 INFO - "builduid": "111970e67f32415fb7d5826f7b3e4496", 08:13:30 INFO - "slavebuilddir": "test" 08:13:30 INFO - } 08:13:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:13:30 INFO - Running post-action listener: _resource_record_post_action 08:13:30 INFO - [mozharness: 2016-12-08 16:13:30.562609Z] Finished read-buildbot-config step (success) 08:13:30 INFO - [mozharness: 2016-12-08 16:13:30.562697Z] Running download-and-extract step. 08:13:30 INFO - Running pre-action listener: _resource_record_pre_action 08:13:30 INFO - Running main action method: download_and_extract 08:13:30 INFO - mkdir: /builds/slave/test/build/tests 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:30 INFO - trying https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:13:30 INFO - Downloading https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/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 08:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/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 08:13:31 INFO - Downloaded 1361 bytes. 08:13:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:13:31 INFO - Using the following test package requirements: 08:13:31 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:31 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:13:31 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:13:31 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'jsshell-linux-x86_64.zip'], 08:13:31 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:13:31 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:31 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:13:31 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:13:31 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:13:31 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:13:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:13:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:13:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:31 INFO - Fetch https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:13:31 INFO - Expected file size: 20219783 08:13:31 INFO - Obtained file size: 20219783 08:13:35 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 08:13:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:13:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:35 INFO - Fetch https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:13:36 INFO - Expected file size: 20219783 08:13:36 INFO - Obtained file size: 20219783 08:13:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:13:41 INFO - Fetch https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:13:41 INFO - Expected file size: 14409734 08:13:41 INFO - Obtained file size: 14409734 08:13:42 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')]} 08:13:42 INFO - trying https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:13:42 INFO - Downloading https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/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 08:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/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 08:13:43 INFO - Downloaded 55705155 bytes. 08:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:13:43 INFO - mkdir: /builds/slave/test/properties 08:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:43 INFO - Contents: 08:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:13:43 INFO - Running post-action listener: _resource_record_post_action 08:13:43 INFO - Running post-action listener: set_extra_try_arguments 08:13:43 INFO - [mozharness: 2016-12-08 16:13:43.907646Z] Finished download-and-extract step (success) 08:13:43 INFO - [mozharness: 2016-12-08 16:13:43.907871Z] Running populate-webroot step. 08:13:43 INFO - Running pre-action listener: _resource_record_pre_action 08:13:43 INFO - Running main action method: populate_webroot 08:13:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:43 INFO - '--tppagecycles', 08:13:43 INFO - '7'], 08:13:43 INFO - 'tests': ['tsvgm']}}, 08:13:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['damp', 'tps']}, 08:13:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'tests': ['damp', 'tps']}, 08:13:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['dromaeo_dom']}, 08:13:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['basic_compositor_video']}, 08:13:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:13:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['a11yr', 08:13:43 INFO - 'ts_paint', 08:13:43 INFO - 'tpaint', 08:13:43 INFO - 'sessionrestore', 08:13:43 INFO - 'sessionrestore_no_auto_restore', 08:13:43 INFO - 'tabpaint']}, 08:13:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:43 INFO - 'ts_paint', 08:13:43 INFO - 'tpaint', 08:13:43 INFO - 'sessionrestore', 08:13:43 INFO - 'sessionrestore_no_auto_restore', 08:13:43 INFO - 'tabpaint']}, 08:13:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:43 INFO - 'ts_paint', 08:13:43 INFO - 'tpaint', 08:13:43 INFO - 'sessionrestore', 08:13:43 INFO - 'sessionrestore_no_auto_restore', 08:13:43 INFO - 'tabpaint']}, 08:13:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:43 INFO - 'ts_paint', 08:13:43 INFO - 'tpaint', 08:13:43 INFO - 'sessionrestore', 08:13:43 INFO - 'sessionrestore_no_auto_restore', 08:13:43 INFO - 'tabpaint']}, 08:13:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['a11yr', 08:13:43 INFO - 'ts_paint', 08:13:43 INFO - 'tpaint', 08:13:43 INFO - 'sessionrestore', 08:13:43 INFO - 'sessionrestore_no_auto_restore', 08:13:43 INFO - 'tabpaint']}, 08:13:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['a11yr', 08:13:43 INFO - 'ts_paint', 08:13:43 INFO - 'tpaint', 08:13:43 INFO - 'sessionrestore', 08:13:43 INFO - 'sessionrestore_no_auto_restore', 08:13:43 INFO - 'tabpaint']}, 08:13:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['tsvgx', 08:13:43 INFO - 'tsvgr_opacity', 08:13:43 INFO - 'tart', 08:13:43 INFO - 'tscrollx', 08:13:43 INFO - 'cart', 08:13:43 INFO - 'tsvg_static']}, 08:13:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:43 INFO - 'tsvgr_opacity', 08:13:43 INFO - 'tart', 08:13:43 INFO - 'tscrollx', 08:13:43 INFO - 'cart', 08:13:43 INFO - 'tsvg_static']}, 08:13:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'talos_options': ['--disable-e10s'], 08:13:43 INFO - 'tests': ['tp5o']}, 08:13:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:13:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'talos_options': ['--disable-e10s', 08:13:43 INFO - '--xperf_path', 08:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:43 INFO - 'tests': ['tp5n']}, 08:13:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:13:43 INFO - 'talos_options': ['--xperf_path', 08:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:43 INFO - 'tests': ['tp5n']}}, 08:13:43 INFO - 'talos.zip': {'path': '', 08:13:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:43 INFO - Running post-action listener: _resource_record_post_action 08:13:43 INFO - [mozharness: 2016-12-08 16:13:43.926652Z] Finished populate-webroot step (success) 08:13:43 INFO - [mozharness: 2016-12-08 16:13:43.926739Z] Running create-virtualenv step. 08:13:43 INFO - Running pre-action listener: _resource_record_pre_action 08:13:43 INFO - Running main action method: create_virtualenv 08:13:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:43 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 08:13:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:44 INFO - Using real prefix '/usr' 08:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:46 INFO - Installing pip.................done. 08:13:46 INFO - Return code: 0 08:13:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:13:46 INFO - Reading from file tmpfile_stdout 08:13:46 INFO - Output received: 08:13:46 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) 08:13:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13:46 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')]} 08:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:46 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')]} 08:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:46 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:46 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 08:13:46 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 08:13:46 INFO - Using env: {'DISPLAY': ':0', 08:13:46 INFO - 'HOME': '/home/cltbld', 08:13:46 INFO - 'LANG': 'en_US.UTF-8', 08:13:46 INFO - 'LANGUAGE': 'en_US:en', 08:13:46 INFO - 'LOGNAME': 'cltbld', 08:13:46 INFO - 'MAIL': '/var/mail/cltbld', 08:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:46 INFO - 'MOZ_NO_REMOTE': '1', 08:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:46 INFO - 'NO_EM_RESTART': '1', 08:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:46 INFO - 'PWD': '/builds/slave/test', 08:13:46 INFO - 'SHELL': '/bin/bash', 08:13:46 INFO - 'SHLVL': '1', 08:13:46 INFO - 'TERM': 'linux', 08:13:46 INFO - 'TMOUT': '86400', 08:13:46 INFO - 'USER': 'cltbld', 08:13:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:46 INFO - '_': '/tools/buildbot/bin/python'} 08:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:46 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 08:13:46 INFO - Cleaning up... 08:13:46 INFO - Return code: 0 08:13:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13:46 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')]} 08:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:46 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')]} 08:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:46 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:46 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 08:13:46 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 08:13:46 INFO - Using env: {'DISPLAY': ':0', 08:13:46 INFO - 'HOME': '/home/cltbld', 08:13:46 INFO - 'LANG': 'en_US.UTF-8', 08:13:46 INFO - 'LANGUAGE': 'en_US:en', 08:13:46 INFO - 'LOGNAME': 'cltbld', 08:13:46 INFO - 'MAIL': '/var/mail/cltbld', 08:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:46 INFO - 'MOZ_NO_REMOTE': '1', 08:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:46 INFO - 'NO_EM_RESTART': '1', 08:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:46 INFO - 'PWD': '/builds/slave/test', 08:13:46 INFO - 'SHELL': '/bin/bash', 08:13:46 INFO - 'SHLVL': '1', 08:13:46 INFO - 'TERM': 'linux', 08:13:46 INFO - 'TMOUT': '86400', 08:13:46 INFO - 'USER': 'cltbld', 08:13:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:46 INFO - '_': '/tools/buildbot/bin/python'} 08:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:47 INFO - Downloading/unpacking psutil>=3.1.1 08:13:47 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 08:13:47 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 08:13:47 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 08:13:47 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 08:13:47 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 08:13:47 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 08:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:49 INFO - Installing collected packages: psutil 08:13:49 INFO - Running setup.py install for psutil 08:13:49 INFO - building 'psutil._psutil_linux' extension 08:13:49 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 08:13:49 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 08:13:49 INFO - building 'psutil._psutil_posix' extension 08:13:49 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 08:13:49 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 08:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:49 INFO - Successfully installed psutil 08:13:49 INFO - Cleaning up... 08:13:49 INFO - Return code: 0 08:13:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:49 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:49 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 08:13:49 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 08:13:49 INFO - Using env: {'DISPLAY': ':0', 08:13:49 INFO - 'HOME': '/home/cltbld', 08:13:49 INFO - 'LANG': 'en_US.UTF-8', 08:13:49 INFO - 'LANGUAGE': 'en_US:en', 08:13:49 INFO - 'LOGNAME': 'cltbld', 08:13:49 INFO - 'MAIL': '/var/mail/cltbld', 08:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:49 INFO - 'MOZ_NO_REMOTE': '1', 08:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:49 INFO - 'NO_EM_RESTART': '1', 08:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:49 INFO - 'PWD': '/builds/slave/test', 08:13:49 INFO - 'SHELL': '/bin/bash', 08:13:49 INFO - 'SHLVL': '1', 08:13:49 INFO - 'TERM': 'linux', 08:13:49 INFO - 'TMOUT': '86400', 08:13:49 INFO - 'USER': 'cltbld', 08:13:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:49 INFO - '_': '/tools/buildbot/bin/python'} 08:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:49 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 08:13:49 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 08:13:49 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 08:13:49 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 08:13:49 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 08:13:49 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 08:13:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:13:52 INFO - Installing collected packages: mozsystemmonitor 08:13:52 INFO - Running setup.py install for mozsystemmonitor 08:13:52 INFO - Successfully installed mozsystemmonitor 08:13:52 INFO - Cleaning up... 08:13:52 INFO - Return code: 0 08:13:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:13:52 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')]} 08:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:52 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')]} 08:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:52 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:52 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 08:13:52 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 08:13:52 INFO - Using env: {'DISPLAY': ':0', 08:13:52 INFO - 'HOME': '/home/cltbld', 08:13:52 INFO - 'LANG': 'en_US.UTF-8', 08:13:52 INFO - 'LANGUAGE': 'en_US:en', 08:13:52 INFO - 'LOGNAME': 'cltbld', 08:13:52 INFO - 'MAIL': '/var/mail/cltbld', 08:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:52 INFO - 'MOZ_NO_REMOTE': '1', 08:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:52 INFO - 'NO_EM_RESTART': '1', 08:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:52 INFO - 'PWD': '/builds/slave/test', 08:13:52 INFO - 'SHELL': '/bin/bash', 08:13:52 INFO - 'SHLVL': '1', 08:13:52 INFO - 'TERM': 'linux', 08:13:52 INFO - 'TMOUT': '86400', 08:13:52 INFO - 'USER': 'cltbld', 08:13:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:52 INFO - '_': '/tools/buildbot/bin/python'} 08:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:52 INFO - Downloading/unpacking jsonschema==2.5.1 08:13:52 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 08:13:52 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 08:13:52 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 08:13:52 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 08:13:52 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 08:13:52 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 08:13:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:13:54 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 08:13:54 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 08:13:54 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 08:13:54 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 08:13:54 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 08:13:54 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 08:13:54 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:54 INFO - warning: no files found matching '*.txt' 08:13:54 INFO - no previously-included directories found matching 'build' 08:13:54 INFO - no previously-included directories found matching 'dist' 08:13:54 INFO - no previously-included directories found matching '.git*' 08:13:54 INFO - Installing collected packages: jsonschema, functools32 08:13:54 INFO - Running setup.py install for functools32 08:13:54 INFO - warning: no files found matching '*.txt' 08:13:54 INFO - no previously-included directories found matching 'build' 08:13:54 INFO - no previously-included directories found matching 'dist' 08:13:54 INFO - no previously-included directories found matching '.git*' 08:13:54 INFO - Successfully installed jsonschema functools32 08:13:54 INFO - Cleaning up... 08:13:54 INFO - Return code: 0 08:13:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:13:54 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')]} 08:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:54 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')]} 08:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:54 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:54 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 08:13:54 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 08:13:54 INFO - Using env: {'DISPLAY': ':0', 08:13:54 INFO - 'HOME': '/home/cltbld', 08:13:54 INFO - 'LANG': 'en_US.UTF-8', 08:13:54 INFO - 'LANGUAGE': 'en_US:en', 08:13:54 INFO - 'LOGNAME': 'cltbld', 08:13:54 INFO - 'MAIL': '/var/mail/cltbld', 08:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:54 INFO - 'MOZ_NO_REMOTE': '1', 08:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:54 INFO - 'NO_EM_RESTART': '1', 08:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:54 INFO - 'PWD': '/builds/slave/test', 08:13:54 INFO - 'SHELL': '/bin/bash', 08:13:54 INFO - 'SHLVL': '1', 08:13:54 INFO - 'TERM': 'linux', 08:13:54 INFO - 'TMOUT': '86400', 08:13:54 INFO - 'USER': 'cltbld', 08:13:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:54 INFO - '_': '/tools/buildbot/bin/python'} 08:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:13:55 INFO - Cleaning up... 08:13:55 INFO - Return code: 0 08:13:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:55 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:55 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 08:13:55 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 08:13:55 INFO - Using env: {'DISPLAY': ':0', 08:13:55 INFO - 'HOME': '/home/cltbld', 08:13:55 INFO - 'LANG': 'en_US.UTF-8', 08:13:55 INFO - 'LANGUAGE': 'en_US:en', 08:13:55 INFO - 'LOGNAME': 'cltbld', 08:13:55 INFO - 'MAIL': '/var/mail/cltbld', 08:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:55 INFO - 'MOZ_NO_REMOTE': '1', 08:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:55 INFO - 'NO_EM_RESTART': '1', 08:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:55 INFO - 'PWD': '/builds/slave/test', 08:13:55 INFO - 'SHELL': '/bin/bash', 08:13:55 INFO - 'SHLVL': '1', 08:13:55 INFO - 'TERM': 'linux', 08:13:55 INFO - 'TMOUT': '86400', 08:13:55 INFO - 'USER': 'cltbld', 08:13:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:55 INFO - '_': '/tools/buildbot/bin/python'} 08:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:55 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 08:13:55 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 08:13:55 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 08:13:55 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 08:13:55 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 08:13:55 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 08:13:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:57 INFO - Downloading docopt-0.6.1.tar.gz 08:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:58 INFO - Running setup.py install for blobuploader 08:13:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:58 INFO - Running setup.py install for requests 08:13:58 INFO - Running setup.py install for docopt 08:13:58 INFO - Successfully installed blobuploader requests docopt 08:13:58 INFO - Cleaning up... 08:13:58 INFO - Return code: 0 08:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:58 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:13:58 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 08:13:58 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 08:13:58 INFO - Using env: {'DISPLAY': ':0', 08:13:58 INFO - 'HOME': '/home/cltbld', 08:13:58 INFO - 'LANG': 'en_US.UTF-8', 08:13:58 INFO - 'LANGUAGE': 'en_US:en', 08:13:58 INFO - 'LOGNAME': 'cltbld', 08:13:58 INFO - 'MAIL': '/var/mail/cltbld', 08:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:58 INFO - 'MOZ_NO_REMOTE': '1', 08:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:58 INFO - 'NO_EM_RESTART': '1', 08:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:58 INFO - 'PWD': '/builds/slave/test', 08:13:58 INFO - 'SHELL': '/bin/bash', 08:13:58 INFO - 'SHLVL': '1', 08:13:58 INFO - 'TERM': 'linux', 08:13:58 INFO - 'TMOUT': '86400', 08:13:58 INFO - 'USER': 'cltbld', 08:13:58 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:58 INFO - '_': '/tools/buildbot/bin/python'} 08:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:58 INFO - Running setup.py (path:/tmp/pip-lIEwty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:58 INFO - Running setup.py (path:/tmp/pip-gpZO2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:59 INFO - Running setup.py (path:/tmp/pip-HpqdOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:59 INFO - Running setup.py (path:/tmp/pip-RSiTfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:59 INFO - Running setup.py (path:/tmp/pip-1l8uI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:59 INFO - Running setup.py (path:/tmp/pip-T8Eg5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:59 INFO - Running setup.py (path:/tmp/pip-QF3mbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:59 INFO - Running setup.py (path:/tmp/pip-rzIcjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:59 INFO - Running setup.py (path:/tmp/pip-hdGKIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:59 INFO - Running setup.py (path:/tmp/pip-nA_Nmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:59 INFO - Running setup.py (path:/tmp/pip-UQq2VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:59 INFO - Running setup.py (path:/tmp/pip-IviaAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:59 INFO - Running setup.py (path:/tmp/pip-Gj_x35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:59 INFO - Running setup.py (path:/tmp/pip-TiT7zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:59 INFO - Running setup.py (path:/tmp/pip-PRIbDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:59 INFO - Running setup.py (path:/tmp/pip-C6Cqir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:00 INFO - Running setup.py (path:/tmp/pip-hGp3H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:00 INFO - Running setup.py install for manifestparser 08:14:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Running setup.py install for mozcrash 08:14:00 INFO - Running setup.py install for mozdebug 08:14:00 INFO - Running setup.py install for mozdevice 08:14:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Running setup.py install for mozfile 08:14:00 INFO - Running setup.py install for mozhttpd 08:14:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Running setup.py install for mozinfo 08:14:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Running setup.py install for mozInstall 08:14:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:00 INFO - Running setup.py install for mozleak 08:14:00 INFO - Running setup.py install for mozlog 08:14:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Running setup.py install for moznetwork 08:14:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Running setup.py install for mozprocess 08:14:01 INFO - Running setup.py install for mozprofile 08:14:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Running setup.py install for mozrunner 08:14:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Running setup.py install for mozscreenshot 08:14:01 INFO - Running setup.py install for moztest 08:14:01 INFO - Running setup.py install for mozversion 08:14:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:01 INFO - Cleaning up... 08:14:01 INFO - Return code: 0 08:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:01 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:14:01 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 08:14:01 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 08:14:01 INFO - Using env: {'DISPLAY': ':0', 08:14:01 INFO - 'HOME': '/home/cltbld', 08:14:01 INFO - 'LANG': 'en_US.UTF-8', 08:14:01 INFO - 'LANGUAGE': 'en_US:en', 08:14:01 INFO - 'LOGNAME': 'cltbld', 08:14:01 INFO - 'MAIL': '/var/mail/cltbld', 08:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:01 INFO - 'MOZ_NO_REMOTE': '1', 08:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:01 INFO - 'NO_EM_RESTART': '1', 08:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:01 INFO - 'PWD': '/builds/slave/test', 08:14:01 INFO - 'SHELL': '/bin/bash', 08:14:01 INFO - 'SHLVL': '1', 08:14:01 INFO - 'TERM': 'linux', 08:14:01 INFO - 'TMOUT': '86400', 08:14:01 INFO - 'USER': 'cltbld', 08:14:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:01 INFO - '_': '/tools/buildbot/bin/python'} 08:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:02 INFO - Running setup.py (path:/tmp/pip-zdcfJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:02 INFO - Running setup.py (path:/tmp/pip-TJW5j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:02 INFO - Running setup.py (path:/tmp/pip-qMAyrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:02 INFO - Running setup.py (path:/tmp/pip-bNvtzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:02 INFO - Running setup.py (path:/tmp/pip-FZIgUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:02 INFO - Running setup.py (path:/tmp/pip-3p7ob8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:02 INFO - Running setup.py (path:/tmp/pip-TzlVZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:02 INFO - Running setup.py (path:/tmp/pip-NwP0Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:02 INFO - Running setup.py (path:/tmp/pip-8qAtuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:02 INFO - Running setup.py (path:/tmp/pip-KtK3q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:02 INFO - Running setup.py (path:/tmp/pip-7EVk4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:02 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)) 08:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:02 INFO - Running setup.py (path:/tmp/pip-2O1hSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:03 INFO - Running setup.py (path:/tmp/pip-_wZVuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:03 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)) 08:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:03 INFO - Running setup.py (path:/tmp/pip-Z4UX0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:03 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)) 08:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:03 INFO - Running setup.py (path:/tmp/pip-5EpUza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:03 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)) 08:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:03 INFO - Running setup.py (path:/tmp/pip-pWeVov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:03 INFO - Running setup.py (path:/tmp/pip-DgWcPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:03 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)) 08:14:03 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)) 08:14:03 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)) 08:14:03 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)) 08:14:03 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)) 08:14:03 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)) 08:14:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:05 INFO - Downloading blessings-1.6.tar.gz 08:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:05 INFO - Installing collected packages: blessings 08:14:05 INFO - Running setup.py install for blessings 08:14:05 INFO - Successfully installed blessings 08:14:05 INFO - Cleaning up... 08:14:05 INFO - Return code: 0 08:14:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:05 INFO - Reading from file tmpfile_stdout 08:14:05 INFO - Current package versions: 08:14:05 INFO - argparse == 1.2.1 08:14:05 INFO - blessings == 1.6 08:14:05 INFO - blobuploader == 1.2.4 08:14:05 INFO - docopt == 0.6.1 08:14:05 INFO - functools32 == 3.2.3-2 08:14:05 INFO - jsonschema == 2.5.1 08:14:05 INFO - manifestparser == 1.1 08:14:05 INFO - mozInstall == 1.12 08:14:05 INFO - mozcrash == 1.0 08:14:05 INFO - mozdebug == 0.1 08:14:05 INFO - mozdevice == 0.49 08:14:05 INFO - mozfile == 1.2 08:14:05 INFO - mozhttpd == 0.7 08:14:05 INFO - mozinfo == 0.9 08:14:05 INFO - mozleak == 0.1 08:14:05 INFO - mozlog == 3.4 08:14:05 INFO - moznetwork == 0.27 08:14:05 INFO - mozprocess == 0.23 08:14:05 INFO - mozprofile == 0.28 08:14:05 INFO - mozrunner == 6.13 08:14:05 INFO - mozscreenshot == 0.1 08:14:05 INFO - mozsystemmonitor == 0.3 08:14:05 INFO - moztest == 0.7 08:14:05 INFO - mozversion == 1.4 08:14:05 INFO - psutil == 3.1.1 08:14:05 INFO - requests == 1.2.3 08:14:05 INFO - wsgiref == 0.1.2 08:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:05 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 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:14:05 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 08:14:05 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 08:14:05 INFO - Using env: {'DISPLAY': ':0', 08:14:05 INFO - 'HOME': '/home/cltbld', 08:14:05 INFO - 'LANG': 'en_US.UTF-8', 08:14:05 INFO - 'LANGUAGE': 'en_US:en', 08:14:05 INFO - 'LOGNAME': 'cltbld', 08:14:05 INFO - 'MAIL': '/var/mail/cltbld', 08:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:05 INFO - 'MOZ_NO_REMOTE': '1', 08:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:05 INFO - 'NO_EM_RESTART': '1', 08:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:05 INFO - 'PWD': '/builds/slave/test', 08:14:05 INFO - 'SHELL': '/bin/bash', 08:14:05 INFO - 'SHLVL': '1', 08:14:05 INFO - 'TERM': 'linux', 08:14:05 INFO - 'TMOUT': '86400', 08:14:05 INFO - 'USER': 'cltbld', 08:14:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:05 INFO - '_': '/tools/buildbot/bin/python'} 08:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 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)) 08:14:06 INFO - Cleaning up... 08:14:06 INFO - Return code: 0 08:14:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cbc2abe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2405a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', '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 08:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:06 INFO - Using env: {'DISPLAY': ':0', 08:14:06 INFO - 'HOME': '/home/cltbld', 08:14:06 INFO - 'LANG': 'en_US.UTF-8', 08:14:06 INFO - 'LANGUAGE': 'en_US:en', 08:14:06 INFO - 'LOGNAME': 'cltbld', 08:14:06 INFO - 'MAIL': '/var/mail/cltbld', 08:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:06 INFO - 'MOZ_NO_REMOTE': '1', 08:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:06 INFO - 'NO_EM_RESTART': '1', 08:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:06 INFO - 'PWD': '/builds/slave/test', 08:14:06 INFO - 'SHELL': '/bin/bash', 08:14:06 INFO - 'SHLVL': '1', 08:14:06 INFO - 'TERM': 'linux', 08:14:06 INFO - 'TMOUT': '86400', 08:14:06 INFO - 'USER': 'cltbld', 08:14:06 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:06 INFO - '_': '/tools/buildbot/bin/python'} 08:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:06 INFO - Cleaning up... 08:14:06 INFO - Return code: 0 08:14:06 INFO - Running post-action listener: _resource_record_post_action 08:14:06 INFO - Running post-action listener: _start_resource_monitoring 08:14:06 INFO - Starting resource monitoring. 08:14:06 INFO - [mozharness: 2016-12-08 16:14:06.386011Z] Finished create-virtualenv step (success) 08:14:06 INFO - [mozharness: 2016-12-08 16:14:06.386533Z] Running install step. 08:14:06 INFO - Running pre-action listener: _resource_record_pre_action 08:14:06 INFO - Running main action method: install 08:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:06 INFO - Reading from file tmpfile_stdout 08:14:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:06 INFO - Reading from file tmpfile_stdout 08:14:06 INFO - Output received: 08:14:06 INFO - Usage: mozinstall [options] installer 08:14:06 INFO - Options: 08:14:06 INFO - -h, --help show this help message and exit 08:14:06 INFO - -d DEST, --destination=DEST 08:14:06 INFO - Directory to install application into. [default: 08:14:06 INFO - "/builds/slave/test"] 08:14:06 INFO - --app=APP Application being installed. [default: firefox] 08:14:06 INFO - mkdir: /builds/slave/test/build/application 08:14:06 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'] 08:14:06 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 08:14:22 INFO - Reading from file tmpfile_stdout 08:14:22 INFO - Output received: 08:14:22 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:22 INFO - Running post-action listener: _resource_record_post_action 08:14:22 INFO - [mozharness: 2016-12-08 16:14:22.713650Z] Finished install step (success) 08:14:22 INFO - [mozharness: 2016-12-08 16:14:22.713981Z] Running run-tests step. 08:14:22 INFO - Running pre-action listener: _resource_record_pre_action 08:14:22 INFO - Running main action method: run_tests 08:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:22 INFO - Python 2.7.3 08:14:22 INFO - Return code: 0 08:14:22 INFO - grabbing minidump binary from tooltool 08:14:22 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')]} 08:14:22 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 0x2633f20>, '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 0x25a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:22 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 08:14:22 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 08:14:22 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 08:14:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:22 INFO - Return code: 0 08:14:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 08:14:22 INFO - Using env: {'DISPLAY': ':0', 08:14:22 INFO - 'HOME': '/home/cltbld', 08:14:22 INFO - 'LANG': 'en_US.UTF-8', 08:14:22 INFO - 'LANGUAGE': 'en_US:en', 08:14:22 INFO - 'LOGNAME': 'cltbld', 08:14:22 INFO - 'MAIL': '/var/mail/cltbld', 08:14:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:22 INFO - 'MOZ_NO_REMOTE': '1', 08:14:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:22 INFO - 'NO_EM_RESTART': '1', 08:14:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:22 INFO - 'PWD': '/builds/slave/test', 08:14:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:22 INFO - 'SHELL': '/bin/bash', 08:14:22 INFO - 'SHLVL': '1', 08:14:22 INFO - 'TERM': 'linux', 08:14:22 INFO - 'TMOUT': '86400', 08:14:22 INFO - 'USER': 'cltbld', 08:14:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223', 08:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:22 INFO - '_': '/tools/buildbot/bin/python'} 08:14:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:14:23 INFO - mozversion application_buildid: 20161208071757 08:14:23 INFO - mozversion application_changeset: d8f63b2935af0915a6a24b3ea8e27d9a09f66416 08:14:23 INFO - mozversion application_display_name: Nightly 08:14:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:23 INFO - mozversion application_name: Firefox 08:14:23 INFO - mozversion application_remotingname: firefox 08:14:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:14:23 INFO - mozversion application_vendor: Mozilla 08:14:23 INFO - mozversion application_version: 53.0a1 08:14:23 INFO - mozversion platform_buildid: 20161208071757 08:14:23 INFO - mozversion platform_changeset: d8f63b2935af0915a6a24b3ea8e27d9a09f66416 08:14:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:14:23 INFO - mozversion platform_version: 53.0a1 08:14:23 INFO - using testdate: 1481213663 08:14:23 INFO - actual date: 1481213663 08:14:23 INFO - starting webserver on 'localhost:36465' 08:14:23 INFO - SUITE-START | Running 2 tests 08:14:23 INFO - TEST-START | dromaeo_css 08:14:23 INFO - operating with platform_type : linux_ 08:14:23 INFO - Initialising browser for dromaeo_css test... 08:14:23 INFO - TEST-INFO | started process 8879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSzKpH/profile http://localhost:36465/getInfo.html) 08:14:27 INFO - PROCESS | 8879 | __metrics Screen width/height:1600/1200 08:14:27 INFO - PROCESS | 8879 | colorDepth:24 08:14:27 INFO - PROCESS | 8879 | Browser inner width/height: 1024/697 08:14:27 INFO - PROCESS | 8879 | __metrics 08:14:27 INFO - PROCESS | 8879 | 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" 08:14:27 INFO - PROCESS | 8879 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:28 INFO - PROCESS | 8879 | console.error: PushService: 08:14:28 INFO - PROCESS | 8879 | stateChangeProcessEnqueue: Error transitioning state 08:14:28 INFO - PROCESS | 8879 | UnknownError 08:14:28 INFO - TEST-INFO | 8879: exit 0 08:14:28 INFO - Browser initialized. 08:14:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:28 INFO - TEST-INFO | started process 8962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSzKpH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:41 INFO - PROCESS | 8962 | RSS: Main: 173867008 08:14:41 INFO - PROCESS | 8962 | 08:15:32 INFO - PROCESS | 8962 | 1481213732038 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:17:45 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:36465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36465/tests/dromaeo/cssquery-ext.html) 08:17:48 INFO - PROCESS | 8962 | RSS: Main: 273076224 08:17:48 INFO - PROCESS | 8962 | 08:20:51 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:36465/tests/dromaeo/cssquery-ext.html (next: http://localhost:36465/tests/dromaeo/cssquery-jquery.html) 08:20:51 INFO - PROCESS | 8962 | RSS: Main: 277434368 08:20:51 INFO - PROCESS | 8962 | 08:23:54 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:36465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36465/tests/dromaeo/cssquery-mootools.html) 08:23:54 INFO - PROCESS | 8962 | RSS: Main: 245252096 08:23:54 INFO - PROCESS | 8962 | 08:26:57 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:36465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36465/tests/dromaeo/cssquery-prototype.html) 08:26:57 INFO - PROCESS | 8962 | RSS: Main: 222113792 08:26:57 INFO - PROCESS | 8962 | 08:30:00 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:36465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36465/tests/dromaeo/cssquery-yui.html) 08:30:01 INFO - PROCESS | 8962 | RSS: Main: 221597696 08:30:01 INFO - PROCESS | 8962 | 08:33:04 INFO - PROCESS | 8962 | Cycle 1(1): loaded http://localhost:36465/tests/dromaeo/cssquery-yui.html (next: http://localhost:36465/tests/dromaeo/cssquery-dojo.html) 08:33:05 INFO - PROCESS | 8962 | RSS: Main: 318283776 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | __start_tp_report 08:33:05 INFO - PROCESS | 8962 | _x_x_mozilla_page_load 08:33:05 INFO - PROCESS | 8962 | _x_x_mozilla_page_load_details 08:33:05 INFO - PROCESS | 8962 | |i|pagename|runs| 08:33:05 INFO - PROCESS | 8962 | |0;dojo.html;2550.528152291826;2570.614407838825;2607.2960300718805;2608.895644174233;2619.764221220091;4599.586037256646;4645.210314246578;4681.719096854191;4704.55306745859;4716.622670186385;4575.702579332341;4591.173588754023;4624.468186158593;4685.25035994241;4696.131215725093;4314.913701725979;4318.179545886287;4345.587169218919;4376.584224498668;4435.201663700533;4037.6971727120435;4419.226635338819;4437.622802061828;4473.530279320673;4521.819127234907;4299.441072660566;4341.978290108561;4384.517703052662;4453.020335526211;4493.415855938723;4384.846530371454;4402.097569998175;4406.5593440656;4409.338599210112;4412.205802955466;4366.432363792718;4374.256376416017;4374.78126093694;4378.78106094694;4378.846740364103;4743.454502732161;4750.429948406213;4756.262779269185;4758.428988521399;4760.857174284777;4969.527894849984;5027.1705168647495;5029.899402011939;5071.239314102877;5091.694498330112;5055.165897626887;5061.974690126526;5067.543921047123;5077.720725360104;5116.616253780981;4731.621470282369;4735.21868891629;4740.312654665055;4742.928856067162;4776.2119250324;5047.722375269322;5058.747062646853;5107.770150343169;5109.335786347751;5130.30740849988;4968.751562421864;4969.875753106201;4970.502949705001;4973.129702302155;5009.949900501021;5049.545540901263;5053.444121146671;5056.115179843586;5057;5102.056119617882;4932.728699921467;4954.281629163751;4974.8756281093265;4977.651564390458;5017.598592112622;5004.224345226496;5027.899442011139;5033;5104.2088476286235;5110.591152707849;4386.956130438654;4388.670849686287;4388.846390376385;4389.253826849444;4437.911241775147;3731.7947512887054;3795.8291876865605;3811.085339518551;3849.191669749384;3861.613838616116;4294.978525107417;4313.805878735465;4318.524962254212;4325.870223893226;4375.387445757597;5046.369203849519;5046.722430266371;5046.924296135561;5052.595792336604;5081.898362032739;4332.67504937131;4335.1979883721615;4345;4363.192809330284;4380.561943805657;4468.888277793016;4520.321951707205;4522.706024108423;4562.429696287964;4575.016371480147;4580.175568397721;4615.353850460871;4635.814567417266;4636.397268355227;4636.933505293734;5031.496850315086;5035.773390197523;5040.647154699136;5042.168042272984;5054.2923990642075;4644.535546445329;4651.651126165619;4659.370984916993;4661.207594708975;4663.393758811333;4964.726940018189;4965.925511117408;4966.900661986668;4967.875803104951;4968.751562421937;4928.433230178575;4941.555260026615;4944.975275123601;4950.4059512858685;4973.577245934136;4799.1601469743355;4799.448063472745;4855.320255164351;4863.805447782049;4870.683405578626;4900.901981960412;4910.9263361050325;4914.213725803854;4916.778744956414;4960.330355401975;4725.385699858996;4768.332433459388;4842.6368022397755;4860.489648586848;4901.926471103007;4931.679440836334;4954.033963377251;4961.355023846877;5011.574016208663;5045.091883461012;4876.073546026244;4884.389451318585;4888.706677599355;4890.926636100533;4926.039422312758 08:33:05 INFO - PROCESS | 8962 | |1;ext.html;557.1058451185846;599.4335353091328;601.7292218501669;603.2579926690171;610.0605068194977;36078.819605902;37260.627393726056;37410;41111.588884111225;41169.58830411695;37801.24397512055;38010.61989380106;38123;38132.23735525288;38135.237295254075;7404.962975185116;7537.962310188455;7712.460127791029;7715.537067775924;7716.575588342639;7318.707251709925;9665.758356041086;9881.851772223386;9883.703488895344;10251.487425628726;9604.2316614671;9641.951790241039;9647.228221742243;9647.565859536338;9653.855192172123;9913.504324783731;9970.202383809277;10015.74960625983;10020.498975051218;10020.549075291628;9901.702948911472;9958.402495850272;9961.601535938555;9965.40207587547;9968.700938971842;36505.81747091274;36596.451053234225;36612.450813237825;36671.266574668356;36797.81601092004;2832.2352964699417;2851.21591562322;2905.6513218413716;2948.6756456789735;3359.8992030239133;27570.724292757215;27684.41079709848;27760.444791104266;28180;28471.572926405912;3269.4278501262183;3288.52316414121;3294.4234758917332;3297.634717402564;3329.96670033299;170987;171164;171646;171837;171869.99999999875;50587.49412505828;50853;50988;51009.09359049353;51012.74493627508;53859.46140538623;53981.730091349295;53989.1901621476;54080.18879716808;54138.72930635322;12992.285424301564;13308.201507909556;13312.866871331356;13313.46746130144;13315.334233288491;9061.184493395625;9213.76965575866;9922.702318930444;10063.39619622825;10133.138683211862;15077.682909759835;15763.527094187193;15780.68438631221;15785.447509337118;15822.77853267614;5572.4706152915405;5588.177970125061;5595.18869763882;5645.153227015899;5658.915116273177;765.3685709289858;858.2404571953741;866.5277423804042;931.3108299858192;948.8434408322687;25759.742402575735;26545.73454265471;27030.324241893715;27114.45771084607;27131.72868271292;870.9956450217709;969.2197780786394;990.5146478225762;994.9005099490138;997.396575072071;14349.78475322871;14523.709525809425;14529.78205326921;14715.852841471662;14821.110733356034;337214;339774;340870;341308;341790;47327.763361183665;47438.5256147441;47457;47484;47563;1073.0557109743377;1091.8525998990035;1095.5289225633055;1156.8496095507699;1196.9341686207167;24579.13973010936;29330.853345733136;30115.397692046474;30157.396852062397;30536.739968306887;43950.34074488821;44400.555994439645;44511.10977780491;44512.10975780531;44557.55442445534;303523;305754;306007;306127;307056;29767.851160744056;30509.54235686422;34144.829275854456;34356.14109647279;34428.65571344355;39453.605463944994;39661.2067758649;39760.80119599384;40155.59844401519;40597.39103913503;33951;34053.148671283416;34107.48838767371;34127.488087678204;34178.31643367069;33728;34043.14892127716;34070.081940577154;34383.65616343805;34500.654993449745;32950;33674;33724.49413258852;33943;34382;29868.10395688133;30958.53562196614;31022.689773102884;31045.68954310428;31608;23435.296941091794;24456.871479953195;24484.51030979406;24551.631725523774;24604.45624498461 08:33:05 INFO - PROCESS | 8962 | |2;jquery.html;358.1994242867193;367.6378766914587;376.0429706397219;378.72542406755105;391.91377896862696;15155.848441515594;15913.522594322174;16652.58368540787;16700.08149551774;16719.66560668789;15614.375424982987;16209.918950405261;16434.42479513214;16559.503214903543;16582.419615313465;4742.122707299152;4990.176620857573;4992.925106123411;4992.950070499303;4994.550490455858;3693.593704692495;3877.0307423144213;4849.75751212438;5513.696746678931;5766.509846663018;5830.096335068071;5851.7074146292725;5857.26784151981;5869.1196320551835;5869.148973398855;5615;5744.368119506851;5758.683272420015;5773.480386765169;5818.27271591049;5060.2156665716875;5081.517255860687;5088.160453525164;5094.083065048289;5102.285680004802;21184.470388240265;21692.674609880865;21724.674129888066;21906.12375504978;22593.322200333852;1901.7717873855088;1959.7746259180092;2011.4569066352149;2122.734658167729;2496.9750302496923;13417.396217170251;13724.519641812589;13817.447302107903;14157.716845663132;14322.959343295128;1853.2309091726918;1853.7404763333145;1858.0895361272878;1890.546268895469;1911;73668.63165684191;78075.6096219521;78087.60956195183;78136;78369;15736.763948540782;15763.290651920692;15972.840271597368;16173.353065877232;16303.83696163047;26893.731062689512;26912.192634221006;27091.322716932234;27100.864495677397;27254.45491090167;8033.598320084089;8093.392995525359;8142.389320800964;8181.140980197112;8445.788855278668;6475.4819614430735;6534.150560427114;6683.090392120566;6698.062271282024;6709.396154346035;7839.294463498312;7987.800304992422;8124.22819832115;8219.342452603778;8307.293880020266;2571.7111770523875;2923.342247994184;3059.464593696094;3162.667919868427;3306.8015919044933;742.2392048150689;843.2832092721261;884.7832281091174;886.3883920095113;918.1048477734289;15294.464693735888;15527.611809704622;15972.440964566184;16523.82927475263;16728.749068763977;782.8121250899743;791.6041979010495;824.4640983360863;827.954462504568;853.9743807685779;8505.532195729294;9218.216451601555;9247.72256832296;9290.814183716288;9325.393849399767;271898;277290;277949;323419;375943;74408.62795685987;77928.610356949;79887.20112798914;79967.20032799598;80472.59763701144;891.0688330694439;899.7345782993901;926.249737712455;932.1983094538691;935.6070450410843;14912.403503859725;15169.620759481102;15699.607509812346;15840.49515296045;15900.52298431049;35289.82355088208;35318.64681353154;36122;36324.818375907955;37120.07199819918;47363.52636473591;48406.930128865715;49287.50712492829;50040.49959500358;50716.10439210682;7302.780916572511;7362.705491780269;7428.814279643052;7463.962680186564;7485.251474852471;7270.001499175538;10582.894171058191;11045.944770276097;11180.944095279472;11427.828582571101;8561;8895.555222238732;9431.198348140211;10024.649137280161;10201.132903703268;9326.906730932604;9816;10016.198704103508;10083.848742268725;10194.949025254826;9955.153811926068;10008.899911001088;10295.53670084863;10460.424676642553;10610.469476526298;7322.3775979042375;7482.064741907262;7641.3886889047635;7674.117476490052;7780.961095194488;9088.909110908806;9451.291153163678;10299.794004119725;10344.637937672145;10353.482325883826 08:33:05 INFO - PROCESS | 8962 | |3;mootools.html;1266.2022925556898;1266.9936650316747;1310.8951283897288;1585.817630972437;1591.3395940684625;6098.4511393974535;6276.466500347465;6634.369734875185;7019.7543085992;7031.71873125075;6546.24718157412;6767.187937447501;6777.830554236147;6937.132858392701;6941.618210998393;2051.4358551398373;2061.701053347264;2068.0693687840458;2072.1193492765588;2081.906314215864;1838.6598479281377;1908.1222637586727;2046.1508473983279;2050.077465140685;2059.804318589739;2024.7165396844453;2097.4861159016064;2100.6428907085833;2101.737282839645;2109.4726318420394;2048.9180432782673;2065.3390914907236;2082.37528741377;2093.6440805063253;2093.958120837575;2101.548167144056;2125.1605615781677;2145.5279838435517;2147.452399638098;2151.87088774674;6888.793336199922;6959.095317608729;6976.19773726023;6984.965075174591;7004.544704594185;4169.60388763067;4275;4307.698461107724;4310.676699247569;4311.28863737483;2678.933026674329;2729.972700272992;2804.943901121966;2832.06541841194;2840.304125489248;883.8409086364452;890.4078787606234;898.6809682562662;899.9100089991014;907.6550910653975;8983.505907175102;8984.505852178128;8988.191062804379;8989.685361012398;8995.595198216097;3900.1029763154065;3952.7430717003303;4024.195160967818;4024.657904078186;4044.757314561136;7801.843963120819;7865.488743231786;7867.134615192324;7868.803279917934;7873.976383070164;4390.473143222834;4396.142752163298;4413.7793110344355;4417.514073451917;4420.425344705168;3820.6179382061573;3955.3078211312904;4045.069633984141;4046.393041043808;4046.656034237064;3096.334288128018;3110.2535391506326;3191.834980232245;3192.584963954671;3208.1819136120607;889.74642226965;893.4951752259952;976.5703090640095;985.3102828020415;1001.8296889528798;667.8196886840623;680.6528670378044;745.3664385272583;761.0980987529795;773.7872085176509;4807.206810876236;4846.7818948147415;4907.754612269372;4930.556249937451;4973.950260497421;812.4800127918137;818.300353198019;841.5707988925569;859.1022381611232;870.5821205821242;3261.951070733941;3387.491876218587;3414.7951122932704;3438.6561343865415;3510.78935263885;7428.702851885864;8064.395170362246;8119.79700507492;8126.553039582762;8131.308838748772;8094.231048050426;8100.149484304181;8100.149484304181;8103.635336409876;8115;6236.6258024518675;6413.679316034273;6414.839629009312;6468.6442245676935;6474.352564743582;4771.66598338113;4830.154722923404;4834.6374021947795;4880.804767809248;4888.022395520839;7352.823548232257;7371.594562299125;7477.214892436434;7503.587302698404;7597.088349398107;7477.813054673459;7546.773596792105;7616.543007419573;7655.655495502827;7667.386609071373;5462.289902312833;5483.095289277225;5520;5547.278853748987;5583.525400341016;6336.778212762531;6407.935920640734;6410.743570257137;6414.871702566016;6417.422431981144;5853.824385268449;6044.758209671564;6045.486133678686;6054.697265136813;6134.04922237054;5795.420457954171;5799.420057994167;5855.443732845373;5859.707014649165;5935.109733540004;5637.633553818989;5705.201271821865;5705.315362156568;5706.172604972173;5707.6575405475805;4162;4243.724157929724;4254.149170165917;4263.232618128766;4448.6663500238255;4195.223883581547;4270.444842170498;4303.634191093792;4373.6063754260995;4501.3473046407435 08:33:05 INFO - PROCESS | 8962 | |4;prototype.html;284.55893365283805;287.77984841596174;295.52125556598315;296.9792114551981;299.0952369083523;4688.929666055012;4757.8096876125;4774.4270687517455;4796.3764710587575;4830.178869592169;4693.55411235932;4695.976520117403;4699.224627936386;4703.764811759407;4731.219348807451;3518.612952575215;3583.9641603584023;3616;3742.195427982983;3753.8498460061633;3672.6327367263325;3698.907527311825;3715.8327875245545;3717.6058977883295;3723.8882833514904;3704.3332200203954;3721.2371463849845;3722.143906901414;3722.9069273268115;3727.7576957497677;3542.167590616203;3662.322470342995;3725.2549490102087;3734.3091528067257;3740.4763333133383;3231.903042908693;3273.0508152635707;3273.3944220319318;3281.8523166457567;3285.96714032859;4606.838760643362;4607.239805432099;4626.167289887819;4630.490646028934;4638.538860259041;4157.189348077126;4182.2890108681295;4198.328267477189;4204.684648651363;4213.199492096492;4749.905001899942;4908.43552991407;4919.901601967977;4921.0157968406465;4935.901281974377;3473.808940508271;3474.9131271718156;3477.9392285352956;3481.8433170507387;3483.599386070609;5171.663841850268;5173.870653233662;5183.637145399824;5192.45479224676;5217.373915130209;3344.7156991655497;3508.1755787389943;3545.5213546170935;3550.8579656813954;3551.982240088783;3536.80547569881;3542.6634469725336;3560.2523470071574;3573.356795776785;3590.425531914881;4098.959010409917;4102.753834769924;4105.58944105593;4109.260333140004;4116.929598304462;4955.677880937727;4958.925616115761;4963.280324353021;4975.676581022294;5000.799968001312;1169.2049406403557;1209.1354681402838;1213.8118591618313;1215.1190386969554;1219.8597161326384;793.9004478796908;812.8902598149174;819.332244220958;822.3092602214169;825.6078362777632;4273.594008569181;4282.63597594208;4290.613844753987;4340.76125813077;4381.16757816014;5131.3579654510195;5138.588912887035;5152.639315247971;5167.870803229949;5173.767180476888;4454.554544545519;4455.532169122195;4455.910881782346;4465.620422264144;4477.306017567283;2531.3418511187224;2620.7248238935017;2631.1317265302405;2638.828476149044;2641.7622413982835;4545.636349092065;4578.45058592971;4582.793774280165;4610.219619911641;4619.290862380941;5029.943711820485;5033.546980771748;5042.840146766264;5046.394432668103;5062.822801202014;4413.911721765547;4559.404208527056;4569.908601828011;4592.035672508744;4602.815887364468;4927.482614325444;4927.975360123177;4930.630202734737;4936.827211047596;4939.333190019302;4866.975665121652;4868.391451068616;4869.926951095666;4871.196252618278;4873.926891096708;4318;4548.658850586286;4567.954320456753;4575.405197324327;4593.931091033571;3479.495473156429;3480.4257297545623;3488.8778892738633;3492.231709024011;3513.209527856212;4906.8959484115785;4927.556519913225;4959.20652695567;4979.975100124476;4981.775820088177;4715.717056976592;4757.857264282077;4778.713277203379;4801.135086255597;4813.470518243061;5017.347744793154;5026.648134630541;5027.547520723152;5029.220470827027;5033.446320904624;4949.554540091409;4951.257311403318;4953.281774142802;4967.875803104951;4978.726170060681;4917.9426423319155;5028.170351891897;5047.712833227651;5063.367079115111;5076.340075790124;4915.877103072452;4932.679375840559;4936.925946110883;4941.43173535048;4942.678725882806 08:33:05 INFO - PROCESS | 8962 | |5;yui.html;649.7563413719854;655.2431941108022;689.1385767790263;722.1514720203759;732.472619713806;12499.312537810416;13684.589462316122;13776.38006289717;13779.724405511884;13792.655183620402;13039.739205215914;13227.735445291088;13235.205887646747;13237.139585926909;13243.867561324409;609.1806520230283;624.7594676049708;738.9408847292203;748.7304570354681;758.6775620361352;759.7530802489185;761.3794757272833;761.6572542355934;761.67628757778;761.6800943603699;816.5223344343536;817.8364327134567;818.1123481023068;818.2717381530442;818.304441224957;645.6674812471581;666.243813271935;668.3450218785617;671.3856821008771;806.6410447350931;488.46269103985685;559.8348487196287;574.184657785945;575.0827430248746;578.5776383240258;13151.934240328832;13171.934140329333;13195.736085278337;13212.603621891263;13226.140300880412;12685.302308373035;12859.807102893465;12868.549600764021;13019.609411717569;13095.738085238241;11581.305121692725;11776.116791240605;11796.233244839059;12138.271703697807;12211.694707632292;4101.91796164078;4124.670026397881;4129.132882094764;4306.310990241577;4313.698041137121;65264;65788.67105664489;67103.3027688062;67467.32532674659;67483;10195.357756382033;10318.329308594917;10428;10432.2697411182;10624.468776561296;19200.327988520334;19233.230670773013;19328.226870925286;19432.80567194338;19906.50233744168;6678.365555272241;6731.966340168366;6751.156105486814;6806.727730890808;7059;3667.339878821784;3727.4781530585738;3747;3762.981185094057;3772.2644084403278;2791.204506715617;2883.783716221292;2887.1627228103616;2888.62447881774;3208.502682084281;530.6073505605901;531.3384835879277;539.7840863654569;544.6187668631974;549.0391814324931;601.2064075420403;606.4966078155121;615.8183335915916;620.0853740732474;630.2625927664643;8054.436189466681;8116.634751436081;8323;8551.486910785372;8677.913220867711;544.2081771023152;559.739721029715;560.7560711090689;622.4179844992132;629.625372903131;3898.9610103899167;4238.809253583535;4250.468691413574;4260.403543503912;4280.89297767552;54593.727031364586;54694.453055469734;55542.44457555454;68554;71271.6436417825;62363.75272494616;63247;63315.68342158352;64533.35466645368;66514;56711;57052;57846.71076644674;60126.699366502886;61915;8042.67829286822;8043.798905027421;8164.83670326602;8177.918220817954;8545.52999585004;38308.61691383162;38951;39664.40503392509;39998.80000600095;41402.1719565613;47493.52506474891;52339;52719.472805271456;53359.46640533545;53734;10396.532156053147;10440.112590429899;10556.313839600401;10783.299085559414;11123.666290011313;11737.119716021161;12124.939375303067;12167.817482737943;12295.938520307342;12800.871991279968;9828.213742900694;10044.899551004397;10647.094996925038;10668.733281668021;11173.385463799568;11099.223054386115;11171.21801473889;11388.886111138783;11827.349495777815;11895.286282823059;11618.535258589562;12074.517019319128;12081.516739330329;12357.073219508753;12580.937095314464;9963.850542242017;10037.297389182688;10122.645707400206;10398.948005260228;10410.583576656849;10371.58513659445;10648.680539583826;10732.14142868553;10830.891691082988;10871.239013268996 08:33:05 INFO - PROCESS | 8962 | __end_tp_report 08:33:05 INFO - PROCESS | 8962 | __start_cc_report 08:33:05 INFO - PROCESS | 8962 | _x_x_mozilla_cycle_collect,2608 08:33:05 INFO - PROCESS | 8962 | __end_cc_report 08:33:05 INFO - PROCESS | 8962 | __startTimestamp1481214785075__endTimestamp 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | ------- Summary: start ------- 08:33:05 INFO - PROCESS | 8962 | Number of tests: 6 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | [#0] dojo.html Cycles:165 Average:4658.53 Median:4756.26 stddev:479.56 (10.1%) stddev-sans-first:451.62 08:33:05 INFO - PROCESS | 8962 | Values: 2550.5 2570.6 2607.3 2608.9 2619.8 4599.6 4645.2 4681.7 4704.6 4716.6 4575.7 4591.2 4624.5 4685.3 4696.1 4314.9 4318.2 4345.6 4376.6 4435.2 4037.7 4419.2 4437.6 4473.5 4521.8 4299.4 4342.0 4384.5 4453.0 4493.4 4384.8 4402.1 4406.6 4409.3 4412.2 4366.4 4374.3 4374.8 4378.8 4378.8 4743.5 4750.4 4756.3 4758.4 4760.9 4969.5 5027.2 5029.9 5071.2 5091.7 5055.2 5062.0 5067.5 5077.7 5116.6 4731.6 4735.2 4740.3 4742.9 4776.2 5047.7 5058.7 5107.8 5109.3 5130.3 4968.8 4969.9 4970.5 4973.1 5009.9 5049.5 5053.4 5056.1 5057.0 5102.1 4932.7 4954.3 4974.9 4977.7 5017.6 5004.2 5027.9 5033.0 5104.2 5110.6 4387.0 4388.7 4388.8 4389.3 4437.9 3731.8 3795.8 3811.1 3849.2 3861.6 4295.0 4313.8 4318.5 4325.9 4375.4 5046.4 5046.7 5046.9 5052.6 5081.9 4332.7 4335.2 4345.0 4363.2 4380.6 4468.9 4520.3 4522.7 4562.4 4575.0 4580.2 4615.4 4635.8 4636.4 4636.9 5031.5 5035.8 5040.6 5042.2 5054.3 4644.5 4651.7 4659.4 4661.2 4663.4 4964.7 4965.9 4966.9 4967.9 4968.8 4928.4 4941.6 4945.0 4950.4 4973.6 4799.2 4799.4 4855.3 4863.8 4870.7 4900.9 4910.9 4914.2 4916.8 4960.3 4725.4 4768.3 4842.6 4860.5 4901.9 4931.7 4954.0 4961.4 5011.6 5045.1 4876.1 4884.4 4888.7 4890.9 4926.0 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | [#1] ext.html Cycles:180 Average:43220.59 Median:188073.07 stddev:74104.30 (39.4%) stddev-sans-first:74242.95 08:33:05 INFO - PROCESS | 8962 | Values: 557.1 599.4 601.7 603.3 610.1 36078.8 37260.6 37410.0 41111.6 41169.6 37801.2 38010.6 38123.0 38132.2 38135.2 7405.0 7538.0 7712.5 7715.5 7716.6 7318.7 9665.8 9881.9 9883.7 10251.5 9604.2 9642.0 9647.2 9647.6 9653.9 9913.5 9970.2 10015.7 10020.5 10020.5 9901.7 9958.4 9961.6 9965.4 9968.7 36505.8 36596.5 36612.5 36671.3 36797.8 2832.2 2851.2 2905.7 2948.7 3359.9 27570.7 27684.4 27760.4 28180.0 28471.6 3269.4 3288.5 3294.4 3297.6 3330.0 170987.0 171164.0 171646.0 171837.0 171870.0 50587.5 50853.0 50988.0 51009.1 51012.7 53859.5 53981.7 53989.2 54080.2 54138.7 12992.3 13308.2 13312.9 13313.5 13315.3 9061.2 9213.8 9922.7 10063.4 10133.1 15077.7 15763.5 15780.7 15785.4 15822.8 5572.5 5588.2 5595.2 5645.2 5658.9 765.4 858.2 866.5 931.3 948.8 25759.7 26545.7 27030.3 27114.5 27131.7 871.0 969.2 990.5 994.9 997.4 14349.8 14523.7 14529.8 14715.9 14821.1 337214.0 339774.0 340870.0 341308.0 341790.0 47327.8 47438.5 47457.0 47484.0 47563.0 1073.1 1091.9 1095.5 1156.8 1196.9 24579.1 29330.9 30115.4 30157.4 30536.7 43950.3 44400.6 44511.1 44512.1 44557.6 303523.0 305754.0 306007.0 306127.0 307056.0 29767.9 30509.5 34144.8 34356.1 34428.7 39453.6 39661.2 39760.8 40155.6 40597.4 33951.0 34053.1 34107.5 34127.5 34178.3 33728.0 34043.1 34070.1 34383.7 34500.7 32950.0 33674.0 33724.5 33943.0 34382.0 29868.1 30958.5 31022.7 31045.7 31608.0 23435.3 24456.9 24484.5 24551.6 24604.5 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | [#2] jquery.html Cycles:180 Average:22837.80 Median:26628.34 stddev:51676.56 (194.1%) stddev-sans-first:51793.96 08:33:05 INFO - PROCESS | 8962 | Values: 358.2 367.6 376.0 378.7 391.9 15155.8 15913.5 16652.6 16700.1 16719.7 15614.4 16209.9 16434.4 16559.5 16582.4 4742.1 4990.2 4992.9 4993.0 4994.6 3693.6 3877.0 4849.8 5513.7 5766.5 5830.1 5851.7 5857.3 5869.1 5869.1 5615.0 5744.4 5758.7 5773.5 5818.3 5060.2 5081.5 5088.2 5094.1 5102.3 21184.5 21692.7 21724.7 21906.1 22593.3 1901.8 1959.8 2011.5 2122.7 2497.0 13417.4 13724.5 13817.4 14157.7 14323.0 1853.2 1853.7 1858.1 1890.5 1911.0 73668.6 78075.6 78087.6 78136.0 78369.0 15736.8 15763.3 15972.8 16173.4 16303.8 26893.7 26912.2 27091.3 27100.9 27254.5 8033.6 8093.4 8142.4 8181.1 8445.8 6475.5 6534.2 6683.1 6698.1 6709.4 7839.3 7987.8 8124.2 8219.3 8307.3 2571.7 2923.3 3059.5 3162.7 3306.8 742.2 843.3 884.8 886.4 918.1 15294.5 15527.6 15972.4 16523.8 16728.7 782.8 791.6 824.5 828.0 854.0 8505.5 9218.2 9247.7 9290.8 9325.4 271898.0 277290.0 277949.0 323419.0 375943.0 74408.6 77928.6 79887.2 79967.2 80472.6 891.1 899.7 926.2 932.2 935.6 14912.4 15169.6 15699.6 15840.5 15900.5 35289.8 35318.6 36122.0 36324.8 37120.1 47363.5 48406.9 49287.5 50040.5 50716.1 7302.8 7362.7 7428.8 7464.0 7485.3 7270.0 10582.9 11045.9 11180.9 11427.8 8561.0 8895.6 9431.2 10024.6 10201.1 9326.9 9816.0 10016.2 10083.8 10194.9 9955.2 10008.9 10295.5 10460.4 10610.5 7322.4 7482.1 7641.4 7674.1 7781.0 9088.9 9451.3 10299.8 10344.6 10353.5 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | [#3] mootools.html Cycles:180 Average:4547.85 Median:5610.58 stddev:2386.91 (42.5%) stddev-sans-first:2380.86 08:33:05 INFO - PROCESS | 8962 | Values: 1266.2 1267.0 1310.9 1585.8 1591.3 6098.5 6276.5 6634.4 7019.8 7031.7 6546.2 6767.2 6777.8 6937.1 6941.6 2051.4 2061.7 2068.1 2072.1 2081.9 1838.7 1908.1 2046.2 2050.1 2059.8 2024.7 2097.5 2100.6 2101.7 2109.5 2048.9 2065.3 2082.4 2093.6 2094.0 2101.5 2125.2 2145.5 2147.5 2151.9 6888.8 6959.1 6976.2 6985.0 7004.5 4169.6 4275.0 4307.7 4310.7 4311.3 2678.9 2730.0 2804.9 2832.1 2840.3 883.8 890.4 898.7 899.9 907.7 8983.5 8984.5 8988.2 8989.7 8995.6 3900.1 3952.7 4024.2 4024.7 4044.8 7801.8 7865.5 7867.1 7868.8 7874.0 4390.5 4396.1 4413.8 4417.5 4420.4 3820.6 3955.3 4045.1 4046.4 4046.7 3096.3 3110.3 3191.8 3192.6 3208.2 889.7 893.5 976.6 985.3 1001.8 667.8 680.7 745.4 761.1 773.8 4807.2 4846.8 4907.8 4930.6 4974.0 812.5 818.3 841.6 859.1 870.6 3262.0 3387.5 3414.8 3438.7 3510.8 7428.7 8064.4 8119.8 8126.6 8131.3 8094.2 8100.1 8100.1 8103.6 8115.0 6236.6 6413.7 6414.8 6468.6 6474.4 4771.7 4830.2 4834.6 4880.8 4888.0 7352.8 7371.6 7477.2 7503.6 7597.1 7477.8 7546.8 7616.5 7655.7 7667.4 5462.3 5483.1 5520.0 5547.3 5583.5 6336.8 6407.9 6410.7 6414.9 6417.4 5853.8 6044.8 6045.5 6054.7 6134.0 5795.4 5799.4 5855.4 5859.7 5935.1 5637.6 5705.2 5705.3 5706.2 5707.7 4162.0 4243.7 4254.1 4263.2 4448.7 4195.2 4270.4 4303.6 4373.6 4501.3 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | [#4] prototype.html Cycles:180 Average:4069.89 Median:4592.98 stddev:1190.58 (25.9%) stddev-sans-first:1159.52 08:33:05 INFO - PROCESS | 8962 | Values: 284.6 287.8 295.5 297.0 299.1 4688.9 4757.8 4774.4 4796.4 4830.2 4693.6 4696.0 4699.2 4703.8 4731.2 3518.6 3584.0 3616.0 3742.2 3753.8 3672.6 3698.9 3715.8 3717.6 3723.9 3704.3 3721.2 3722.1 3722.9 3727.8 3542.2 3662.3 3725.3 3734.3 3740.5 3231.9 3273.1 3273.4 3281.9 3286.0 4606.8 4607.2 4626.2 4630.5 4638.5 4157.2 4182.3 4198.3 4204.7 4213.2 4749.9 4908.4 4919.9 4921.0 4935.9 3473.8 3474.9 3477.9 3481.8 3483.6 5171.7 5173.9 5183.6 5192.5 5217.4 3344.7 3508.2 3545.5 3550.9 3552.0 3536.8 3542.7 3560.3 3573.4 3590.4 4099.0 4102.8 4105.6 4109.3 4116.9 4955.7 4958.9 4963.3 4975.7 5000.8 1169.2 1209.1 1213.8 1215.1 1219.9 793.9 812.9 819.3 822.3 825.6 4273.6 4282.6 4290.6 4340.8 4381.2 5131.4 5138.6 5152.6 5167.9 5173.8 4454.6 4455.5 4455.9 4465.6 4477.3 2531.3 2620.7 2631.1 2638.8 2641.8 4545.6 4578.5 4582.8 4610.2 4619.3 5029.9 5033.5 5042.8 5046.4 5062.8 4413.9 4559.4 4569.9 4592.0 4602.8 4927.5 4928.0 4930.6 4936.8 4939.3 4867.0 4868.4 4869.9 4871.2 4873.9 4318.0 4548.7 4568.0 4575.4 4593.9 3479.5 3480.4 3488.9 3492.2 3513.2 4906.9 4927.6 4959.2 4980.0 4981.8 4715.7 4757.9 4778.7 4801.1 4813.5 5017.3 5026.6 5027.5 5029.2 5033.4 4949.6 4951.3 4953.3 4967.9 4978.7 4917.9 5028.2 5047.7 5063.4 5076.3 4915.9 4932.7 4936.9 4941.4 4942.7 08:33:05 INFO - PROCESS | 8962 | 08:33:05 INFO - PROCESS | 8962 | [#5] yui.html Cycles:180 Average:15516.38 Median:4293.60 stddev:19637.87 (457.4%) stddev-sans-first:19661.22 08:33:05 INFO - PROCESS | 8962 | Values: 649.8 655.2 689.1 722.2 732.5 12499.3 13684.6 13776.4 13779.7 13792.7 13039.7 13227.7 13235.2 13237.1 13243.9 609.2 624.8 738.9 748.7 758.7 759.8 761.4 761.7 761.7 761.7 816.5 817.8 818.1 818.3 818.3 645.7 666.2 668.3 671.4 806.6 488.5 559.8 574.2 575.1 578.6 13151.9 13171.9 13195.7 13212.6 13226.1 12685.3 12859.8 12868.5 13019.6 13095.7 11581.3 11776.1 11796.2 12138.3 12211.7 4101.9 4124.7 4129.1 4306.3 4313.7 65264.0 65788.7 67103.3 67467.3 67483.0 10195.4 10318.3 10428.0 10432.3 10624.5 19200.3 19233.2 19328.2 19432.8 19906.5 6678.4 6732.0 6751.2 6806.7 7059.0 3667.3 3727.5 3747.0 3763.0 3772.3 2791.2 2883.8 2887.2 2888.6 3208.5 530.6 531.3 539.8 544.6 549.0 601.2 606.5 615.8 620.1 630.3 8054.4 8116.6 8323.0 8551.5 8677.9 544.2 559.7 560.8 622.4 629.6 3899.0 4238.8 4250.5 4260.4 4280.9 54593.7 54694.5 55542.4 68554.0 71271.6 62363.8 63247.0 63315.7 64533.4 66514.0 56711.0 57052.0 57846.7 60126.7 61915.0 8042.7 8043.8 8164.8 8177.9 8545.5 38308.6 38951.0 39664.4 39998.8 41402.2 47493.5 52339.0 52719.5 53359.5 53734.0 10396.5 10440.1 10556.3 10783.3 11123.7 11737.1 12124.9 12167.8 12295.9 12800.9 9828.2 10044.9 10647.1 10668.7 11173.4 11099.2 11171.2 11388.9 11827.3 11895.3 11618.5 12074.5 12081.5 12357.1 12580.9 9963.9 10037.3 10122.6 10398.9 10410.6 10371.6 10648.7 10732.1 10830.9 10871.2 08:33:05 INFO - PROCESS | 8962 | -------- Summary: end -------- 08:33:05 INFO - PROCESS | 8962 | 08:33:06 INFO - TEST-INFO | 8962: exit 0 08:33:06 INFO - TEST-OK | dromaeo_css | took 1123072ms 08:33:06 INFO - TEST-START | kraken 08:33:06 INFO - operating with platform_type : linux_ 08:33:06 INFO - Initialising browser for kraken test... 08:33:06 INFO - TEST-INFO | started process 9266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo23kgM/profile http://localhost:36465/getInfo.html) 08:33:09 INFO - PROCESS | 9266 | __metrics Screen width/height:1600/1200 08:33:09 INFO - PROCESS | 9266 | colorDepth:24 08:33:09 INFO - PROCESS | 9266 | Browser inner width/height: 1024/697 08:33:09 INFO - PROCESS | 9266 | __metrics 08:33:10 INFO - PROCESS | 9266 | 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" 08:33:10 INFO - PROCESS | 9266 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:11 INFO - PROCESS | 9266 | console.error: PushService: 08:33:11 INFO - PROCESS | 9266 | stateChangeProcessEnqueue: Error transitioning state 08:33:11 INFO - PROCESS | 9266 | UnknownError 08:33:11 INFO - TEST-INFO | 9266: exit 0 08:33:11 INFO - Browser initialized. 08:33:11 INFO - Running cycle 1/1 for kraken test... 08:33:11 INFO - TEST-INFO | started process 9351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo23kgM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:24 INFO - PROCESS | 9351 | RSS: Main: 173170688 08:33:24 INFO - PROCESS | 9351 | 08:33:26 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36465/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:27 INFO - PROCESS | 9351 | RSS: Main: 239333376 08:33:27 INFO - PROCESS | 9351 | 08:33:30 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36465/tests/kraken/driver.html?testName=audio-dft) 08:33:31 INFO - PROCESS | 9351 | RSS: Main: 218013696 08:33:31 INFO - PROCESS | 9351 | 08:33:34 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36465/tests/kraken/driver.html?testName=audio-fft) 08:33:34 INFO - PROCESS | 9351 | RSS: Main: 300027904 08:33:34 INFO - PROCESS | 9351 | 08:33:37 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36465/tests/kraken/driver.html?testName=audio-oscillator) 08:33:37 INFO - PROCESS | 9351 | RSS: Main: 210878464 08:33:37 INFO - PROCESS | 9351 | 08:33:39 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:40 INFO - PROCESS | 9351 | RSS: Main: 214016000 08:33:40 INFO - PROCESS | 9351 | 08:33:43 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36465/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:44 INFO - PROCESS | 9351 | RSS: Main: 253370368 08:33:44 INFO - PROCESS | 9351 | 08:33:47 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36465/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:48 INFO - PROCESS | 9351 | RSS: Main: 247439360 08:33:48 INFO - PROCESS | 9351 | 08:33:51 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36465/tests/kraken/driver.html?testName=json-parse-financial) 08:33:51 INFO - PROCESS | 9351 | RSS: Main: 249995264 08:33:51 INFO - PROCESS | 9351 | 08:33:53 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:54 INFO - PROCESS | 9351 | RSS: Main: 212992000 08:33:54 INFO - PROCESS | 9351 | 08:33:56 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:56 INFO - PROCESS | 9351 | RSS: Main: 219607040 08:33:56 INFO - PROCESS | 9351 | 08:33:59 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:59 INFO - PROCESS | 9351 | RSS: Main: 228651008 08:33:59 INFO - PROCESS | 9351 | 08:34:02 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:03 INFO - PROCESS | 9351 | RSS: Main: 237826048 08:34:03 INFO - PROCESS | 9351 | 08:34:06 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:06 INFO - PROCESS | 9351 | RSS: Main: 234291200 08:34:06 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | Cycle 1(1): loaded http://localhost:36465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36465/tests/kraken/driver.html?testName=ai-astar) 08:34:08 INFO - PROCESS | 9351 | RSS: Main: 284991488 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | __start_tp_report 08:34:08 INFO - PROCESS | 9351 | _x_x_mozilla_page_load 08:34:08 INFO - PROCESS | 9351 | _x_x_mozilla_page_load_details 08:34:08 INFO - PROCESS | 9351 | |i|pagename|runs| 08:34:08 INFO - PROCESS | 9351 | |0;ai-astar;108;119;117;117;115;117;118;115;117;117 08:34:08 INFO - PROCESS | 9351 | |1;audio-beat-detection;152;130;133;178;133;129;129;131;167;131 08:34:08 INFO - PROCESS | 9351 | |2;audio-dft;163;161;163;161;161;163;163;163;160;163 08:34:08 INFO - PROCESS | 9351 | |3;audio-fft;76;76;76;104;76;77;78;76;93;76 08:34:08 INFO - PROCESS | 9351 | |4;audio-oscillator;83;84;118;84;84;84;101;84;84;103 08:34:08 INFO - PROCESS | 9351 | |5;imaging-gaussian-blur;117;117;116;117;117;116;118;117;116;117 08:34:08 INFO - PROCESS | 9351 | |6;imaging-darkroom;146;147;149;147;146;146;147;147;147;147 08:34:08 INFO - PROCESS | 9351 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 08:34:08 INFO - PROCESS | 9351 | |8;json-parse-financial;65;64;63;65;66;69;65;66;66;66 08:34:08 INFO - PROCESS | 9351 | |9;json-stringify-tinderbox;65;65;64;65;65;65;66;65;65;65 08:34:08 INFO - PROCESS | 9351 | |10;stanford-crypto-aes;87;94;85;88;86;91;88;85;86;86 08:34:08 INFO - PROCESS | 9351 | |11;stanford-crypto-ccm;145;149;142;139;150;139;139;139;180;136 08:34:08 INFO - PROCESS | 9351 | |12;stanford-crypto-pbkdf2;180;182;181;186;192;182;182;179;178;185 08:34:08 INFO - PROCESS | 9351 | |13;stanford-crypto-sha256-iterative;69;68;69;70;69;70;68;68;69;67 08:34:08 INFO - PROCESS | 9351 | __end_tp_report 08:34:08 INFO - PROCESS | 9351 | __start_cc_report 08:34:08 INFO - PROCESS | 9351 | _x_x_mozilla_cycle_collect,1979 08:34:08 INFO - PROCESS | 9351 | __end_cc_report 08:34:08 INFO - PROCESS | 9351 | __startTimestamp1481214848932__endTimestamp 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | ------- Summary: start ------- 08:34:08 INFO - PROCESS | 9351 | Number of tests: 14 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#0] ai-astar Cycles:10 Average:116.00 Median:117.00 stddev:3.06 (2.6%) stddev-sans-first:1.27 08:34:08 INFO - PROCESS | 9351 | Values: 108.0 119.0 117.0 117.0 115.0 117.0 118.0 115.0 117.0 117.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:133.00 stddev:17.96 (13.5%) stddev-sans-first:18.62 08:34:08 INFO - PROCESS | 9351 | Values: 152.0 130.0 133.0 178.0 133.0 129.0 129.0 131.0 167.0 131.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#2] audio-dft Cycles:10 Average:162.10 Median:163.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 08:34:08 INFO - PROCESS | 9351 | Values: 163.0 161.0 163.0 161.0 161.0 163.0 163.0 163.0 160.0 163.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:9.70 (12.8%) stddev-sans-first:10.14 08:34:08 INFO - PROCESS | 9351 | Values: 76.0 76.0 76.0 104.0 76.0 77.0 78.0 76.0 93.0 76.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:12.16 (14.5%) stddev-sans-first:12.56 08:34:08 INFO - PROCESS | 9351 | Values: 83.0 84.0 118.0 84.0 84.0 84.0 101.0 84.0 84.0 103.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:34:08 INFO - PROCESS | 9351 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 118.0 117.0 116.0 117.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 08:34:08 INFO - PROCESS | 9351 | Values: 146.0 147.0 149.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:34:08 INFO - PROCESS | 9351 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 08:34:08 INFO - PROCESS | 9351 | Values: 65.0 64.0 63.0 65.0 66.0 69.0 65.0 66.0 66.0 66.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 08:34:08 INFO - PROCESS | 9351 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.50 stddev:2.88 (3.3%) stddev-sans-first:3.04 08:34:08 INFO - PROCESS | 9351 | Values: 87.0 94.0 85.0 88.0 86.0 91.0 88.0 85.0 86.0 86.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:143.50 stddev:12.88 (9.0%) stddev-sans-first:13.66 08:34:08 INFO - PROCESS | 9351 | Values: 145.0 149.0 142.0 139.0 150.0 139.0 139.0 139.0 180.0 136.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:182.00 stddev:4.08 (2.2%) stddev-sans-first:4.21 08:34:08 INFO - PROCESS | 9351 | Values: 180.0 182.0 181.0 186.0 192.0 182.0 182.0 179.0 178.0 185.0 08:34:08 INFO - PROCESS | 9351 | 08:34:08 INFO - PROCESS | 9351 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 08:34:08 INFO - PROCESS | 9351 | Values: 69.0 68.0 69.0 70.0 69.0 70.0 68.0 68.0 69.0 67.0 08:34:08 INFO - PROCESS | 9351 | -------- Summary: end -------- 08:34:08 INFO - PROCESS | 9351 | 08:34:10 INFO - TEST-INFO | 9351: exit 0 08:34:10 INFO - TEST-OK | kraken | took 64161ms 08:34:10 INFO - SUITE-END | took 1187s 08:34:10 INFO - Completed test suite (00:19:47) 08:34:10 INFO - javascript benchmark 08:34:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2550.528152291826, 2570.614407838825, 2607.2960300718805, 2608.895644174233, 2619.764221220091, 4599.586037256646, 4645.210314246578, 4681.719096854191, 4704.55306745859, 4716.622670186385, 4575.702579332341, 4591.173588754023, 4624.468186158593, 4685.25035994241, 4696.131215725093, 4314.913701725979, 4318.179545886287, 4345.587169218919, 4376.584224498668, 4435.201663700533, 4037.6971727120435, 4419.226635338819, 4437.622802061828, 4473.530279320673, 4521.819127234907, 4299.441072660566, 4341.978290108561, 4384.517703052662, 4453.020335526211, 4493.415855938723, 4384.846530371454, 4402.097569998175, 4406.5593440656, 4409.338599210112, 4412.205802955466, 4366.432363792718, 4374.256376416017, 4374.78126093694, 4378.78106094694, 4378.846740364103, 4743.454502732161, 4750.429948406213, 4756.262779269185, 4758.428988521399, 4760.857174284777, 4969.527894849984, 5027.1705168647495, 5029.899402011939, 5071.239314102877, 5091.694498330112, 5055.165897626887, 5061.974690126526, 5067.543921047123, 5077.720725360104, 5116.616253780981, 4731.621470282369, 4735.21868891629, 4740.312654665055, 4742.928856067162, 4776.2119250324, 5047.722375269322, 5058.747062646853, 5107.770150343169, 5109.335786347751, 5130.30740849988, 4968.751562421864, 4969.875753106201, 4970.502949705001, 4973.129702302155, 5009.949900501021, 5049.545540901263, 5053.444121146671, 5056.115179843586, 5057.0, 5102.056119617882, 4932.728699921467, 4954.281629163751, 4974.8756281093265, 4977.651564390458, 5017.598592112622, 5004.224345226496, 5027.899442011139, 5033.0, 5104.2088476286235, 5110.591152707849, 4386.956130438654, 4388.670849686287, 4388.846390376385, 4389.253826849444, 4437.911241775147, 3731.7947512887054, 3795.8291876865605, 3811.085339518551, 3849.191669749384, 3861.613838616116, 4294.978525107417, 4313.805878735465, 4318.524962254212, 4325.870223893226, 4375.387445757597, 5046.369203849519, 5046.722430266371, 5046.924296135561, 5052.595792336604, 5081.898362032739, 4332.67504937131, 4335.1979883721615, 4345.0, 4363.192809330284, 4380.561943805657, 4468.888277793016, 4520.321951707205, 4522.706024108423, 4562.429696287964, 4575.016371480147, 4580.175568397721, 4615.353850460871, 4635.814567417266, 4636.397268355227, 4636.933505293734, 5031.496850315086, 5035.773390197523, 5040.647154699136, 5042.168042272984, 5054.2923990642075, 4644.535546445329, 4651.651126165619, 4659.370984916993, 4661.207594708975, 4663.393758811333, 4964.726940018189, 4965.925511117408, 4966.900661986668, 4967.875803104951, 4968.751562421937, 4928.433230178575, 4941.555260026615, 4944.975275123601, 4950.4059512858685, 4973.577245934136, 4799.1601469743355, 4799.448063472745, 4855.320255164351, 4863.805447782049, 4870.683405578626, 4900.901981960412, 4910.9263361050325, 4914.213725803854, 4916.778744956414, 4960.330355401975, 4725.385699858996, 4768.332433459388, 4842.6368022397755, 4860.489648586848, 4901.926471103007, 4931.679440836334, 4954.033963377251, 4961.355023846877, 5011.574016208663, 5045.091883461012, 4876.073546026244, 4884.389451318585, 4888.706677599355, 4890.926636100533, 4926.039422312758], "value": 4627.908774792182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1058451185846, 599.4335353091328, 601.7292218501669, 603.2579926690171, 610.0605068194977, 36078.819605902, 37260.627393726056, 37410.0, 41111.588884111225, 41169.58830411695, 37801.24397512055, 38010.61989380106, 38123.0, 38132.23735525288, 38135.237295254075, 7404.962975185116, 7537.962310188455, 7712.460127791029, 7715.537067775924, 7716.575588342639, 7318.707251709925, 9665.758356041086, 9881.851772223386, 9883.703488895344, 10251.487425628726, 9604.2316614671, 9641.951790241039, 9647.228221742243, 9647.565859536338, 9653.855192172123, 9913.504324783731, 9970.202383809277, 10015.74960625983, 10020.498975051218, 10020.549075291628, 9901.702948911472, 9958.402495850272, 9961.601535938555, 9965.40207587547, 9968.700938971842, 36505.81747091274, 36596.451053234225, 36612.450813237825, 36671.266574668356, 36797.81601092004, 2832.2352964699417, 2851.21591562322, 2905.6513218413716, 2948.6756456789735, 3359.8992030239133, 27570.724292757215, 27684.41079709848, 27760.444791104266, 28180.0, 28471.572926405912, 3269.4278501262183, 3288.52316414121, 3294.4234758917332, 3297.634717402564, 3329.96670033299, 170987.0, 171164.0, 171646.0, 171837.0, 171869.99999999875, 50587.49412505828, 50853.0, 50988.0, 51009.09359049353, 51012.74493627508, 53859.46140538623, 53981.730091349295, 53989.1901621476, 54080.18879716808, 54138.72930635322, 12992.285424301564, 13308.201507909556, 13312.866871331356, 13313.46746130144, 13315.334233288491, 9061.184493395625, 9213.76965575866, 9922.702318930444, 10063.39619622825, 10133.138683211862, 15077.682909759835, 15763.527094187193, 15780.68438631221, 15785.447509337118, 15822.77853267614, 5572.4706152915405, 5588.177970125061, 5595.18869763882, 5645.153227015899, 5658.915116273177, 765.3685709289858, 858.2404571953741, 866.5277423804042, 931.3108299858192, 948.8434408322687, 25759.742402575735, 26545.73454265471, 27030.324241893715, 27114.45771084607, 27131.72868271292, 870.9956450217709, 969.2197780786394, 990.5146478225762, 994.9005099490138, 997.396575072071, 14349.78475322871, 14523.709525809425, 14529.78205326921, 14715.852841471662, 14821.110733356034, 337214.0, 339774.0, 340870.0, 341308.0, 341790.0, 47327.763361183665, 47438.5256147441, 47457.0, 47484.0, 47563.0, 1073.0557109743377, 1091.8525998990035, 1095.5289225633055, 1156.8496095507699, 1196.9341686207167, 24579.13973010936, 29330.853345733136, 30115.397692046474, 30157.396852062397, 30536.739968306887, 43950.34074488821, 44400.555994439645, 44511.10977780491, 44512.10975780531, 44557.55442445534, 303523.0, 305754.0, 306007.0, 306127.0, 307056.0, 29767.851160744056, 30509.54235686422, 34144.829275854456, 34356.14109647279, 34428.65571344355, 39453.605463944994, 39661.2067758649, 39760.80119599384, 40155.59844401519, 40597.39103913503, 33951.0, 34053.148671283416, 34107.48838767371, 34127.488087678204, 34178.31643367069, 33728.0, 34043.14892127716, 34070.081940577154, 34383.65616343805, 34500.654993449745, 32950.0, 33674.0, 33724.49413258852, 33943.0, 34382.0, 29868.10395688133, 30958.53562196614, 31022.689773102884, 31045.68954310428, 31608.0, 23435.296941091794, 24456.871479953195, 24484.51030979406, 24551.631725523774, 24604.45624498461], "value": 17179.247086518997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.1994242867193, 367.6378766914587, 376.0429706397219, 378.72542406755105, 391.91377896862696, 15155.848441515594, 15913.522594322174, 16652.58368540787, 16700.08149551774, 16719.66560668789, 15614.375424982987, 16209.918950405261, 16434.42479513214, 16559.503214903543, 16582.419615313465, 4742.122707299152, 4990.176620857573, 4992.925106123411, 4992.950070499303, 4994.550490455858, 3693.593704692495, 3877.0307423144213, 4849.75751212438, 5513.696746678931, 5766.509846663018, 5830.096335068071, 5851.7074146292725, 5857.26784151981, 5869.1196320551835, 5869.148973398855, 5615.0, 5744.368119506851, 5758.683272420015, 5773.480386765169, 5818.27271591049, 5060.2156665716875, 5081.517255860687, 5088.160453525164, 5094.083065048289, 5102.285680004802, 21184.470388240265, 21692.674609880865, 21724.674129888066, 21906.12375504978, 22593.322200333852, 1901.7717873855088, 1959.7746259180092, 2011.4569066352149, 2122.734658167729, 2496.9750302496923, 13417.396217170251, 13724.519641812589, 13817.447302107903, 14157.716845663132, 14322.959343295128, 1853.2309091726918, 1853.7404763333145, 1858.0895361272878, 1890.546268895469, 1911.0, 73668.63165684191, 78075.6096219521, 78087.60956195183, 78136.0, 78369.0, 15736.763948540782, 15763.290651920692, 15972.840271597368, 16173.353065877232, 16303.83696163047, 26893.731062689512, 26912.192634221006, 27091.322716932234, 27100.864495677397, 27254.45491090167, 8033.598320084089, 8093.392995525359, 8142.389320800964, 8181.140980197112, 8445.788855278668, 6475.4819614430735, 6534.150560427114, 6683.090392120566, 6698.062271282024, 6709.396154346035, 7839.294463498312, 7987.800304992422, 8124.22819832115, 8219.342452603778, 8307.293880020266, 2571.7111770523875, 2923.342247994184, 3059.464593696094, 3162.667919868427, 3306.8015919044933, 742.2392048150689, 843.2832092721261, 884.7832281091174, 886.3883920095113, 918.1048477734289, 15294.464693735888, 15527.611809704622, 15972.440964566184, 16523.82927475263, 16728.749068763977, 782.8121250899743, 791.6041979010495, 824.4640983360863, 827.954462504568, 853.9743807685779, 8505.532195729294, 9218.216451601555, 9247.72256832296, 9290.814183716288, 9325.393849399767, 271898.0, 277290.0, 277949.0, 323419.0, 375943.0, 74408.62795685987, 77928.610356949, 79887.20112798914, 79967.20032799598, 80472.59763701144, 891.0688330694439, 899.7345782993901, 926.249737712455, 932.1983094538691, 935.6070450410843, 14912.403503859725, 15169.620759481102, 15699.607509812346, 15840.49515296045, 15900.52298431049, 35289.82355088208, 35318.64681353154, 36122.0, 36324.818375907955, 37120.07199819918, 47363.52636473591, 48406.930128865715, 49287.50712492829, 50040.49959500358, 50716.10439210682, 7302.780916572511, 7362.705491780269, 7428.814279643052, 7463.962680186564, 7485.251474852471, 7270.001499175538, 10582.894171058191, 11045.944770276097, 11180.944095279472, 11427.828582571101, 8561.0, 8895.555222238732, 9431.198348140211, 10024.649137280161, 10201.132903703268, 9326.906730932604, 9816.0, 10016.198704103508, 10083.848742268725, 10194.949025254826, 9955.153811926068, 10008.899911001088, 10295.53670084863, 10460.424676642553, 10610.469476526298, 7322.3775979042375, 7482.064741907262, 7641.3886889047635, 7674.117476490052, 7780.961095194488, 9088.909110908806, 9451.291153163678, 10299.794004119725, 10344.637937672145, 10353.482325883826], "value": 8714.266780206035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.2022925556898, 1266.9936650316747, 1310.8951283897288, 1585.817630972437, 1591.3395940684625, 6098.4511393974535, 6276.466500347465, 6634.369734875185, 7019.7543085992, 7031.71873125075, 6546.24718157412, 6767.187937447501, 6777.830554236147, 6937.132858392701, 6941.618210998393, 2051.4358551398373, 2061.701053347264, 2068.0693687840458, 2072.1193492765588, 2081.906314215864, 1838.6598479281377, 1908.1222637586727, 2046.1508473983279, 2050.077465140685, 2059.804318589739, 2024.7165396844453, 2097.4861159016064, 2100.6428907085833, 2101.737282839645, 2109.4726318420394, 2048.9180432782673, 2065.3390914907236, 2082.37528741377, 2093.6440805063253, 2093.958120837575, 2101.548167144056, 2125.1605615781677, 2145.5279838435517, 2147.452399638098, 2151.87088774674, 6888.793336199922, 6959.095317608729, 6976.19773726023, 6984.965075174591, 7004.544704594185, 4169.60388763067, 4275.0, 4307.698461107724, 4310.676699247569, 4311.28863737483, 2678.933026674329, 2729.972700272992, 2804.943901121966, 2832.06541841194, 2840.304125489248, 883.8409086364452, 890.4078787606234, 898.6809682562662, 899.9100089991014, 907.6550910653975, 8983.505907175102, 8984.505852178128, 8988.191062804379, 8989.685361012398, 8995.595198216097, 3900.1029763154065, 3952.7430717003303, 4024.195160967818, 4024.657904078186, 4044.757314561136, 7801.843963120819, 7865.488743231786, 7867.134615192324, 7868.803279917934, 7873.976383070164, 4390.473143222834, 4396.142752163298, 4413.7793110344355, 4417.514073451917, 4420.425344705168, 3820.6179382061573, 3955.3078211312904, 4045.069633984141, 4046.393041043808, 4046.656034237064, 3096.334288128018, 3110.2535391506326, 3191.834980232245, 3192.584963954671, 3208.1819136120607, 889.74642226965, 893.4951752259952, 976.5703090640095, 985.3102828020415, 1001.8296889528798, 667.8196886840623, 680.6528670378044, 745.3664385272583, 761.0980987529795, 773.7872085176509, 4807.206810876236, 4846.7818948147415, 4907.754612269372, 4930.556249937451, 4973.950260497421, 812.4800127918137, 818.300353198019, 841.5707988925569, 859.1022381611232, 870.5821205821242, 3261.951070733941, 3387.491876218587, 3414.7951122932704, 3438.6561343865415, 3510.78935263885, 7428.702851885864, 8064.395170362246, 8119.79700507492, 8126.553039582762, 8131.308838748772, 8094.231048050426, 8100.149484304181, 8100.149484304181, 8103.635336409876, 8115.0, 6236.6258024518675, 6413.679316034273, 6414.839629009312, 6468.6442245676935, 6474.352564743582, 4771.66598338113, 4830.154722923404, 4834.6374021947795, 4880.804767809248, 4888.022395520839, 7352.823548232257, 7371.594562299125, 7477.214892436434, 7503.587302698404, 7597.088349398107, 7477.813054673459, 7546.773596792105, 7616.543007419573, 7655.655495502827, 7667.386609071373, 5462.289902312833, 5483.095289277225, 5520.0, 5547.278853748987, 5583.525400341016, 6336.778212762531, 6407.935920640734, 6410.743570257137, 6414.871702566016, 6417.422431981144, 5853.824385268449, 6044.758209671564, 6045.486133678686, 6054.697265136813, 6134.04922237054, 5795.420457954171, 5799.420057994167, 5855.443732845373, 5859.707014649165, 5935.109733540004, 5637.633553818989, 5705.201271821865, 5705.315362156568, 5706.172604972173, 5707.6575405475805, 4162.0, 4243.724157929724, 4254.149170165917, 4263.232618128766, 4448.6663500238255, 4195.223883581547, 4270.444842170498, 4303.634191093792, 4373.6063754260995, 4501.3473046407435], "value": 3734.2968993793033, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.55893365283805, 287.77984841596174, 295.52125556598315, 296.9792114551981, 299.0952369083523, 4688.929666055012, 4757.8096876125, 4774.4270687517455, 4796.3764710587575, 4830.178869592169, 4693.55411235932, 4695.976520117403, 4699.224627936386, 4703.764811759407, 4731.219348807451, 3518.612952575215, 3583.9641603584023, 3616.0, 3742.195427982983, 3753.8498460061633, 3672.6327367263325, 3698.907527311825, 3715.8327875245545, 3717.6058977883295, 3723.8882833514904, 3704.3332200203954, 3721.2371463849845, 3722.143906901414, 3722.9069273268115, 3727.7576957497677, 3542.167590616203, 3662.322470342995, 3725.2549490102087, 3734.3091528067257, 3740.4763333133383, 3231.903042908693, 3273.0508152635707, 3273.3944220319318, 3281.8523166457567, 3285.96714032859, 4606.838760643362, 4607.239805432099, 4626.167289887819, 4630.490646028934, 4638.538860259041, 4157.189348077126, 4182.2890108681295, 4198.328267477189, 4204.684648651363, 4213.199492096492, 4749.905001899942, 4908.43552991407, 4919.901601967977, 4921.0157968406465, 4935.901281974377, 3473.808940508271, 3474.9131271718156, 3477.9392285352956, 3481.8433170507387, 3483.599386070609, 5171.663841850268, 5173.870653233662, 5183.637145399824, 5192.45479224676, 5217.373915130209, 3344.7156991655497, 3508.1755787389943, 3545.5213546170935, 3550.8579656813954, 3551.982240088783, 3536.80547569881, 3542.6634469725336, 3560.2523470071574, 3573.356795776785, 3590.425531914881, 4098.959010409917, 4102.753834769924, 4105.58944105593, 4109.260333140004, 4116.929598304462, 4955.677880937727, 4958.925616115761, 4963.280324353021, 4975.676581022294, 5000.799968001312, 1169.2049406403557, 1209.1354681402838, 1213.8118591618313, 1215.1190386969554, 1219.8597161326384, 793.9004478796908, 812.8902598149174, 819.332244220958, 822.3092602214169, 825.6078362777632, 4273.594008569181, 4282.63597594208, 4290.613844753987, 4340.76125813077, 4381.16757816014, 5131.3579654510195, 5138.588912887035, 5152.639315247971, 5167.870803229949, 5173.767180476888, 4454.554544545519, 4455.532169122195, 4455.910881782346, 4465.620422264144, 4477.306017567283, 2531.3418511187224, 2620.7248238935017, 2631.1317265302405, 2638.828476149044, 2641.7622413982835, 4545.636349092065, 4578.45058592971, 4582.793774280165, 4610.219619911641, 4619.290862380941, 5029.943711820485, 5033.546980771748, 5042.840146766264, 5046.394432668103, 5062.822801202014, 4413.911721765547, 4559.404208527056, 4569.908601828011, 4592.035672508744, 4602.815887364468, 4927.482614325444, 4927.975360123177, 4930.630202734737, 4936.827211047596, 4939.333190019302, 4866.975665121652, 4868.391451068616, 4869.926951095666, 4871.196252618278, 4873.926891096708, 4318.0, 4548.658850586286, 4567.954320456753, 4575.405197324327, 4593.931091033571, 3479.495473156429, 3480.4257297545623, 3488.8778892738633, 3492.231709024011, 3513.209527856212, 4906.8959484115785, 4927.556519913225, 4959.20652695567, 4979.975100124476, 4981.775820088177, 4715.717056976592, 4757.857264282077, 4778.713277203379, 4801.135086255597, 4813.470518243061, 5017.347744793154, 5026.648134630541, 5027.547520723152, 5029.220470827027, 5033.446320904624, 4949.554540091409, 4951.257311403318, 4953.281774142802, 4967.875803104951, 4978.726170060681, 4917.9426423319155, 5028.170351891897, 5047.712833227651, 5063.367079115111, 5076.340075790124, 4915.877103072452, 4932.679375840559, 4936.925946110883, 4941.43173535048, 4942.678725882806], "value": 3689.234131266574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.7563413719854, 655.2431941108022, 689.1385767790263, 722.1514720203759, 732.472619713806, 12499.312537810416, 13684.589462316122, 13776.38006289717, 13779.724405511884, 13792.655183620402, 13039.739205215914, 13227.735445291088, 13235.205887646747, 13237.139585926909, 13243.867561324409, 609.1806520230283, 624.7594676049708, 738.9408847292203, 748.7304570354681, 758.6775620361352, 759.7530802489185, 761.3794757272833, 761.6572542355934, 761.67628757778, 761.6800943603699, 816.5223344343536, 817.8364327134567, 818.1123481023068, 818.2717381530442, 818.304441224957, 645.6674812471581, 666.243813271935, 668.3450218785617, 671.3856821008771, 806.6410447350931, 488.46269103985685, 559.8348487196287, 574.184657785945, 575.0827430248746, 578.5776383240258, 13151.934240328832, 13171.934140329333, 13195.736085278337, 13212.603621891263, 13226.140300880412, 12685.302308373035, 12859.807102893465, 12868.549600764021, 13019.609411717569, 13095.738085238241, 11581.305121692725, 11776.116791240605, 11796.233244839059, 12138.271703697807, 12211.694707632292, 4101.91796164078, 4124.670026397881, 4129.132882094764, 4306.310990241577, 4313.698041137121, 65264.0, 65788.67105664489, 67103.3027688062, 67467.32532674659, 67483.0, 10195.357756382033, 10318.329308594917, 10428.0, 10432.2697411182, 10624.468776561296, 19200.327988520334, 19233.230670773013, 19328.226870925286, 19432.80567194338, 19906.50233744168, 6678.365555272241, 6731.966340168366, 6751.156105486814, 6806.727730890808, 7059.0, 3667.339878821784, 3727.4781530585738, 3747.0, 3762.981185094057, 3772.2644084403278, 2791.204506715617, 2883.783716221292, 2887.1627228103616, 2888.62447881774, 3208.502682084281, 530.6073505605901, 531.3384835879277, 539.7840863654569, 544.6187668631974, 549.0391814324931, 601.2064075420403, 606.4966078155121, 615.8183335915916, 620.0853740732474, 630.2625927664643, 8054.436189466681, 8116.634751436081, 8323.0, 8551.486910785372, 8677.913220867711, 544.2081771023152, 559.739721029715, 560.7560711090689, 622.4179844992132, 629.625372903131, 3898.9610103899167, 4238.809253583535, 4250.468691413574, 4260.403543503912, 4280.89297767552, 54593.727031364586, 54694.453055469734, 55542.44457555454, 68554.0, 71271.6436417825, 62363.75272494616, 63247.0, 63315.68342158352, 64533.35466645368, 66514.0, 56711.0, 57052.0, 57846.71076644674, 60126.699366502886, 61915.0, 8042.67829286822, 8043.798905027421, 8164.83670326602, 8177.918220817954, 8545.52999585004, 38308.61691383162, 38951.0, 39664.40503392509, 39998.80000600095, 41402.1719565613, 47493.52506474891, 52339.0, 52719.472805271456, 53359.46640533545, 53734.0, 10396.532156053147, 10440.112590429899, 10556.313839600401, 10783.299085559414, 11123.666290011313, 11737.119716021161, 12124.939375303067, 12167.817482737943, 12295.938520307342, 12800.871991279968, 9828.213742900694, 10044.899551004397, 10647.094996925038, 10668.733281668021, 11173.385463799568, 11099.223054386115, 11171.21801473889, 11388.886111138783, 11827.349495777815, 11895.286282823059, 11618.535258589562, 12074.517019319128, 12081.516739330329, 12357.073219508753, 12580.937095314464, 9963.850542242017, 10037.297389182688, 10122.645707400206, 10398.948005260228, 10410.583576656849, 10371.58513659445, 10648.680539583826, 10732.14142868553, 10830.891691082988, 10871.239013268996], "value": 6382.310141063106, "unit": "score"}], "name": "dromaeo_css", "value": 6272.87147969165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 117.0, 117.0, 115.0, 117.0, 118.0, 115.0, 117.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 133.0, 178.0, 133.0, 129.0, 129.0, 131.0, 167.0, 131.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 161.0, 163.0, 163.0, 163.0, 160.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 104.0, 76.0, 77.0, 78.0, 76.0, 93.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 118.0, 84.0, 84.0, 84.0, 101.0, 84.0, 84.0, 103.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 149.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 65.0, 66.0, 69.0, 65.0, 66.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 85.0, 88.0, 86.0, 91.0, 88.0, 85.0, 86.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 149.0, 142.0, 139.0, 150.0, 139.0, 139.0, 139.0, 180.0, 136.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 182.0, 181.0, 186.0, 192.0, 182.0, 182.0, 179.0, 178.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 70.0, 69.0, 70.0, 68.0, 68.0, 69.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1565.3, "alertThreshold": 2.0}]} 08:34:10 INFO - Return code: 0 08:34:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:10 INFO - # TBPL SUCCESS # 08:34:10 INFO - Running post-action listener: _resource_record_post_action 08:34:10 INFO - [mozharness: 2016-12-08 16:34:10.752564Z] Finished run-tests step (success) 08:34:10 INFO - Running post-run listener: _resource_record_post_run 08:34:10 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393912320; Read time: 16; Write time: 278960 08:34:10 INFO - TinderboxPrint: CPU usage
13.1% 08:34:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:34:10 INFO - TinderboxPrint: I/O write bytes / time
393,912,320 / 278,960 08:34:10 INFO - TinderboxPrint: CPU idle
8,348.8 (86.9%) 08:34:10 INFO - TinderboxPrint: CPU user
1,208.2 (12.6%) 08:34:10 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99868672; Read time: 0; Write time: 100448 08:34:10 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 294043648; Read time: 0; Write time: 178512 08:34:11 INFO - Running post-run listener: _upload_blobber_files 08:34:11 INFO - Blob upload gear active. 08:34:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:11 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 08:34:11 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:11 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:11 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:12 INFO - (blobuploader) - INFO - Done attempting. 08:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:13 INFO - (blobuploader) - INFO - Done attempting. 08:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:16 INFO - (blobuploader) - INFO - Done attempting. 08:34:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:16 INFO - Return code: 0 08:34:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5befb160ef4ee219d5df356342f8b25eaa31be166061ff732d94295a243c8ab04a34bf03370d1436b4f178b5b15cbe9933f4e1968fd61fd163fc9372641a26f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3f88a1d0a266a7fb3fa6e048a003595edaf89404d25cd52bd624998fda7c809db1ed286d0a5c9b7cae41f2ff873d90e43a61c367b0709c1aa142c3b430a6cbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971f29225f53c934798c97a963dda515539c9c214b8d49ee799468b77a3db86b73b4632455cdcfa8b32e6c0a6be2e6dba546b6af9efc4b6692961095f9eacf0a"} 08:34:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:16 INFO - Contents: 08:34:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5befb160ef4ee219d5df356342f8b25eaa31be166061ff732d94295a243c8ab04a34bf03370d1436b4f178b5b15cbe9933f4e1968fd61fd163fc9372641a26f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3f88a1d0a266a7fb3fa6e048a003595edaf89404d25cd52bd624998fda7c809db1ed286d0a5c9b7cae41f2ff873d90e43a61c367b0709c1aa142c3b430a6cbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971f29225f53c934798c97a963dda515539c9c214b8d49ee799468b77a3db86b73b4632455cdcfa8b32e6c0a6be2e6dba546b6af9efc4b6692961095f9eacf0a"} 08:34:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:16 INFO - Copying logs to upload dir... 08:34:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.703371 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-08 08:34:16.406262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 08:34:16.410280) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5befb160ef4ee219d5df356342f8b25eaa31be166061ff732d94295a243c8ab04a34bf03370d1436b4f178b5b15cbe9933f4e1968fd61fd163fc9372641a26f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3f88a1d0a266a7fb3fa6e048a003595edaf89404d25cd52bd624998fda7c809db1ed286d0a5c9b7cae41f2ff873d90e43a61c367b0709c1aa142c3b430a6cbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971f29225f53c934798c97a963dda515539c9c214b8d49ee799468b77a3db86b73b4632455cdcfa8b32e6c0a6be2e6dba546b6af9efc4b6692961095f9eacf0a"} build_url:https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/XPuz0M2aQIyUlyjbLWseAQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5befb160ef4ee219d5df356342f8b25eaa31be166061ff732d94295a243c8ab04a34bf03370d1436b4f178b5b15cbe9933f4e1968fd61fd163fc9372641a26f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3f88a1d0a266a7fb3fa6e048a003595edaf89404d25cd52bd624998fda7c809db1ed286d0a5c9b7cae41f2ff873d90e43a61c367b0709c1aa142c3b430a6cbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971f29225f53c934798c97a963dda515539c9c214b8d49ee799468b77a3db86b73b4632455cdcfa8b32e6c0a6be2e6dba546b6af9efc4b6692961095f9eacf0a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 08:34:16.439379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:34:16.440139) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1481213607.492247-528054223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 08:34:16.523107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 08:34:16.523875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 08:34:16.524621) ========= ========= Total master_lag: 0.21 =========