builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1470490443.87 results: success (0) buildid: 20160806023103 builduid: ac55196d6b4a407281d8aba8ab10c2c9 revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:03.865861) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:03.867099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:03.867889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:03.884483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:03.884854) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 06:34:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.0M=0s 2016-08-06 06:34:04 (88.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:04.019713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:04.020477) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:04.071846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 06:34:04.072770) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --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=9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 06:34:04,259 truncating revision to first 12 chars 2016-08-06 06:34:04,259 Setting DEBUG logging. 2016-08-06 06:34:04,259 attempt 1/10 2016-08-06 06:34:04,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/115ec609a6bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 06:34:05,274 unpacking tar archive at: fx-team-115ec609a6bf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 06:34:05.457608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:05.458421) ========= script_repo_revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:05.459427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:05.459994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 06:34:05.473545) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-06 06:34:05.474268) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:34:05 INFO - MultiFileLogger online at 20160806 06:34:05 in /builds/slave/test 06:34:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:34:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:34:05 INFO - {'append_to_log': False, 06:34:05 INFO - 'base_work_dir': '/builds/slave/test', 06:34:05 INFO - 'blob_upload_branch': 'Fx-Team', 06:34:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:34:05 INFO - 'branch': 'Fx-Team', 06:34:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:34:05 INFO - 'config_files': ('talos/linux_config.py',), 06:34:05 INFO - 'default_actions': ('clobber', 06:34:05 INFO - 'read-buildbot-config', 06:34:05 INFO - 'download-and-extract', 06:34:05 INFO - 'populate-webroot', 06:34:05 INFO - 'create-virtualenv', 06:34:05 INFO - 'install', 06:34:05 INFO - 'run-tests'), 06:34:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:34:05 INFO - 'download_minidump_stackwalk': True, 06:34:05 INFO - 'download_symbols': 'ondemand', 06:34:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:34:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:34:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:34:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:34:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:34:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:34:05 INFO - 'installer_path': 'installer.exe', 06:34:05 INFO - 'log_level': 'info', 06:34:05 INFO - 'log_name': 'talos', 06:34:05 INFO - 'log_to_console': True, 06:34:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:34:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:34:05 INFO - 'opt_config_files': (), 06:34:05 INFO - 'pip_index': False, 06:34:05 INFO - 'sps_profile': False, 06:34:05 INFO - 'sps_profile_interval': 0, 06:34:05 INFO - 'suite': 'dromaeojs-e10s', 06:34:05 INFO - 'system_bits': '32', 06:34:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:34:05 INFO - 'title': 'talos-linux64-ix-040', 06:34:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:34:05 INFO - 'use_talos_json': True, 06:34:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:34:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:34:05 INFO - 'work_dir': 'build'} 06:34:05 INFO - [mozharness: 2016-08-06 13:34:05.752865Z] Running clobber step. 06:34:05 INFO - Running pre-action listener: _resource_record_pre_action 06:34:05 INFO - Running main action method: clobber 06:34:05 INFO - rmtree: /builds/slave/test/build 06:34:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:34:06 INFO - Running post-action listener: _resource_record_post_action 06:34:06 INFO - [mozharness: 2016-08-06 13:34:06.208590Z] Finished clobber step (success) 06:34:06 INFO - [mozharness: 2016-08-06 13:34:06.208692Z] Running read-buildbot-config step. 06:34:06 INFO - Running pre-action listener: _resource_record_pre_action 06:34:06 INFO - Running main action method: read_buildbot_config 06:34:06 INFO - Using buildbot properties: 06:34:06 INFO - { 06:34:06 INFO - "project": "", 06:34:06 INFO - "product": "firefox", 06:34:06 INFO - "script_repo_revision": "production", 06:34:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:34:06 INFO - "repository": "", 06:34:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:34:06 INFO - "buildid": "20160806023103", 06:34:06 INFO - "pgo_build": "True", 06:34:06 INFO - "basedir": "/builds/slave/test", 06:34:06 INFO - "buildnumber": 649, 06:34:06 INFO - "slavename": "talos-linux64-ix-040", 06:34:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:34:06 INFO - "platform": "ubuntu64_hw", 06:34:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:34:06 INFO - "branch": "fx-team", 06:34:06 INFO - "repo_path": "integration/fx-team", 06:34:06 INFO - "revision": "115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1", 06:34:06 INFO - "stage_platform": "linux64-pgo", 06:34:06 INFO - "builduid": "ac55196d6b4a407281d8aba8ab10c2c9", 06:34:06 INFO - "slavebuilddir": "test" 06:34:06 INFO - } 06:34:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:34:06 INFO - Running post-action listener: _resource_record_post_action 06:34:06 INFO - [mozharness: 2016-08-06 13:34:06.211107Z] Finished read-buildbot-config step (success) 06:34:06 INFO - [mozharness: 2016-08-06 13:34:06.211195Z] Running download-and-extract step. 06:34:06 INFO - Running pre-action listener: _resource_record_pre_action 06:34:06 INFO - Running main action method: download_and_extract 06:34:06 INFO - mkdir: /builds/slave/test/build/tests 06:34: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')]} 06:34:06 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:34:06 INFO - Downloaded 1361 bytes. 06:34:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:34:06 INFO - Using the following test package requirements: 06:34:06 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:34:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:34:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:34:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'jsshell-linux-x86_64.zip'], 06:34:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:34:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:34:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:34:06 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:34:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:34:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:34:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:34: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')]} 06:34:06 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:34:07 INFO - Downloaded 21824821 bytes. 06:34:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:34:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:34:08 INFO - Return code: 0 06:34:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:08 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:34:09 INFO - Downloaded 21824821 bytes. 06:34:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:34:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:34:11 INFO - Return code: 0 06:34:11 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')]} 06:34:11 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:34:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:34:12 INFO - Downloaded 14413723 bytes. 06:34:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:34:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:34:12 INFO - Return code: 0 06:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:12 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:34:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:34:13 INFO - Downloaded 59971237 bytes. 06:34:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:34:13 INFO - mkdir: /builds/slave/test/properties 06:34:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:34:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:34:13 INFO - Contents: 06:34:13 INFO - build_url:https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:34:14 INFO - Running post-action listener: _resource_record_post_action 06:34:14 INFO - Running post-action listener: set_extra_try_arguments 06:34:14 INFO - [mozharness: 2016-08-06 13:34:14.311611Z] Finished download-and-extract step (success) 06:34:14 INFO - [mozharness: 2016-08-06 13:34:14.311842Z] Running populate-webroot step. 06:34:14 INFO - Running pre-action listener: _resource_record_pre_action 06:34:14 INFO - Running main action method: populate_webroot 06:34:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:34:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:34:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:34:14 INFO - '--tppagecycles', 06:34:14 INFO - '7'], 06:34:14 INFO - 'tests': ['tsvgm']}}, 06:34:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:34:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:34:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:34:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:34:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['damp', 'tps']}, 06:34:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'tests': ['damp', 'tps']}, 06:34:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['dromaeo_dom']}, 06:34:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:34:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['basic_compositor_video']}, 06:34:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:34:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['a11yr', 06:34:14 INFO - 'ts_paint', 06:34:14 INFO - 'tpaint', 06:34:14 INFO - 'sessionrestore', 06:34:14 INFO - 'sessionrestore_no_auto_restore', 06:34:14 INFO - 'tabpaint']}, 06:34:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:34:14 INFO - 'ts_paint', 06:34:14 INFO - 'tpaint', 06:34:14 INFO - 'sessionrestore', 06:34:14 INFO - 'sessionrestore_no_auto_restore', 06:34:14 INFO - 'tabpaint']}, 06:34:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:34:14 INFO - 'ts_paint', 06:34:14 INFO - 'tpaint', 06:34:14 INFO - 'sessionrestore', 06:34:14 INFO - 'sessionrestore_no_auto_restore', 06:34:14 INFO - 'tabpaint']}, 06:34:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:34:14 INFO - 'ts_paint', 06:34:14 INFO - 'tpaint', 06:34:14 INFO - 'sessionrestore', 06:34:14 INFO - 'sessionrestore_no_auto_restore', 06:34:14 INFO - 'tabpaint']}, 06:34:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['a11yr', 06:34:14 INFO - 'ts_paint', 06:34:14 INFO - 'tpaint', 06:34:14 INFO - 'sessionrestore', 06:34:14 INFO - 'sessionrestore_no_auto_restore', 06:34:14 INFO - 'tabpaint']}, 06:34:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['a11yr', 06:34:14 INFO - 'ts_paint', 06:34:14 INFO - 'tpaint', 06:34:14 INFO - 'sessionrestore', 06:34:14 INFO - 'sessionrestore_no_auto_restore', 06:34:14 INFO - 'tabpaint']}, 06:34:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['tsvgx', 06:34:14 INFO - 'tsvgr_opacity', 06:34:14 INFO - 'tart', 06:34:14 INFO - 'tscrollx', 06:34:14 INFO - 'cart']}, 06:34:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:34:14 INFO - 'tsvgr_opacity', 06:34:14 INFO - 'tart', 06:34:14 INFO - 'tscrollx', 06:34:14 INFO - 'cart']}, 06:34:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'talos_options': ['--disable-e10s'], 06:34:14 INFO - 'tests': ['tp5o']}, 06:34:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'tests': ['tp5o']}, 06:34:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'talos_options': ['--disable-e10s', 06:34:14 INFO - '--xperf_path', 06:34:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:14 INFO - 'tests': ['tp5n']}, 06:34:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:14 INFO - 'talos_options': ['--xperf_path', 06:34:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:14 INFO - 'tests': ['tp5n']}}, 06:34:14 INFO - 'talos.zip': {'path': '', 06:34:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:34:14 INFO - Running post-action listener: _resource_record_post_action 06:34:14 INFO - [mozharness: 2016-08-06 13:34:14.327961Z] Finished populate-webroot step (success) 06:34:14 INFO - [mozharness: 2016-08-06 13:34:14.328050Z] Running create-virtualenv step. 06:34:14 INFO - Running pre-action listener: _resource_record_pre_action 06:34:14 INFO - Running main action method: create_virtualenv 06:34:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:34:14 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 06:34:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:34:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:34:14 INFO - Using real prefix '/usr' 06:34:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:34:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:34:16 INFO - Installing pip.................done. 06:34:16 INFO - Return code: 0 06:34:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:34:16 INFO - Using env: {'DISPLAY': ':0', 06:34:16 INFO - 'HOME': '/home/cltbld', 06:34:16 INFO - 'LANG': 'en_US.UTF-8', 06:34:16 INFO - 'LANGUAGE': 'en_US:en', 06:34:16 INFO - 'LOGNAME': 'cltbld', 06:34:16 INFO - 'MAIL': '/var/mail/cltbld', 06:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:16 INFO - 'MOZ_NO_REMOTE': '1', 06:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:16 INFO - 'NO_EM_RESTART': '1', 06:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:16 INFO - 'PWD': '/builds/slave/test', 06:34:16 INFO - 'SHELL': '/bin/bash', 06:34:16 INFO - 'SHLVL': '1', 06:34:16 INFO - 'TERM': 'linux', 06:34:16 INFO - 'TMOUT': '86400', 06:34:16 INFO - 'USER': 'cltbld', 06:34:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:16 INFO - '_': '/tools/buildbot/bin/python'} 06:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:17 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 06:34:17 INFO - Cleaning up... 06:34:17 INFO - Return code: 0 06:34:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:34:17 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')]} 06:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:17 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')]} 06:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:17 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:17 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 06:34:17 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 06:34:17 INFO - Using env: {'DISPLAY': ':0', 06:34:17 INFO - 'HOME': '/home/cltbld', 06:34:17 INFO - 'LANG': 'en_US.UTF-8', 06:34:17 INFO - 'LANGUAGE': 'en_US:en', 06:34:17 INFO - 'LOGNAME': 'cltbld', 06:34:17 INFO - 'MAIL': '/var/mail/cltbld', 06:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:17 INFO - 'MOZ_NO_REMOTE': '1', 06:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:17 INFO - 'NO_EM_RESTART': '1', 06:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:17 INFO - 'PWD': '/builds/slave/test', 06:34:17 INFO - 'SHELL': '/bin/bash', 06:34:17 INFO - 'SHLVL': '1', 06:34:17 INFO - 'TERM': 'linux', 06:34:17 INFO - 'TMOUT': '86400', 06:34:17 INFO - 'USER': 'cltbld', 06:34:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:17 INFO - '_': '/tools/buildbot/bin/python'} 06:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:17 INFO - Downloading/unpacking psutil>=3.1.1 06:34:17 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 06:34:17 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 06:34:17 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 06:34:17 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 06:34:17 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 06:34:17 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 06:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:34:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:19 INFO - Installing collected packages: psutil 06:34:19 INFO - Running setup.py install for psutil 06:34:19 INFO - building 'psutil._psutil_linux' extension 06:34:19 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 06:34:19 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 06:34:19 INFO - building 'psutil._psutil_posix' extension 06:34:19 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 06:34:19 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 06:34:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:19 INFO - Successfully installed psutil 06:34:19 INFO - Cleaning up... 06:34:19 INFO - Return code: 0 06:34:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:34:19 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')]} 06:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:19 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')]} 06:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:19 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:19 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 06:34:19 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 06:34:19 INFO - Using env: {'DISPLAY': ':0', 06:34:19 INFO - 'HOME': '/home/cltbld', 06:34:19 INFO - 'LANG': 'en_US.UTF-8', 06:34:19 INFO - 'LANGUAGE': 'en_US:en', 06:34:19 INFO - 'LOGNAME': 'cltbld', 06:34:19 INFO - 'MAIL': '/var/mail/cltbld', 06:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:19 INFO - 'MOZ_NO_REMOTE': '1', 06:34:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:19 INFO - 'NO_EM_RESTART': '1', 06:34:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:19 INFO - 'PWD': '/builds/slave/test', 06:34:19 INFO - 'SHELL': '/bin/bash', 06:34:19 INFO - 'SHLVL': '1', 06:34:19 INFO - 'TERM': 'linux', 06:34:19 INFO - 'TMOUT': '86400', 06:34:19 INFO - 'USER': 'cltbld', 06:34:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:19 INFO - '_': '/tools/buildbot/bin/python'} 06:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:34:20 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 06:34:20 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 06:34:20 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 06:34:20 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 06:34:20 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 06:34:20 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 06:34:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:34:22 INFO - Installing collected packages: mozsystemmonitor 06:34:22 INFO - Running setup.py install for mozsystemmonitor 06:34:22 INFO - Successfully installed mozsystemmonitor 06:34:22 INFO - Cleaning up... 06:34:22 INFO - Return code: 0 06:34:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:34: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')]} 06:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34: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')]} 06:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:22 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:22 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 06:34:22 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 06:34:22 INFO - Using env: {'DISPLAY': ':0', 06:34:22 INFO - 'HOME': '/home/cltbld', 06:34:22 INFO - 'LANG': 'en_US.UTF-8', 06:34:22 INFO - 'LANGUAGE': 'en_US:en', 06:34:22 INFO - 'LOGNAME': 'cltbld', 06:34:22 INFO - 'MAIL': '/var/mail/cltbld', 06:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:22 INFO - 'MOZ_NO_REMOTE': '1', 06:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:22 INFO - 'NO_EM_RESTART': '1', 06:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:22 INFO - 'PWD': '/builds/slave/test', 06:34:22 INFO - 'SHELL': '/bin/bash', 06:34:22 INFO - 'SHLVL': '1', 06:34:22 INFO - 'TERM': 'linux', 06:34:22 INFO - 'TMOUT': '86400', 06:34:22 INFO - 'USER': 'cltbld', 06:34:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:22 INFO - '_': '/tools/buildbot/bin/python'} 06:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:34:22 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 06:34:22 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 06:34:22 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 06:34:22 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 06:34:22 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 06:34:22 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 06:34:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:34:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:34:24 INFO - warning: no files found matching '*.txt' 06:34:24 INFO - no previously-included directories found matching 'build' 06:34:24 INFO - no previously-included directories found matching 'dist' 06:34:24 INFO - no previously-included directories found matching '.git*' 06:34:24 INFO - Installing collected packages: jsonschema, functools32 06:34:24 INFO - Running setup.py install for functools32 06:34:24 INFO - warning: no files found matching '*.txt' 06:34:24 INFO - no previously-included directories found matching 'build' 06:34:24 INFO - no previously-included directories found matching 'dist' 06:34:24 INFO - no previously-included directories found matching '.git*' 06:34:24 INFO - Successfully installed jsonschema functools32 06:34:24 INFO - Cleaning up... 06:34:24 INFO - Return code: 0 06:34:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:34:24 INFO - Using env: {'DISPLAY': ':0', 06:34:24 INFO - 'HOME': '/home/cltbld', 06:34:24 INFO - 'LANG': 'en_US.UTF-8', 06:34:24 INFO - 'LANGUAGE': 'en_US:en', 06:34:24 INFO - 'LOGNAME': 'cltbld', 06:34:24 INFO - 'MAIL': '/var/mail/cltbld', 06:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:24 INFO - 'MOZ_NO_REMOTE': '1', 06:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:24 INFO - 'NO_EM_RESTART': '1', 06:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:24 INFO - 'PWD': '/builds/slave/test', 06:34:24 INFO - 'SHELL': '/bin/bash', 06:34:24 INFO - 'SHLVL': '1', 06:34:24 INFO - 'TERM': 'linux', 06:34:24 INFO - 'TMOUT': '86400', 06:34:24 INFO - 'USER': 'cltbld', 06:34:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:24 INFO - '_': '/tools/buildbot/bin/python'} 06:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:34:24 INFO - Cleaning up... 06:34:24 INFO - Return code: 0 06:34:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:34:24 INFO - Using env: {'DISPLAY': ':0', 06:34:24 INFO - 'HOME': '/home/cltbld', 06:34:24 INFO - 'LANG': 'en_US.UTF-8', 06:34:24 INFO - 'LANGUAGE': 'en_US:en', 06:34:24 INFO - 'LOGNAME': 'cltbld', 06:34:24 INFO - 'MAIL': '/var/mail/cltbld', 06:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:24 INFO - 'MOZ_NO_REMOTE': '1', 06:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:24 INFO - 'NO_EM_RESTART': '1', 06:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:24 INFO - 'PWD': '/builds/slave/test', 06:34:24 INFO - 'SHELL': '/bin/bash', 06:34:24 INFO - 'SHLVL': '1', 06:34:24 INFO - 'TERM': 'linux', 06:34:24 INFO - 'TMOUT': '86400', 06:34:24 INFO - 'USER': 'cltbld', 06:34:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:24 INFO - '_': '/tools/buildbot/bin/python'} 06:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:34:25 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 06:34:25 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 06:34:25 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 06:34:25 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 06:34:25 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 06:34:25 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 06:34:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:34:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:34:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:27 INFO - Downloading docopt-0.6.1.tar.gz 06:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:34:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:34:27 INFO - Running setup.py install for blobuploader 06:34:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:34:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:34:27 INFO - Running setup.py install for requests 06:34:28 INFO - Running setup.py install for docopt 06:34:28 INFO - Successfully installed blobuploader requests docopt 06:34:28 INFO - Cleaning up... 06:34:28 INFO - Return code: 0 06:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:28 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')]} 06:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:28 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')]} 06:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:28 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:28 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 06:34:28 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 06:34:28 INFO - Using env: {'DISPLAY': ':0', 06:34:28 INFO - 'HOME': '/home/cltbld', 06:34:28 INFO - 'LANG': 'en_US.UTF-8', 06:34:28 INFO - 'LANGUAGE': 'en_US:en', 06:34:28 INFO - 'LOGNAME': 'cltbld', 06:34:28 INFO - 'MAIL': '/var/mail/cltbld', 06:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:28 INFO - 'MOZ_NO_REMOTE': '1', 06:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:28 INFO - 'NO_EM_RESTART': '1', 06:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:28 INFO - 'PWD': '/builds/slave/test', 06:34:28 INFO - 'SHELL': '/bin/bash', 06:34:28 INFO - 'SHLVL': '1', 06:34:28 INFO - 'TERM': 'linux', 06:34:28 INFO - 'TMOUT': '86400', 06:34:28 INFO - 'USER': 'cltbld', 06:34:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:28 INFO - '_': '/tools/buildbot/bin/python'} 06:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:28 INFO - Running setup.py (path:/tmp/pip-rwy7Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:28 INFO - Running setup.py (path:/tmp/pip-JjfQTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:28 INFO - Running setup.py (path:/tmp/pip-Q9SoE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:28 INFO - Running setup.py (path:/tmp/pip-kVxh7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:28 INFO - Running setup.py (path:/tmp/pip-b6naiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:28 INFO - Running setup.py (path:/tmp/pip-uytdX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:29 INFO - Running setup.py (path:/tmp/pip-v0qGqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:29 INFO - Running setup.py (path:/tmp/pip-Onjr2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:29 INFO - Running setup.py (path:/tmp/pip-XGlovP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:29 INFO - Running setup.py (path:/tmp/pip-PS98Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:29 INFO - Running setup.py (path:/tmp/pip-jzKxIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:29 INFO - Running setup.py (path:/tmp/pip-K4jMho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:29 INFO - Running setup.py (path:/tmp/pip-lTDvMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:29 INFO - Running setup.py (path:/tmp/pip-sJhIdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:29 INFO - Running setup.py (path:/tmp/pip-WEz4kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:29 INFO - Running setup.py (path:/tmp/pip-KGmqTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:29 INFO - Running setup.py (path:/tmp/pip-jBUcmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:34:29 INFO - Running setup.py install for manifestparser 06:34:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:34:29 INFO - Running setup.py install for mozcrash 06:34:30 INFO - Running setup.py install for mozdebug 06:34:30 INFO - Running setup.py install for mozdevice 06:34:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Running setup.py install for mozfile 06:34:30 INFO - Running setup.py install for mozhttpd 06:34:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Running setup.py install for mozinfo 06:34:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Running setup.py install for mozInstall 06:34:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Running setup.py install for mozleak 06:34:30 INFO - Running setup.py install for mozlog 06:34:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Running setup.py install for moznetwork 06:34:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:34:30 INFO - Running setup.py install for mozprocess 06:34:31 INFO - Running setup.py install for mozprofile 06:34:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:34:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:34:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:34:31 INFO - Running setup.py install for mozrunner 06:34:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:34:31 INFO - Running setup.py install for mozscreenshot 06:34:31 INFO - Running setup.py install for moztest 06:34:31 INFO - Running setup.py install for mozversion 06:34:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:34:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:34:31 INFO - Cleaning up... 06:34:31 INFO - Return code: 0 06:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:31 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')]} 06:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:31 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')]} 06:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:31 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:31 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 06:34:31 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 06:34:31 INFO - Using env: {'DISPLAY': ':0', 06:34:31 INFO - 'HOME': '/home/cltbld', 06:34:31 INFO - 'LANG': 'en_US.UTF-8', 06:34:31 INFO - 'LANGUAGE': 'en_US:en', 06:34:31 INFO - 'LOGNAME': 'cltbld', 06:34:31 INFO - 'MAIL': '/var/mail/cltbld', 06:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:31 INFO - 'MOZ_NO_REMOTE': '1', 06:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:31 INFO - 'NO_EM_RESTART': '1', 06:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:31 INFO - 'PWD': '/builds/slave/test', 06:34:31 INFO - 'SHELL': '/bin/bash', 06:34:31 INFO - 'SHLVL': '1', 06:34:31 INFO - 'TERM': 'linux', 06:34:31 INFO - 'TMOUT': '86400', 06:34:31 INFO - 'USER': 'cltbld', 06:34:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:31 INFO - '_': '/tools/buildbot/bin/python'} 06:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:31 INFO - Running setup.py (path:/tmp/pip-vZSAM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:31 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)) 06:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:31 INFO - Running setup.py (path:/tmp/pip-UcADvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:32 INFO - Running setup.py (path:/tmp/pip-WmbKL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:32 INFO - Running setup.py (path:/tmp/pip-Lv6RF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:32 INFO - Running setup.py (path:/tmp/pip-H2pB2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:32 INFO - Running setup.py (path:/tmp/pip-QopwTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:32 INFO - Running setup.py (path:/tmp/pip-9V06x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:32 INFO - Running setup.py (path:/tmp/pip-eemv0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:32 INFO - Running setup.py (path:/tmp/pip-4KNyv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:32 INFO - Running setup.py (path:/tmp/pip-s5cZg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:32 INFO - Running setup.py (path:/tmp/pip-aebt2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:32 INFO - Running setup.py (path:/tmp/pip-AsNrzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:32 INFO - Running setup.py (path:/tmp/pip-umEMyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:32 INFO - Running setup.py (path:/tmp/pip-Zf3wUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:32 INFO - Running setup.py (path:/tmp/pip-15TA8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:32 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)) 06:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:32 INFO - Running setup.py (path:/tmp/pip-bA1wYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:33 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)) 06:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:33 INFO - Running setup.py (path:/tmp/pip-xNu1_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:33 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)) 06:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:34:33 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)) 06:34:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:34:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:34:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:34:33 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 06:34:33 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 06:34:33 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 06:34:33 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 06:34:33 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 06:34:33 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 06:34:34 INFO - Downloading blessings-1.6.tar.gz 06:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:34:35 INFO - Installing collected packages: blessings 06:34:35 INFO - Running setup.py install for blessings 06:34:35 INFO - Successfully installed blessings 06:34:35 INFO - Cleaning up... 06:34:35 INFO - Return code: 0 06:34:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:35 INFO - Reading from file tmpfile_stdout 06:34:35 INFO - Current package versions: 06:34:35 INFO - argparse == 1.2.1 06:34:35 INFO - blessings == 1.6 06:34:35 INFO - blobuploader == 1.2.4 06:34:35 INFO - docopt == 0.6.1 06:34:35 INFO - functools32 == 3.2.3-2 06:34:35 INFO - jsonschema == 2.5.1 06:34:35 INFO - manifestparser == 1.1 06:34:35 INFO - mozInstall == 1.12 06:34:35 INFO - mozcrash == 0.17 06:34:35 INFO - mozdebug == 0.1 06:34:35 INFO - mozdevice == 0.48 06:34:35 INFO - mozfile == 1.2 06:34:35 INFO - mozhttpd == 0.7 06:34:35 INFO - mozinfo == 0.9 06:34:35 INFO - mozleak == 0.1 06:34:35 INFO - mozlog == 3.3 06:34:35 INFO - moznetwork == 0.27 06:34:35 INFO - mozprocess == 0.23 06:34:35 INFO - mozprofile == 0.28 06:34:35 INFO - mozrunner == 6.12 06:34:35 INFO - mozscreenshot == 0.1 06:34:35 INFO - mozsystemmonitor == 0.3 06:34:35 INFO - moztest == 0.7 06:34:35 INFO - mozversion == 1.4 06:34:35 INFO - psutil == 3.1.1 06:34:35 INFO - requests == 1.2.3 06:34:35 INFO - wsgiref == 0.1.2 06:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:35 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')]} 06:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:35 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')]} 06:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:35 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:35 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 06:34:35 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 06:34:35 INFO - Using env: {'DISPLAY': ':0', 06:34:35 INFO - 'HOME': '/home/cltbld', 06:34:35 INFO - 'LANG': 'en_US.UTF-8', 06:34:35 INFO - 'LANGUAGE': 'en_US:en', 06:34:35 INFO - 'LOGNAME': 'cltbld', 06:34:35 INFO - 'MAIL': '/var/mail/cltbld', 06:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:35 INFO - 'MOZ_NO_REMOTE': '1', 06:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:35 INFO - 'NO_EM_RESTART': '1', 06:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:35 INFO - 'PWD': '/builds/slave/test', 06:34:35 INFO - 'SHELL': '/bin/bash', 06:34:35 INFO - 'SHLVL': '1', 06:34:35 INFO - 'TERM': 'linux', 06:34:35 INFO - 'TMOUT': '86400', 06:34:35 INFO - 'USER': 'cltbld', 06:34:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:35 INFO - '_': '/tools/buildbot/bin/python'} 06:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 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)) 06:34:35 INFO - Cleaning up... 06:34:35 INFO - Return code: 0 06:34:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:34:35 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')]} 06:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:35 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')]} 06:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:35 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 0x1b0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', '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 06:34:35 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 06:34:35 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 06:34:35 INFO - Using env: {'DISPLAY': ':0', 06:34:35 INFO - 'HOME': '/home/cltbld', 06:34:35 INFO - 'LANG': 'en_US.UTF-8', 06:34:35 INFO - 'LANGUAGE': 'en_US:en', 06:34:35 INFO - 'LOGNAME': 'cltbld', 06:34:35 INFO - 'MAIL': '/var/mail/cltbld', 06:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:35 INFO - 'MOZ_NO_REMOTE': '1', 06:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:35 INFO - 'NO_EM_RESTART': '1', 06:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:35 INFO - 'PWD': '/builds/slave/test', 06:34:35 INFO - 'SHELL': '/bin/bash', 06:34:35 INFO - 'SHLVL': '1', 06:34:35 INFO - 'TERM': 'linux', 06:34:35 INFO - 'TMOUT': '86400', 06:34:35 INFO - 'USER': 'cltbld', 06:34:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:35 INFO - '_': '/tools/buildbot/bin/python'} 06:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:34:35 INFO - Cleaning up... 06:34:35 INFO - Return code: 0 06:34:35 INFO - Running post-action listener: _resource_record_post_action 06:34:35 INFO - Running post-action listener: _start_resource_monitoring 06:34:35 INFO - Starting resource monitoring. 06:34:35 INFO - [mozharness: 2016-08-06 13:34:35.884108Z] Finished create-virtualenv step (success) 06:34:35 INFO - [mozharness: 2016-08-06 13:34:35.884762Z] Running install step. 06:34:35 INFO - Running pre-action listener: _resource_record_pre_action 06:34:35 INFO - Running main action method: install 06:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:36 INFO - Reading from file tmpfile_stdout 06:34:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:34:36 INFO - Reading from file tmpfile_stdout 06:34:36 INFO - Output received: 06:34:36 INFO - Usage: mozinstall [options] installer 06:34:36 INFO - Options: 06:34:36 INFO - -h, --help show this help message and exit 06:34:36 INFO - -d DEST, --destination=DEST 06:34:36 INFO - Directory to install application into. [default: 06:34:36 INFO - "/builds/slave/test"] 06:34:36 INFO - --app=APP Application being installed. [default: firefox] 06:34:36 INFO - mkdir: /builds/slave/test/build/application 06:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:34:53 INFO - Reading from file tmpfile_stdout 06:34:53 INFO - Output received: 06:34:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:34:53 INFO - Running post-action listener: _resource_record_post_action 06:34:53 INFO - [mozharness: 2016-08-06 13:34:53.246377Z] Finished install step (success) 06:34:53 INFO - [mozharness: 2016-08-06 13:34:53.246625Z] Running run-tests step. 06:34:53 INFO - Running pre-action listener: _resource_record_pre_action 06:34:53 INFO - Running main action method: run_tests 06:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:34:53 INFO - Python 2.7.3 06:34:53 INFO - Return code: 0 06:34:53 INFO - grabbing minidump binary from tooltool 06:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:53 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 0x1dce3b0>, '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 0x1dcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:34:53 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 06:34:53 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 06:34:53 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 06:34:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:34:53 INFO - Return code: 0 06:34:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:34:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:34:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:34:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:34:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:34:53 INFO - Using env: {'DISPLAY': ':0', 06:34:53 INFO - 'HOME': '/home/cltbld', 06:34:53 INFO - 'LANG': 'en_US.UTF-8', 06:34:53 INFO - 'LANGUAGE': 'en_US:en', 06:34:53 INFO - 'LOGNAME': 'cltbld', 06:34:53 INFO - 'MAIL': '/var/mail/cltbld', 06:34:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:34:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:53 INFO - 'MOZ_NO_REMOTE': '1', 06:34:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:53 INFO - 'NO_EM_RESTART': '1', 06:34:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:53 INFO - 'PWD': '/builds/slave/test', 06:34:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:34:53 INFO - 'SHELL': '/bin/bash', 06:34:53 INFO - 'SHLVL': '1', 06:34:53 INFO - 'TERM': 'linux', 06:34:53 INFO - 'TMOUT': '86400', 06:34:53 INFO - 'USER': 'cltbld', 06:34:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222', 06:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:53 INFO - '_': '/tools/buildbot/bin/python'} 06:34:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:34:53 INFO - mozversion application_buildid: 20160806023103 06:34:53 INFO - mozversion application_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 06:34:53 INFO - mozversion application_display_name: Nightly 06:34:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:34:53 INFO - mozversion application_name: Firefox 06:34:53 INFO - mozversion application_remotingname: firefox 06:34:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:34:53 INFO - mozversion application_vendor: Mozilla 06:34:53 INFO - mozversion application_version: 51.0a1 06:34:53 INFO - mozversion platform_buildid: 20160806023103 06:34:53 INFO - mozversion platform_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 06:34:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:34:53 INFO - mozversion platform_version: 51.0a1 06:34:53 INFO - using testdate: 1470490493 06:34:53 INFO - actual date: 1470490493 06:34:53 INFO - starting webserver on 'localhost:51057' 06:34:53 INFO - SUITE-START | Running 2 tests 06:34:53 INFO - TEST-START | dromaeo_css 06:34:53 INFO - operating with platform_type : linux_ 06:34:53 INFO - Initialising browser for dromaeo_css test... 06:34:53 INFO - TEST-INFO | started process 31245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrPEzE/profile http://localhost:51057/getInfo.html) 06:34:57 INFO - PROCESS | 31245 | __metrics Screen width/height:1600/1200 06:34:57 INFO - PROCESS | 31245 | colorDepth:24 06:34:57 INFO - PROCESS | 31245 | Browser inner width/height: 1024/697 06:34:57 INFO - PROCESS | 31245 | __metrics 06:34:58 ERROR - PROCESS | 31245 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:34:59 INFO - TEST-INFO | 31245: exit 0 06:34:59 INFO - Browser initialized. 06:34:59 INFO - Running cycle 1/1 for dromaeo_css test... 06:34:59 INFO - TEST-INFO | started process 31366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrPEzE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:11 INFO - PROCESS | 31366 | RSS: Main: 164216832 06:35:11 INFO - PROCESS | 31366 | 06:36:00 INFO - PROCESS | 31366 | 1470490560822 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] 06:38:10 INFO - PROCESS | 31366 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51057/tests/dromaeo/cssquery-ext.html) 06:38:11 INFO - PROCESS | 31366 | RSS: Main: 167407616 06:38:11 INFO - PROCESS | 31366 | 06:41:14 INFO - PROCESS | 31366 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-ext.html (next: http://localhost:51057/tests/dromaeo/cssquery-jquery.html) 06:41:14 INFO - PROCESS | 31366 | RSS: Main: 165416960 06:41:14 INFO - PROCESS | 31366 | 06:44:16 INFO - PROCESS | 31366 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51057/tests/dromaeo/cssquery-mootools.html) 06:44:17 INFO - PROCESS | 31366 | RSS: Main: 170852352 06:44:17 INFO - PROCESS | 31366 | 06:47:18 INFO - PROCESS | 31366 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51057/tests/dromaeo/cssquery-prototype.html) 06:47:19 INFO - PROCESS | 31366 | RSS: Main: 164421632 06:47:19 INFO - PROCESS | 31366 | 06:50:22 INFO - PROCESS | 31366 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51057/tests/dromaeo/cssquery-yui.html) 06:50:22 INFO - PROCESS | 31366 | RSS: Main: 167051264 06:50:22 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-yui.html (next: http://localhost:51057/tests/dromaeo/cssquery-dojo.html) 06:53:25 INFO - PROCESS | 31366 | RSS: Main: 170295296 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | __start_tp_report 06:53:25 INFO - PROCESS | 31366 | _x_x_mozilla_page_load 06:53:25 INFO - PROCESS | 31366 | _x_x_mozilla_page_load_details 06:53:25 INFO - PROCESS | 31366 | |i|pagename|runs| 06:53:25 INFO - PROCESS | 31366 | |0;dojo.html;3125.9218519537008;3140.434721750084;3156.463401221792;3160.5891234139567;3173.46051171301;5274.525292723654;5427.864303392422;5436.238926550282;5460.453954604538;5484.314460692413;5374.167004114359;5389.434109418514;5405.567554595623;5439.864003399917;5531.668099914008;4954;4973.701577905319;5059.392872855263;5088.1095808233595;5096.159133742928;4992.77532511036;5015.824446144386;5057.924131138036;5102.1836506159025;5117.846464606049;4794.089123066607;4985.975070124662;4995.900081998376;5041.521055499722;5078;4869.488703686133;4909.558139767402;4928.457869634337;4983.15286401309;4984;4913.287573301887;4917.262410638397;4921.901561968776;4932.753362331869;4942.110420124376;5387.461253874581;5439.972800136014;5465.863353416196;5482.671039737628;5515.972420137914;5763.077907534816;5814.912776308359;5829.067349224104;5832.475077243069;5848;5826.650400975955;5872.207252021008;5890.469857712784;5891.175235467038;5892.322382925976;5316.3354580677415;5470.070088085035;5483.287172667568;5485.945140548623;5489.505944464978;5873.911891321633;5916.408359164049;5945.2865656120675;5953.702314884238;5958.314793798682;5755.683437410982;5759;5761.049426844524;5762.942370576325;5768;5658.603897727119;5841.94158058414;5846.181534585076;5848.707564621837;5854.590178687451;5687.744051517691;5699.658020518782;5716.542676585863;5735.139729040678;5735.569832262597;5734.512566431817;5772;5788.479036886616;5802.303723553201;5846.1230815377185;4380.189664912002;4434.490033646108;4434.933475997863;4436.112777444524;4484.080763443486;3944.309745794532;3985.2228815381304;4003.779792111462;4010.939835902464;4017.116234428421;5561.944380556223;5676.035074037423;5676.120201368794;5701.657900525982;5731.942680573225;5886.087656413263;5897.439743224472;5909.6158749681135;5912.083627037816;5915.7633694652595;5446.673199608036;5591.161325801081;5640.125780504029;5665.291838520185;5666.178404131378;5060.1903695408555;5088.796448142033;5095.388553373619;5131.2559678846355;5135.35808023997;6108.8778224436155;6115.205023347025;6115.908261376083;6119.326874043852;6125.693715314305;5714.942850571441;5793.507551858139;5859.326177489473;5893.086571581412;5893.292804863272;6043.848903777441;6112.985242459679;6113.841195312776;6114.540688159306;6130.612163469634;5778.537716982715;5780.710964451845;5784.1034639630925;5797.59416840834;5803.535717142703;5652.0674088774895;5754.136879468113;5811.186433899342;5881.147233651182;5906.468417842415;5677.148427735708;5705.857353566194;5710.3433105193435;5752.367239603556;5763.884722305615;5655.010373184594;5658.434156584309;5688.345840228261;5705.515031222392;5711.914321285267;5429.592780541554;5541.9168712470155;5625.21247025425;5627.606067575231;5629.971850140723;5671.574631902541;5696.401877802771;5726.713664316684;5753;5784.739686714192;5587.44125587438;5601.719914004365;5602.467765562265;5605.5795815313195;5608.551315894637 06:53:25 INFO - PROCESS | 31366 | |1;ext.html;562.198649951784;573.6443405088845;590.0470739755297;606.963582185069;613.0191693290735;41739.58260417395;42872.35691464627;42965.35551966723;46137.769311153395;46593.53406465935;44765.7761711191;45027.324590131095;45048.77475612617;45413.545864541346;45843.08313833721;8820;9006.099390061006;9012.098790121001;9014.45913245204;9020.8646870297;8948.284137269004;8965.237954773853;9002.594883230271;9004.144606262395;9054.411463254868;9023.142801433853;9059.95470022649;9064.274858011377;9066.682666106688;9087;8963.282937365027;8972.41679290844;8995.235404990584;8999.100089991014;9045.954770226173;8766.605502752327;8852.424592401474;8854.645814167425;8872.689455869078;8886.066962968924;43320.78339608282;43839;43909;43921.560784392066;43953;3362.2098806780386;3392.1519620094978;3455.2987570508612;3509.2805974775365;3510.2452972611013;31274.37451250962;33444.49833252503;34096.31807363839;34150.31699365999;34153.658463415544;4343;4374.300111982099;4494.70784399013;4601.7699115044115;4613.100445413146;360363;360506;364225;366409;367899;60476;61163.38836611666;61559.692201539605;61803.38196618066;61924.38075619186;36964.44553331702;65270;65302.346976529625;65345.34654653488;65480.67259663671;16532.256048477848;17628.91185544064;17645.823541764417;17658.20538075764;17693.911530442267;13413.731725365438;13420.261885596386;13519;13533.39099740514;13570.660733481742;19230;19254;19254.422367329003;19255.903720481307;19409.32067377635;7102.18324892644;7192.568445893263;7294.708211671474;7382.963085184647;7403.555786652818;940.5109343141528;1099.5491848342142;1100.1748688483638;1133.2520536445907;1158.79141754485;33323.83338083343;33449;33530.49704254438;33852.66147338495;34266.14334641654;1054.7204990677476;1129.220837622038;1147.8565179352581;1241.698810991383;1280.6286177008562;17426.21582028812;17636.559086022953;17655.73516397255;17724.822751772575;17746.91126544359;600893;602680;602804;604404;608148;58538.7073064632;58858.70570647119;58979.410205897395;59106.40893591095;59247.40752592505;1286.2475451860766;1367.1045465220298;1372.6911444924813;1376.2361889151616;1380.0822453068597;29899.252518687208;32227;32746.345073097928;33016.83491582527;33222.16944576405;45427.77286113548;45462.54537454715;45532.77233613811;45751.313730293405;45768.77115614401;452217;452222;454007;454221;455109;28766.137015889555;28902.277443064093;29116.56325155082;29345.7065429343;29811.403771924874;48309.75845120892;48433.515664842904;49939.250911235635;49984;50287;40911.38632920449;41821.372679410444;42083.57916420919;42239;43952;41898;41933;41978.790106050496;43055;43471.565284346754;41941.161176775684;42135.36796948109;43090;43416.34875476807;44222.336664949406;32413.18967025749;37583.24833503369;38122.809385952896;38307.425388618634;38351.80824095861;29174.854125729235;29295.267618309714;29674.851625741732;29702.108936731933;29838.55242171326 06:53:25 INFO - PROCESS | 31366 | |2;jquery.html;390.5820771774201;390.95699473057977;399.7321794397754;404.70052161400565;418.6169654765889;14162.929185354085;18303.267869285228;18670.346537871144;20215.595688086247;20262.39212823614;19357.322493712723;19738.90130549345;19809.405717828453;20644;20794.792052079476;5626.803061892824;5679.460451257124;5680.517156041741;5736.942630573682;5773.307203135609;5651.2935883014625;5761.337446193678;5788.016037273674;5793.391693872146;5799;5556.611037227396;5650.63270887391;5734.770609175628;5737.397573254811;5752.626079304852;5625.493705566478;5706.600537962365;5718.1136923776885;5718.456746609066;5720.542356611461;4981.800727970877;5086.77109530072;5101.821436249714;5126.359205099363;5141.640085194038;17542;21688.566228675496;23965.400864978514;24055.15806946766;24787.380315492075;2332.918347857817;2421.418859473731;2467.8272520923542;2468.456939473313;2529.1021687300927;15289.923550382176;15443.227838608136;15446.768298475532;15480.45818396362;15755.527334179993;1957.862949593529;1971.3297478857257;1978.2977043149763;1988.1749074134218;2004.98997505013;85320.57339713324;86238.99999999937;86629.56685216534;88404.55797721035;90030.549847251;9807.656732014488;10034.397936123856;10093.848592271122;10183.796324073624;10329.380237185642;14163.150210987375;14184.716305673828;14187.432502699983;14195.29023548839;14203.857961420254;8111.75664730059;8189.959050204711;8368.3305335573;8478.448900821428;8514.446560973516;8239.917600824036;8252.917470825336;8374.916250837536;8518.829623407497;8546.743597692079;6298.401651843159;6384.936150638527;6407.519436042316;6502.479801615859;6588.143541339691;1849.704047352417;1863.6924907390128;1895.933642322512;1912.8522886268129;1923.3268356075262;959.8464245720651;1027.773889744255;1055.2929537210089;1082.929609575375;1144.5078616195117;20826.687599686018;20962.58074838525;21101.78898210998;21128.577428451346;21171.47071323229;1025.3847691385258;1025.7692019295598;1045.2056437107701;1105.4464187726217;1128.6388355726253;11181.944090279496;11941.761164776655;12013.399330033464;12106.576269830513;12108.394580271128;492531;510055;521979;529161;531179;61452;62803.685981570714;64021.35978640154;85367.14632853592;91281.54359228161;1026.199564339816;1045.1064339989352;1071.924965252425;1083.0469187115289;1090.2095980414135;15912.0452772834;16004.67990640204;17694.646107078042;19133.712994305373;19269.614607707488;44715.55284447114;45314;45716.54283457123;46024.309635354824;47548;61646.69176654267;64779.67610161919;65735.67132164308;66561.33438665746;66830.3316966824;8656.610452529778;8708;8735;8841;8904.154105359981;13023.934880325538;13044.673883152996;13048.739025219633;13640.113392629448;14015.439382424589;11332.830007549728;11761.353125578175;12203.75592488163;12242.204256723284;12315.507379704712;11725.472353743931;11849.940750296539;11852.822207666719;11861;11902.226355286879;11768.70578235551;12005.519779208735;12167.634970950885;12291.877081229073;12480;8570.442921210102;8755.474671519729;8772.254358379609;8897.599608017785;8944.731658050268;11496.48265828023;11893.821592675944;12009.519619215484;12271;12373.072019598747 06:53:25 INFO - PROCESS | 31366 | |3;mootools.html;1481.9703605927884;1514.621344663834;1631.796025496813;1767.7701898753169;1788.955276118096;7649.082110146776;8491.91508084919;8575.742727718163;9125.133112354324;9129.726108216748;8675.913240867589;8888.911110888888;8928.91071089289;8958.686445974392;9021.72934811955;2397.568437681221;2431.2706188143575;2432.7567243275707;2443.9755602444015;2452.877356132195;2423.151896836111;2436.9756302437013;2478.8016958643357;2495.950080998379;2503.2740505253455;2445.3397582652674;2445.4742230420457;2452.3133522613607;2454.128784281581;2477.3930387055198;2365.207655435431;2396.2451827674226;2405.5206048280356;2411.44536756547;2416.3113512648897;2332.9650055249185;2341.4497593065616;2346.16711067572;2349.565330413879;2361.8346715729904;8883.911160888438;8897.911020889838;8934.061923498004;8941.016488186295;8976.461412315282;5293.947060529384;5450.345958484968;5456.699881506515;5459.317585301837;5461.126219804852;3237.53055806909;3377.9155521111925;3389.3560223557447;3393.9490907636405;3421.9144521386916;973.756560859785;1012.8936461671492;1021.7752094539189;1022.3865680591659;1030.3148406309795;12509.812352814715;12552.435140418704;12555;12563.183393079513;12573.937130314382;4703.811847526061;4819.336759449052;4902.803887844518;4908.190148625436;5025.974870125699;10609.416482093404;10648.467576621139;10664.41345725977;10668.519916603771;10681.893181068246;5403.83788486346;5437.918431223535;5457.45425457459;5473.589480788877;5522.088855338824;4217.283061879488;4732.858014259509;4894.583960363338;4920;5065.797368105234;4032.7580345179385;4148.647364973951;4154.376843473503;4162.980069882898;4305.677074219446;1360.8017373632629;1371.7599420101442;1374.2647683489286;1375.099309951983;1394.400407824645;986.5954958466995;998.3610489286863;1017.6285655735603;1030.1501261459325;1049.0191670787685;6270.0908368287255;6334.651594162273;6373;6413.839654008594;6437.935620643827;491.842610364687;496.30765082709416;499.0493110624267;499.6876951905059;507.9771410286546;4357.346398040256;4450.265706158512;4456.197884380777;4473.3960915276675;4565.315202719618;10330.225233107547;10816.242862999672;10828.837567436494;10896.291741036966;10900.291481053706;10682.1988350874;10723.731906702238;10725.463726813628;10758.731031724114;10773.407462589634;8003.199680032067;8075.394345424117;8252.752417427488;8339;8439.831203376021;6184.165137706352;6199.287081985449;6309.747610095545;6480.416762491398;6502.317256687979;10030.398176109456;10205.336653117523;10294.330868493824;10346.844797327896;10374.740631484274;10203.642872499428;10360.430176340073;10378.688639340831;10421.322614030063;10467.738306542398;7762.92237077622;7933.444658873824;7955.721549745731;7984.600769961363;8118.837623247384;8790.164934331227;8809;8826.646934122564;8837.690680826141;8895.911040889509;7493.250674932463;7630.465867389229;7722.15056343813;7796.259355361231;8032.4778889372;7569.735059272899;7697.191794861459;7734.458587899018;7741.264579864904;7772.417068719982;7294.562326260441;7406.222346653739;7442.4418168636485;7449.739259125905;7467.850642987001;5404.405515393382;5453.645513041798;5464.453554644504;5564.248826408383;5665.773369065191;5332.760025798771;5500.862478437911;5564.527015203591;5567.081431563909;5686.34607020198 06:53:25 INFO - PROCESS | 31366 | |4;prototype.html;316.3404302030267;321.26911276845175;322.14309935571384;331.1439927786671;338.3554329003249;5498.120300751875;5556.083246264367;5557.582816381817;5616.747246373913;5662.263905692254;5487.506124448799;5514.641548299358;5527.170924361348;5540.63985840921;5550.888982220353;4123.83504659814;4209.3054645983375;4304.816175551717;4310.913781724364;4336.891577710551;4279.700420970534;4283.421738065368;4304.956950430503;4318.935215971763;4322.459692538433;4281.336392859096;4293.819199720071;4317.4819021717285;4331.1376108273425;4343.9565604344025;4035.878923632296;4196.58034196581;4233.576642335742;4264.680148988808;4335.176316499871;3722.1997270586953;3731.2350968051483;3733.906652333686;3736.6076561961145;3738.8691395801015;5341.305630268079;5376.650517716336;5378.811741589065;5425.5856144015925;5431.266778984826;4613.538646135393;4783.049543722231;4864.7324397158145;4896.975515122437;4901.852944411673;5655.1799989001365;5678.006348888928;5712.685802280873;5726.255586773735;5774.797882074149;4077.4087757275324;4079.2657321682086;4088.9795551022353;4095.6279646318517;4106.835726570934;5895.616784908967;5930.7034648267845;5949.382271800394;5956.315023772235;6029.366916473795;4162.8135981245805;4195.811188496525;4199.2704741918;4206.305959516707;4213.241616508996;4265.125649241898;4270.636995855325;4278.957210427918;4282.143571285756;4290.699651024398;4711.764411779397;4796.424429068465;4877.658563900563;4884.072026314989;4888.364512613338;5712.257406537124;5727.284089488814;5740.598158128974;5748.712564371848;5797.913031304533;1440.9567712968628;1444.5738507140418;1454.8579365198268;1465.8754005909404;1475.7712554554062;877.4719826376579;930.3998920696113;943.4622265308845;974.5906719177963;1002.8997100290059;5593;5653.406392328829;5689.77240910359;5690.715464226772;5706.828795136153;5887.35239123696;5924.6149000314845;5941.881162376728;5956.970215148896;5987.730552125077;5391.757370918318;5592.832215033555;5626.35296940857;5647.915281270784;5728.510587247346;3152.858121384543;3161.8893338733033;3169.8256595887447;3173.2066983254185;3174.714275715197;5981.760729570856;6144.446999770043;6148.200733904564;6238.313785483593;6260.248770147611;5906.468417842415;5910.926318314539;5914.940850591525;5974.550434321994;5982.4316689914385;6131.724072416752;6141.662208578482;6193.38066193377;6220.533459990519;6239;5742.196092546963;5743.3395159557185;5787.479126878601;5806.200077975841;5821.214136091573;5752.626079304831;5776.537876969748;5807.76768929255;5872.530197584098;5909.734061967136;5991.442225021438;6097.817065488042;6139.631622102688;6255.840800395771;6269.68651567429;4192.406885383535;4196.8111434984885;4209;4218.49378074633;4234.724742891703;5901.911471327848;5932.673702946379;5946.910796338145;5953.702314884152;5978.880422391615;5541.1991102892525;5693.718913244653;5723.3672510645565;5735.541156707537;5789.681567513827;5693.772249109989;5702.372738998624;5764.077747560538;5775.509081727932;5783;5092.007058623532;5662.943370566241;5682.232898558642;5707.086866101404;5745.023346031101;5750.539956803362;5787.8553036174435;5799.217105690678;5810.4189581041555;5824.864151490418;5688.516476099578;5704;5717.3996730342715;5718.685472299064;5758.769649213985 06:53:25 INFO - PROCESS | 31366 | |5;yui.html;704.8731228378896;707.1867352544573;737.9040724705789;768.8324104688684;802.546561192926;15507.302171402285;16009.679806403894;16043;16085.115318657468;16133.515994520154;15474.922625386886;15585.610359740984;15601.843981560181;15629.671477924361;15668.529944101696;651.7230177174705;786.5555960882112;801.4950581133907;807.3823525003377;811.926926576608;797.2346547314585;817.2971244729528;818.2104269380047;818.251300060444;819.1767273889762;863.5078005536847;870.1472556894247;870.4037734152095;871.2463718883153;871.7689812199741;863.0290922711949;865;865.5585651317841;865.7186414415308;867;624.8750249950028;627.0969803482969;631.2235949781748;632.6741728010079;633.3919437340159;14690;14898.627534311621;14936.178510181935;15016.324265408082;15019.474318398803;15814.367425302975;15864.286107125206;15921.761173582405;16049.197540122947;16061.437849675322;12446.25322480645;12565.811512827315;12594.181378210387;13334.599962001155;13352.532661356807;4009.1179940413354;4066.552679205285;4203.852865149705;4208.137331846995;4214.599613036757;79163.6041819793;80279.5986020072;81088.59455702684;81115;81395.5930220351;11859.229150105215;11932.821007684892;12352.938235308946;12389.318587477776;12671.619851404472;23888.044478221025;23913.282601521983;23924.162654307016;23935.880320598633;23962.640560391606;7794.727184548514;8000;8015.759527214076;8446.028706698686;8524.70163544273;4860.8298709545;4881.658283920092;4889.535494128123;4932.358793356841;4997.475265097112;3481.1819222482695;3594.263176048904;3595.496630471736;3597.1546686528645;3600.8739694111105;563.1637019026742;568.6389142894292;584.9590528663038;589.4341432225112;602.9216201893726;600.297176820208;688.7968049425432;722.1406526233765;727.5416487612875;770.872805987017;9839.75400614976;9896.505174741234;10313.9484302578;10330.276880618285;10813.783724325469;619.0188551146483;688.9345512176335;736.8784150615088;736.9742059027908;755.52401986748;4626.930596041062;4658.464276608166;4727.739974301447;4734.218853889139;4824.541668541483;102282.3060039905;105022.94977050285;107043.46478267558;113742;125170;63355;72675;95492.52253738826;99237;100639;58522.7073864628;82547;88344.5582772082;91544.99999999866;92424.53787731018;9570.377925434825;9615.423074615546;9752.366096203725;10319.226058045526;10452.216083793593;38935.858527781245;43012.569874302106;50626.493735063654;52226.73886630694;53916.19125713039;47057.2941405886;47169.528304716514;65025.674871627234;77139;79184;12952.352382381032;13264.801027984395;13308.268045257604;13507.392167352296;13934.372953217333;15163.620909477351;15216.771748424004;15385;16130.758038629196;16134.435294764628;14208.857911420753;14309.713805723619;14763.630909227355;15212.315445804745;15316.770248446504;14274.785878211627;14534.563963081124;14600.707985840012;14922.776158357416;15144.621384465476;13320.600381988555;13491.460341586228;13689.31553422305;13831.308434578432;14273.928630356782;11746.29522228669;11767.941160294144;11971.16201865861;11975.820362694742;12459;9822.656207033006;11120.720252348088;12232.938835305766;12272.570460033856;12525 06:53:25 INFO - PROCESS | 31366 | __end_tp_report 06:53:25 INFO - PROCESS | 31366 | __start_cc_report 06:53:25 INFO - PROCESS | 31366 | _x_x_mozilla_cycle_collect,319 06:53:25 INFO - PROCESS | 31366 | __end_cc_report 06:53:25 INFO - PROCESS | 31366 | __startTimestamp1470491605831__endTimestamp 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | ------- Summary: start ------- 06:53:25 INFO - PROCESS | 31366 | Number of tests: 6 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | [#0] dojo.html Cycles:165 Average:5429.71 Median:5658.60 stddev:616.08 (10.9%) stddev-sans-first:590.87 06:53:25 INFO - PROCESS | 31366 | Values: 3125.9 3140.4 3156.5 3160.6 3173.5 5274.5 5427.9 5436.2 5460.5 5484.3 5374.2 5389.4 5405.6 5439.9 5531.7 4954.0 4973.7 5059.4 5088.1 5096.2 4992.8 5015.8 5057.9 5102.2 5117.8 4794.1 4986.0 4995.9 5041.5 5078.0 4869.5 4909.6 4928.5 4983.2 4984.0 4913.3 4917.3 4921.9 4932.8 4942.1 5387.5 5440.0 5465.9 5482.7 5516.0 5763.1 5814.9 5829.1 5832.5 5848.0 5826.7 5872.2 5890.5 5891.2 5892.3 5316.3 5470.1 5483.3 5485.9 5489.5 5873.9 5916.4 5945.3 5953.7 5958.3 5755.7 5759.0 5761.0 5762.9 5768.0 5658.6 5841.9 5846.2 5848.7 5854.6 5687.7 5699.7 5716.5 5735.1 5735.6 5734.5 5772.0 5788.5 5802.3 5846.1 4380.2 4434.5 4434.9 4436.1 4484.1 3944.3 3985.2 4003.8 4010.9 4017.1 5561.9 5676.0 5676.1 5701.7 5731.9 5886.1 5897.4 5909.6 5912.1 5915.8 5446.7 5591.2 5640.1 5665.3 5666.2 5060.2 5088.8 5095.4 5131.3 5135.4 6108.9 6115.2 6115.9 6119.3 6125.7 5714.9 5793.5 5859.3 5893.1 5893.3 6043.8 6113.0 6113.8 6114.5 6130.6 5778.5 5780.7 5784.1 5797.6 5803.5 5652.1 5754.1 5811.2 5881.1 5906.5 5677.1 5705.9 5710.3 5752.4 5763.9 5655.0 5658.4 5688.3 5705.5 5711.9 5429.6 5541.9 5625.2 5627.6 5630.0 5671.6 5696.4 5726.7 5753.0 5784.7 5587.4 5601.7 5602.5 5605.6 5608.6 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | [#1] ext.html Cycles:180 Average:63445.54 Median:23879.67 stddev:128661.36 (538.8%) stddev-sans-first:128935.66 06:53:25 INFO - PROCESS | 31366 | Values: 562.2 573.6 590.0 607.0 613.0 41739.6 42872.4 42965.4 46137.8 46593.5 44765.8 45027.3 45048.8 45413.5 45843.1 8820.0 9006.1 9012.1 9014.5 9020.9 8948.3 8965.2 9002.6 9004.1 9054.4 9023.1 9060.0 9064.3 9066.7 9087.0 8963.3 8972.4 8995.2 8999.1 9046.0 8766.6 8852.4 8854.6 8872.7 8886.1 43320.8 43839.0 43909.0 43921.6 43953.0 3362.2 3392.2 3455.3 3509.3 3510.2 31274.4 33444.5 34096.3 34150.3 34153.7 4343.0 4374.3 4494.7 4601.8 4613.1 360363.0 360506.0 364225.0 366409.0 367899.0 60476.0 61163.4 61559.7 61803.4 61924.4 36964.4 65270.0 65302.3 65345.3 65480.7 16532.3 17628.9 17645.8 17658.2 17693.9 13413.7 13420.3 13519.0 13533.4 13570.7 19230.0 19254.0 19254.4 19255.9 19409.3 7102.2 7192.6 7294.7 7383.0 7403.6 940.5 1099.5 1100.2 1133.3 1158.8 33323.8 33449.0 33530.5 33852.7 34266.1 1054.7 1129.2 1147.9 1241.7 1280.6 17426.2 17636.6 17655.7 17724.8 17746.9 600893.0 602680.0 602804.0 604404.0 608148.0 58538.7 58858.7 58979.4 59106.4 59247.4 1286.2 1367.1 1372.7 1376.2 1380.1 29899.3 32227.0 32746.3 33016.8 33222.2 45427.8 45462.5 45532.8 45751.3 45768.8 452217.0 452222.0 454007.0 454221.0 455109.0 28766.1 28902.3 29116.6 29345.7 29811.4 48309.8 48433.5 49939.3 49984.0 50287.0 40911.4 41821.4 42083.6 42239.0 43952.0 41898.0 41933.0 41978.8 43055.0 43471.6 41941.2 42135.4 43090.0 43416.3 44222.3 32413.2 37583.2 38122.8 38307.4 38351.8 29174.9 29295.3 29674.9 29702.1 29838.6 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | [#2] jquery.html Cycles:180 Average:29977.56 Median:13149.16 stddev:84981.03 (646.3%) stddev-sans-first:85190.39 06:53:25 INFO - PROCESS | 31366 | Values: 390.6 391.0 399.7 404.7 418.6 14162.9 18303.3 18670.3 20215.6 20262.4 19357.3 19738.9 19809.4 20644.0 20794.8 5626.8 5679.5 5680.5 5736.9 5773.3 5651.3 5761.3 5788.0 5793.4 5799.0 5556.6 5650.6 5734.8 5737.4 5752.6 5625.5 5706.6 5718.1 5718.5 5720.5 4981.8 5086.8 5101.8 5126.4 5141.6 17542.0 21688.6 23965.4 24055.2 24787.4 2332.9 2421.4 2467.8 2468.5 2529.1 15289.9 15443.2 15446.8 15480.5 15755.5 1957.9 1971.3 1978.3 1988.2 2005.0 85320.6 86239.0 86629.6 88404.6 90030.5 9807.7 10034.4 10093.8 10183.8 10329.4 14163.2 14184.7 14187.4 14195.3 14203.9 8111.8 8190.0 8368.3 8478.4 8514.4 8239.9 8252.9 8374.9 8518.8 8546.7 6298.4 6384.9 6407.5 6502.5 6588.1 1849.7 1863.7 1895.9 1912.9 1923.3 959.8 1027.8 1055.3 1082.9 1144.5 20826.7 20962.6 21101.8 21128.6 21171.5 1025.4 1025.8 1045.2 1105.4 1128.6 11181.9 11941.8 12013.4 12106.6 12108.4 492531.0 510055.0 521979.0 529161.0 531179.0 61452.0 62803.7 64021.4 85367.1 91281.5 1026.2 1045.1 1071.9 1083.0 1090.2 15912.0 16004.7 17694.6 19133.7 19269.6 44715.6 45314.0 45716.5 46024.3 47548.0 61646.7 64779.7 65735.7 66561.3 66830.3 8656.6 8708.0 8735.0 8841.0 8904.2 13023.9 13044.7 13048.7 13640.1 14015.4 11332.8 11761.4 12203.8 12242.2 12315.5 11725.5 11849.9 11852.8 11861.0 11902.2 11768.7 12005.5 12167.6 12291.9 12480.0 8570.4 8755.5 8772.3 8897.6 8944.7 11496.5 11893.8 12009.5 12271.0 12373.1 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | [#3] mootools.html Cycles:180 Average:5929.68 Median:4856.96 stddev:3329.41 (68.5%) stddev-sans-first:3321.98 06:53:25 INFO - PROCESS | 31366 | Values: 1482.0 1514.6 1631.8 1767.8 1789.0 7649.1 8491.9 8575.7 9125.1 9129.7 8675.9 8888.9 8928.9 8958.7 9021.7 2397.6 2431.3 2432.8 2444.0 2452.9 2423.2 2437.0 2478.8 2496.0 2503.3 2445.3 2445.5 2452.3 2454.1 2477.4 2365.2 2396.2 2405.5 2411.4 2416.3 2333.0 2341.4 2346.2 2349.6 2361.8 8883.9 8897.9 8934.1 8941.0 8976.5 5293.9 5450.3 5456.7 5459.3 5461.1 3237.5 3377.9 3389.4 3393.9 3421.9 973.8 1012.9 1021.8 1022.4 1030.3 12509.8 12552.4 12555.0 12563.2 12573.9 4703.8 4819.3 4902.8 4908.2 5026.0 10609.4 10648.5 10664.4 10668.5 10681.9 5403.8 5437.9 5457.5 5473.6 5522.1 4217.3 4732.9 4894.6 4920.0 5065.8 4032.8 4148.6 4154.4 4163.0 4305.7 1360.8 1371.8 1374.3 1375.1 1394.4 986.6 998.4 1017.6 1030.2 1049.0 6270.1 6334.7 6373.0 6413.8 6437.9 491.8 496.3 499.0 499.7 508.0 4357.3 4450.3 4456.2 4473.4 4565.3 10330.2 10816.2 10828.8 10896.3 10900.3 10682.2 10723.7 10725.5 10758.7 10773.4 8003.2 8075.4 8252.8 8339.0 8439.8 6184.2 6199.3 6309.7 6480.4 6502.3 10030.4 10205.3 10294.3 10346.8 10374.7 10203.6 10360.4 10378.7 10421.3 10467.7 7762.9 7933.4 7955.7 7984.6 8118.8 8790.2 8809.0 8826.6 8837.7 8895.9 7493.3 7630.5 7722.2 7796.3 8032.5 7569.7 7697.2 7734.5 7741.3 7772.4 7294.6 7406.2 7442.4 7449.7 7467.9 5404.4 5453.6 5464.5 5564.2 5665.8 5332.8 5500.9 5564.5 5567.1 5686.3 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | [#4] prototype.html Cycles:180 Average:4853.87 Median:5637.13 stddev:1438.33 (25.5%) stddev-sans-first:1401.47 06:53:25 INFO - PROCESS | 31366 | Values: 316.3 321.3 322.1 331.1 338.4 5498.1 5556.1 5557.6 5616.7 5662.3 5487.5 5514.6 5527.2 5540.6 5550.9 4123.8 4209.3 4304.8 4310.9 4336.9 4279.7 4283.4 4305.0 4318.9 4322.5 4281.3 4293.8 4317.5 4331.1 4344.0 4035.9 4196.6 4233.6 4264.7 4335.2 3722.2 3731.2 3733.9 3736.6 3738.9 5341.3 5376.7 5378.8 5425.6 5431.3 4613.5 4783.0 4864.7 4897.0 4901.9 5655.2 5678.0 5712.7 5726.3 5774.8 4077.4 4079.3 4089.0 4095.6 4106.8 5895.6 5930.7 5949.4 5956.3 6029.4 4162.8 4195.8 4199.3 4206.3 4213.2 4265.1 4270.6 4279.0 4282.1 4290.7 4711.8 4796.4 4877.7 4884.1 4888.4 5712.3 5727.3 5740.6 5748.7 5797.9 1441.0 1444.6 1454.9 1465.9 1475.8 877.5 930.4 943.5 974.6 1002.9 5593.0 5653.4 5689.8 5690.7 5706.8 5887.4 5924.6 5941.9 5957.0 5987.7 5391.8 5592.8 5626.4 5647.9 5728.5 3152.9 3161.9 3169.8 3173.2 3174.7 5981.8 6144.4 6148.2 6238.3 6260.2 5906.5 5910.9 5914.9 5974.6 5982.4 6131.7 6141.7 6193.4 6220.5 6239.0 5742.2 5743.3 5787.5 5806.2 5821.2 5752.6 5776.5 5807.8 5872.5 5909.7 5991.4 6097.8 6139.6 6255.8 6269.7 4192.4 4196.8 4209.0 4218.5 4234.7 5901.9 5932.7 5946.9 5953.7 5978.9 5541.2 5693.7 5723.4 5735.5 5789.7 5693.8 5702.4 5764.1 5775.5 5783.0 5092.0 5662.9 5682.2 5707.1 5745.0 5750.5 5787.9 5799.2 5810.4 5824.9 5688.5 5704.0 5717.4 5718.7 5758.8 06:53:25 INFO - PROCESS | 31366 | 06:53:25 INFO - PROCESS | 31366 | [#5] yui.html Cycles:180 Average:20295.11 Median:23613.58 stddev:28304.98 (119.9%) stddev-sans-first:28346.16 06:53:25 INFO - PROCESS | 31366 | Values: 704.9 707.2 737.9 768.8 802.5 15507.3 16009.7 16043.0 16085.1 16133.5 15474.9 15585.6 15601.8 15629.7 15668.5 651.7 786.6 801.5 807.4 811.9 797.2 817.3 818.2 818.3 819.2 863.5 870.1 870.4 871.2 871.8 863.0 865.0 865.6 865.7 867.0 624.9 627.1 631.2 632.7 633.4 14690.0 14898.6 14936.2 15016.3 15019.5 15814.4 15864.3 15921.8 16049.2 16061.4 12446.3 12565.8 12594.2 13334.6 13352.5 4009.1 4066.6 4203.9 4208.1 4214.6 79163.6 80279.6 81088.6 81115.0 81395.6 11859.2 11932.8 12352.9 12389.3 12671.6 23888.0 23913.3 23924.2 23935.9 23962.6 7794.7 8000.0 8015.8 8446.0 8524.7 4860.8 4881.7 4889.5 4932.4 4997.5 3481.2 3594.3 3595.5 3597.2 3600.9 563.2 568.6 585.0 589.4 602.9 600.3 688.8 722.1 727.5 770.9 9839.8 9896.5 10313.9 10330.3 10813.8 619.0 688.9 736.9 737.0 755.5 4626.9 4658.5 4727.7 4734.2 4824.5 102282.3 105022.9 107043.5 113742.0 125170.0 63355.0 72675.0 95492.5 99237.0 100639.0 58522.7 82547.0 88344.6 91545.0 92424.5 9570.4 9615.4 9752.4 10319.2 10452.2 38935.9 43012.6 50626.5 52226.7 53916.2 47057.3 47169.5 65025.7 77139.0 79184.0 12952.4 13264.8 13308.3 13507.4 13934.4 15163.6 15216.8 15385.0 16130.8 16134.4 14208.9 14309.7 14763.6 15212.3 15316.8 14274.8 14534.6 14600.7 14922.8 15144.6 13320.6 13491.5 13689.3 13831.3 14273.9 11746.3 11767.9 11971.2 11975.8 12459.0 9822.7 11120.7 12232.9 12272.6 12525.0 06:53:25 INFO - PROCESS | 31366 | -------- Summary: end -------- 06:53:25 INFO - PROCESS | 31366 | 06:53:26 INFO - TEST-INFO | 31366: exit 0 06:53:26 INFO - TEST-OK | dromaeo_css | took 1113080ms 06:53:26 INFO - TEST-START | kraken 06:53:26 INFO - operating with platform_type : linux_ 06:53:26 INFO - Initialising browser for kraken test... 06:53:26 INFO - TEST-INFO | started process 31613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCChAT6/profile http://localhost:51057/getInfo.html) 06:53:31 INFO - PROCESS | 31613 | __metrics Screen width/height:1600/1200 06:53:31 INFO - PROCESS | 31613 | colorDepth:24 06:53:31 INFO - PROCESS | 31613 | Browser inner width/height: 1024/697 06:53:31 INFO - PROCESS | 31613 | __metrics 06:53:31 ERROR - PROCESS | 31613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:53:32 INFO - TEST-INFO | 31613: exit 0 06:53:32 INFO - Browser initialized. 06:53:32 INFO - Running cycle 1/1 for kraken test... 06:53:32 INFO - TEST-INFO | started process 31734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCChAT6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:44 INFO - PROCESS | 31734 | RSS: Main: 164564992 06:53:44 INFO - PROCESS | 31734 | 06:53:47 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-beat-detection) 06:53:47 INFO - PROCESS | 31734 | RSS: Main: 169349120 06:53:47 INFO - PROCESS | 31734 | 06:53:50 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-dft) 06:53:51 INFO - PROCESS | 31734 | RSS: Main: 168943616 06:53:51 INFO - PROCESS | 31734 | 06:53:54 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-fft) 06:53:54 INFO - PROCESS | 31734 | RSS: Main: 164438016 06:53:54 INFO - PROCESS | 31734 | 06:53:56 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-oscillator) 06:53:57 INFO - PROCESS | 31734 | RSS: Main: 165855232 06:53:57 INFO - PROCESS | 31734 | 06:53:59 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:54:00 INFO - PROCESS | 31734 | RSS: Main: 165888000 06:54:00 INFO - PROCESS | 31734 | 06:54:03 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51057/tests/kraken/driver.html?testName=imaging-darkroom) 06:54:03 INFO - PROCESS | 31734 | RSS: Main: 165793792 06:54:03 INFO - PROCESS | 31734 | 06:54:07 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51057/tests/kraken/driver.html?testName=imaging-desaturate) 06:54:07 INFO - PROCESS | 31734 | RSS: Main: 163381248 06:54:07 INFO - PROCESS | 31734 | 06:54:10 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51057/tests/kraken/driver.html?testName=json-parse-financial) 06:54:11 INFO - PROCESS | 31734 | RSS: Main: 165150720 06:54:11 INFO - PROCESS | 31734 | 06:54:13 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:54:13 INFO - PROCESS | 31734 | RSS: Main: 165224448 06:54:13 INFO - PROCESS | 31734 | 06:54:15 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:54:16 INFO - PROCESS | 31734 | RSS: Main: 165531648 06:54:16 INFO - PROCESS | 31734 | 06:54:18 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:54:18 INFO - PROCESS | 31734 | RSS: Main: 165900288 06:54:18 INFO - PROCESS | 31734 | 06:54:21 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:54:22 INFO - PROCESS | 31734 | RSS: Main: 166039552 06:54:22 INFO - PROCESS | 31734 | 06:54:24 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:54:25 INFO - PROCESS | 31734 | RSS: Main: 166252544 06:54:25 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51057/tests/kraken/driver.html?testName=ai-astar) 06:54:27 INFO - PROCESS | 31734 | RSS: Main: 166989824 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | __start_tp_report 06:54:27 INFO - PROCESS | 31734 | _x_x_mozilla_page_load 06:54:27 INFO - PROCESS | 31734 | _x_x_mozilla_page_load_details 06:54:27 INFO - PROCESS | 31734 | |i|pagename|runs| 06:54:27 INFO - PROCESS | 31734 | |0;ai-astar;104;114;108;112;112;113;113;111;112;112 06:54:27 INFO - PROCESS | 31734 | |1;audio-beat-detection;149;119;156;186;122;148;152;122;181;118 06:54:27 INFO - PROCESS | 31734 | |2;audio-dft;162;163;162;164;164;171;166;162;162;162 06:54:27 INFO - PROCESS | 31734 | |3;audio-fft;76;75;74;178;81;76;75;76;170;78 06:54:27 INFO - PROCESS | 31734 | |4;audio-oscillator;85;84;144;84;84;83;139;84;84;152 06:54:27 INFO - PROCESS | 31734 | |5;imaging-gaussian-blur;117;119;117;118;117;117;117;117;118;117 06:54:27 INFO - PROCESS | 31734 | |6;imaging-darkroom;148;147;147;147;147;147;147;147;149;146 06:54:27 INFO - PROCESS | 31734 | |7;imaging-desaturate;95;97;95;96;96;97;96;97;96;96 06:54:27 INFO - PROCESS | 31734 | |8;json-parse-financial;55;52;57;52;51;52;52;51;54;51 06:54:27 INFO - PROCESS | 31734 | |9;json-stringify-tinderbox;61;60;60;59;61;60;60;60;60;61 06:54:27 INFO - PROCESS | 31734 | |10;stanford-crypto-aes;81;78;78;78;78;83;83;83;83;76 06:54:27 INFO - PROCESS | 31734 | |11;stanford-crypto-ccm;125;130;126;125;128;135;124;126;135;129 06:54:27 INFO - PROCESS | 31734 | |12;stanford-crypto-pbkdf2;163;159;157;167;168;158;158;157;159;159 06:54:27 INFO - PROCESS | 31734 | |13;stanford-crypto-sha256-iterative;64;64;64;64;64;64;64;64;64;64 06:54:27 INFO - PROCESS | 31734 | __end_tp_report 06:54:27 INFO - PROCESS | 31734 | __start_cc_report 06:54:27 INFO - PROCESS | 31734 | _x_x_mozilla_cycle_collect,876 06:54:27 INFO - PROCESS | 31734 | __end_cc_report 06:54:27 INFO - PROCESS | 31734 | __startTimestamp1470491667422__endTimestamp 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | ------- Summary: start ------- 06:54:27 INFO - PROCESS | 31734 | Number of tests: 14 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.96 (2.6%) stddev-sans-first:1.69 06:54:27 INFO - PROCESS | 31734 | Values: 104.0 114.0 108.0 112.0 112.0 113.0 113.0 111.0 112.0 112.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.50 stddev:25.02 (16.6%) stddev-sans-first:26.50 06:54:27 INFO - PROCESS | 31734 | Values: 149.0 119.0 156.0 186.0 122.0 148.0 152.0 122.0 181.0 118.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.86 (1.7%) stddev-sans-first:2.96 06:54:27 INFO - PROCESS | 31734 | Values: 162.0 163.0 162.0 164.0 164.0 171.0 166.0 162.0 162.0 162.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:41.25 (54.3%) stddev-sans-first:43.12 06:54:27 INFO - PROCESS | 31734 | Values: 76.0 75.0 74.0 178.0 81.0 76.0 75.0 76.0 170.0 78.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:29.63 (35.3%) stddev-sans-first:30.76 06:54:27 INFO - PROCESS | 31734 | Values: 85.0 84.0 144.0 84.0 84.0 83.0 139.0 84.0 84.0 152.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:54:27 INFO - PROCESS | 31734 | Values: 117.0 119.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:54:27 INFO - PROCESS | 31734 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 149.0 146.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 06:54:27 INFO - PROCESS | 31734 | Values: 95.0 97.0 95.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:2.00 (3.9%) stddev-sans-first:1.94 06:54:27 INFO - PROCESS | 31734 | Values: 55.0 52.0 57.0 52.0 51.0 52.0 52.0 51.0 54.0 51.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 06:54:27 INFO - PROCESS | 31734 | Values: 61.0 60.0 60.0 59.0 61.0 60.0 60.0 60.0 60.0 61.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:82.00 stddev:2.77 (3.4%) stddev-sans-first:2.92 06:54:27 INFO - PROCESS | 31734 | Values: 81.0 78.0 78.0 78.0 78.0 83.0 83.0 83.0 83.0 76.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:128.50 stddev:4.00 (3.1%) stddev-sans-first:4.06 06:54:27 INFO - PROCESS | 31734 | Values: 125.0 130.0 126.0 125.0 128.0 135.0 124.0 126.0 135.0 129.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:159.00 stddev:4.06 (2.6%) stddev-sans-first:4.21 06:54:27 INFO - PROCESS | 31734 | Values: 163.0 159.0 157.0 167.0 168.0 158.0 158.0 157.0 159.0 159.0 06:54:27 INFO - PROCESS | 31734 | 06:54:27 INFO - PROCESS | 31734 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:54:27 INFO - PROCESS | 31734 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 06:54:27 INFO - PROCESS | 31734 | -------- Summary: end -------- 06:54:27 INFO - PROCESS | 31734 | 06:54:28 INFO - TEST-INFO | 31734: exit 0 06:54:28 INFO - TEST-OK | kraken | took 61790ms 06:54:28 INFO - SUITE-END | took 1174s 06:54:28 INFO - Completed test suite (00:19:35) 06:54:28 INFO - javascript benchmark 06:54:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7419.488763087825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.9218519537008, 3140.434721750084, 3156.463401221792, 3160.5891234139567, 3173.46051171301, 5274.525292723654, 5427.864303392422, 5436.238926550282, 5460.453954604538, 5484.314460692413, 5374.167004114359, 5389.434109418514, 5405.567554595623, 5439.864003399917, 5531.668099914008, 4954.0, 4973.701577905319, 5059.392872855263, 5088.1095808233595, 5096.159133742928, 4992.77532511036, 5015.824446144386, 5057.924131138036, 5102.1836506159025, 5117.846464606049, 4794.089123066607, 4985.975070124662, 4995.900081998376, 5041.521055499722, 5078.0, 4869.488703686133, 4909.558139767402, 4928.457869634337, 4983.15286401309, 4984.0, 4913.287573301887, 4917.262410638397, 4921.901561968776, 4932.753362331869, 4942.110420124376, 5387.461253874581, 5439.972800136014, 5465.863353416196, 5482.671039737628, 5515.972420137914, 5763.077907534816, 5814.912776308359, 5829.067349224104, 5832.475077243069, 5848.0, 5826.650400975955, 5872.207252021008, 5890.469857712784, 5891.175235467038, 5892.322382925976, 5316.3354580677415, 5470.070088085035, 5483.287172667568, 5485.945140548623, 5489.505944464978, 5873.911891321633, 5916.408359164049, 5945.2865656120675, 5953.702314884238, 5958.314793798682, 5755.683437410982, 5759.0, 5761.049426844524, 5762.942370576325, 5768.0, 5658.603897727119, 5841.94158058414, 5846.181534585076, 5848.707564621837, 5854.590178687451, 5687.744051517691, 5699.658020518782, 5716.542676585863, 5735.139729040678, 5735.569832262597, 5734.512566431817, 5772.0, 5788.479036886616, 5802.303723553201, 5846.1230815377185, 4380.189664912002, 4434.490033646108, 4434.933475997863, 4436.112777444524, 4484.080763443486, 3944.309745794532, 3985.2228815381304, 4003.779792111462, 4010.939835902464, 4017.116234428421, 5561.944380556223, 5676.035074037423, 5676.120201368794, 5701.657900525982, 5731.942680573225, 5886.087656413263, 5897.439743224472, 5909.6158749681135, 5912.083627037816, 5915.7633694652595, 5446.673199608036, 5591.161325801081, 5640.125780504029, 5665.291838520185, 5666.178404131378, 5060.1903695408555, 5088.796448142033, 5095.388553373619, 5131.2559678846355, 5135.35808023997, 6108.8778224436155, 6115.205023347025, 6115.908261376083, 6119.326874043852, 6125.693715314305, 5714.942850571441, 5793.507551858139, 5859.326177489473, 5893.086571581412, 5893.292804863272, 6043.848903777441, 6112.985242459679, 6113.841195312776, 6114.540688159306, 6130.612163469634, 5778.537716982715, 5780.710964451845, 5784.1034639630925, 5797.59416840834, 5803.535717142703, 5652.0674088774895, 5754.136879468113, 5811.186433899342, 5881.147233651182, 5906.468417842415, 5677.148427735708, 5705.857353566194, 5710.3433105193435, 5752.367239603556, 5763.884722305615, 5655.010373184594, 5658.434156584309, 5688.345840228261, 5705.515031222392, 5711.914321285267, 5429.592780541554, 5541.9168712470155, 5625.21247025425, 5627.606067575231, 5629.971850140723, 5671.574631902541, 5696.401877802771, 5726.713664316684, 5753.0, 5784.739686714192, 5587.44125587438, 5601.719914004365, 5602.467765562265, 5605.5795815313195, 5608.551315894637], "value": 5387.980513293764, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.198649951784, 573.6443405088845, 590.0470739755297, 606.963582185069, 613.0191693290735, 41739.58260417395, 42872.35691464627, 42965.35551966723, 46137.769311153395, 46593.53406465935, 44765.7761711191, 45027.324590131095, 45048.77475612617, 45413.545864541346, 45843.08313833721, 8820.0, 9006.099390061006, 9012.098790121001, 9014.45913245204, 9020.8646870297, 8948.284137269004, 8965.237954773853, 9002.594883230271, 9004.144606262395, 9054.411463254868, 9023.142801433853, 9059.95470022649, 9064.274858011377, 9066.682666106688, 9087.0, 8963.282937365027, 8972.41679290844, 8995.235404990584, 8999.100089991014, 9045.954770226173, 8766.605502752327, 8852.424592401474, 8854.645814167425, 8872.689455869078, 8886.066962968924, 43320.78339608282, 43839.0, 43909.0, 43921.560784392066, 43953.0, 3362.2098806780386, 3392.1519620094978, 3455.2987570508612, 3509.2805974775365, 3510.2452972611013, 31274.37451250962, 33444.49833252503, 34096.31807363839, 34150.31699365999, 34153.658463415544, 4343.0, 4374.300111982099, 4494.70784399013, 4601.7699115044115, 4613.100445413146, 360363.0, 360506.0, 364225.0, 366409.0, 367899.0, 60476.0, 61163.38836611666, 61559.692201539605, 61803.38196618066, 61924.38075619186, 36964.44553331702, 65270.0, 65302.346976529625, 65345.34654653488, 65480.67259663671, 16532.256048477848, 17628.91185544064, 17645.823541764417, 17658.20538075764, 17693.911530442267, 13413.731725365438, 13420.261885596386, 13519.0, 13533.39099740514, 13570.660733481742, 19230.0, 19254.0, 19254.422367329003, 19255.903720481307, 19409.32067377635, 7102.18324892644, 7192.568445893263, 7294.708211671474, 7382.963085184647, 7403.555786652818, 940.5109343141528, 1099.5491848342142, 1100.1748688483638, 1133.2520536445907, 1158.79141754485, 33323.83338083343, 33449.0, 33530.49704254438, 33852.66147338495, 34266.14334641654, 1054.7204990677476, 1129.220837622038, 1147.8565179352581, 1241.698810991383, 1280.6286177008562, 17426.21582028812, 17636.559086022953, 17655.73516397255, 17724.822751772575, 17746.91126544359, 600893.0, 602680.0, 602804.0, 604404.0, 608148.0, 58538.7073064632, 58858.70570647119, 58979.410205897395, 59106.40893591095, 59247.40752592505, 1286.2475451860766, 1367.1045465220298, 1372.6911444924813, 1376.2361889151616, 1380.0822453068597, 29899.252518687208, 32227.0, 32746.345073097928, 33016.83491582527, 33222.16944576405, 45427.77286113548, 45462.54537454715, 45532.77233613811, 45751.313730293405, 45768.77115614401, 452217.0, 452222.0, 454007.0, 454221.0, 455109.0, 28766.137015889555, 28902.277443064093, 29116.56325155082, 29345.7065429343, 29811.403771924874, 48309.75845120892, 48433.515664842904, 49939.250911235635, 49984.0, 50287.0, 40911.38632920449, 41821.372679410444, 42083.57916420919, 42239.0, 43952.0, 41898.0, 41933.0, 41978.790106050496, 43055.0, 43471.565284346754, 41941.161176775684, 42135.36796948109, 43090.0, 43416.34875476807, 44222.336664949406, 32413.18967025749, 37583.24833503369, 38122.809385952896, 38307.425388618634, 38351.80824095861, 29174.854125729235, 29295.267618309714, 29674.851625741732, 29702.108936731933, 29838.55242171326], "value": 20605.33462711742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5820771774201, 390.95699473057977, 399.7321794397754, 404.70052161400565, 418.6169654765889, 14162.929185354085, 18303.267869285228, 18670.346537871144, 20215.595688086247, 20262.39212823614, 19357.322493712723, 19738.90130549345, 19809.405717828453, 20644.0, 20794.792052079476, 5626.803061892824, 5679.460451257124, 5680.517156041741, 5736.942630573682, 5773.307203135609, 5651.2935883014625, 5761.337446193678, 5788.016037273674, 5793.391693872146, 5799.0, 5556.611037227396, 5650.63270887391, 5734.770609175628, 5737.397573254811, 5752.626079304852, 5625.493705566478, 5706.600537962365, 5718.1136923776885, 5718.456746609066, 5720.542356611461, 4981.800727970877, 5086.77109530072, 5101.821436249714, 5126.359205099363, 5141.640085194038, 17542.0, 21688.566228675496, 23965.400864978514, 24055.15806946766, 24787.380315492075, 2332.918347857817, 2421.418859473731, 2467.8272520923542, 2468.456939473313, 2529.1021687300927, 15289.923550382176, 15443.227838608136, 15446.768298475532, 15480.45818396362, 15755.527334179993, 1957.862949593529, 1971.3297478857257, 1978.2977043149763, 1988.1749074134218, 2004.98997505013, 85320.57339713324, 86238.99999999937, 86629.56685216534, 88404.55797721035, 90030.549847251, 9807.656732014488, 10034.397936123856, 10093.848592271122, 10183.796324073624, 10329.380237185642, 14163.150210987375, 14184.716305673828, 14187.432502699983, 14195.29023548839, 14203.857961420254, 8111.75664730059, 8189.959050204711, 8368.3305335573, 8478.448900821428, 8514.446560973516, 8239.917600824036, 8252.917470825336, 8374.916250837536, 8518.829623407497, 8546.743597692079, 6298.401651843159, 6384.936150638527, 6407.519436042316, 6502.479801615859, 6588.143541339691, 1849.704047352417, 1863.6924907390128, 1895.933642322512, 1912.8522886268129, 1923.3268356075262, 959.8464245720651, 1027.773889744255, 1055.2929537210089, 1082.929609575375, 1144.5078616195117, 20826.687599686018, 20962.58074838525, 21101.78898210998, 21128.577428451346, 21171.47071323229, 1025.3847691385258, 1025.7692019295598, 1045.2056437107701, 1105.4464187726217, 1128.6388355726253, 11181.944090279496, 11941.761164776655, 12013.399330033464, 12106.576269830513, 12108.394580271128, 492531.0, 510055.0, 521979.0, 529161.0, 531179.0, 61452.0, 62803.685981570714, 64021.35978640154, 85367.14632853592, 91281.54359228161, 1026.199564339816, 1045.1064339989352, 1071.924965252425, 1083.0469187115289, 1090.2095980414135, 15912.0452772834, 16004.67990640204, 17694.646107078042, 19133.712994305373, 19269.614607707488, 44715.55284447114, 45314.0, 45716.54283457123, 46024.309635354824, 47548.0, 61646.69176654267, 64779.67610161919, 65735.67132164308, 66561.33438665746, 66830.3316966824, 8656.610452529778, 8708.0, 8735.0, 8841.0, 8904.154105359981, 13023.934880325538, 13044.673883152996, 13048.739025219633, 13640.113392629448, 14015.439382424589, 11332.830007549728, 11761.353125578175, 12203.75592488163, 12242.204256723284, 12315.507379704712, 11725.472353743931, 11849.940750296539, 11852.822207666719, 11861.0, 11902.226355286879, 11768.70578235551, 12005.519779208735, 12167.634970950885, 12291.877081229073, 12480.0, 8570.442921210102, 8755.474671519729, 8772.254358379609, 8897.599608017785, 8944.731658050268, 11496.48265828023, 11893.821592675944, 12009.519619215484, 12271.0, 12373.072019598747], "value": 9534.869400538335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.9703605927884, 1514.621344663834, 1631.796025496813, 1767.7701898753169, 1788.955276118096, 7649.082110146776, 8491.91508084919, 8575.742727718163, 9125.133112354324, 9129.726108216748, 8675.913240867589, 8888.911110888888, 8928.91071089289, 8958.686445974392, 9021.72934811955, 2397.568437681221, 2431.2706188143575, 2432.7567243275707, 2443.9755602444015, 2452.877356132195, 2423.151896836111, 2436.9756302437013, 2478.8016958643357, 2495.950080998379, 2503.2740505253455, 2445.3397582652674, 2445.4742230420457, 2452.3133522613607, 2454.128784281581, 2477.3930387055198, 2365.207655435431, 2396.2451827674226, 2405.5206048280356, 2411.44536756547, 2416.3113512648897, 2332.9650055249185, 2341.4497593065616, 2346.16711067572, 2349.565330413879, 2361.8346715729904, 8883.911160888438, 8897.911020889838, 8934.061923498004, 8941.016488186295, 8976.461412315282, 5293.947060529384, 5450.345958484968, 5456.699881506515, 5459.317585301837, 5461.126219804852, 3237.53055806909, 3377.9155521111925, 3389.3560223557447, 3393.9490907636405, 3421.9144521386916, 973.756560859785, 1012.8936461671492, 1021.7752094539189, 1022.3865680591659, 1030.3148406309795, 12509.812352814715, 12552.435140418704, 12555.0, 12563.183393079513, 12573.937130314382, 4703.811847526061, 4819.336759449052, 4902.803887844518, 4908.190148625436, 5025.974870125699, 10609.416482093404, 10648.467576621139, 10664.41345725977, 10668.519916603771, 10681.893181068246, 5403.83788486346, 5437.918431223535, 5457.45425457459, 5473.589480788877, 5522.088855338824, 4217.283061879488, 4732.858014259509, 4894.583960363338, 4920.0, 5065.797368105234, 4032.7580345179385, 4148.647364973951, 4154.376843473503, 4162.980069882898, 4305.677074219446, 1360.8017373632629, 1371.7599420101442, 1374.2647683489286, 1375.099309951983, 1394.400407824645, 986.5954958466995, 998.3610489286863, 1017.6285655735603, 1030.1501261459325, 1049.0191670787685, 6270.0908368287255, 6334.651594162273, 6373.0, 6413.839654008594, 6437.935620643827, 491.842610364687, 496.30765082709416, 499.0493110624267, 499.6876951905059, 507.9771410286546, 4357.346398040256, 4450.265706158512, 4456.197884380777, 4473.3960915276675, 4565.315202719618, 10330.225233107547, 10816.242862999672, 10828.837567436494, 10896.291741036966, 10900.291481053706, 10682.1988350874, 10723.731906702238, 10725.463726813628, 10758.731031724114, 10773.407462589634, 8003.199680032067, 8075.394345424117, 8252.752417427488, 8339.0, 8439.831203376021, 6184.165137706352, 6199.287081985449, 6309.747610095545, 6480.416762491398, 6502.317256687979, 10030.398176109456, 10205.336653117523, 10294.330868493824, 10346.844797327896, 10374.740631484274, 10203.642872499428, 10360.430176340073, 10378.688639340831, 10421.322614030063, 10467.738306542398, 7762.92237077622, 7933.444658873824, 7955.721549745731, 7984.600769961363, 8118.837623247384, 8790.164934331227, 8809.0, 8826.646934122564, 8837.690680826141, 8895.911040889509, 7493.250674932463, 7630.465867389229, 7722.15056343813, 7796.259355361231, 8032.4778889372, 7569.735059272899, 7697.191794861459, 7734.458587899018, 7741.264579864904, 7772.417068719982, 7294.562326260441, 7406.222346653739, 7442.4418168636485, 7449.739259125905, 7467.850642987001, 5404.405515393382, 5453.645513041798, 5464.453554644504, 5564.248826408383, 5665.773369065191, 5332.760025798771, 5500.862478437911, 5564.527015203591, 5567.081431563909, 5686.34607020198], "value": 4689.572849874748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.3404302030267, 321.26911276845175, 322.14309935571384, 331.1439927786671, 338.3554329003249, 5498.120300751875, 5556.083246264367, 5557.582816381817, 5616.747246373913, 5662.263905692254, 5487.506124448799, 5514.641548299358, 5527.170924361348, 5540.63985840921, 5550.888982220353, 4123.83504659814, 4209.3054645983375, 4304.816175551717, 4310.913781724364, 4336.891577710551, 4279.700420970534, 4283.421738065368, 4304.956950430503, 4318.935215971763, 4322.459692538433, 4281.336392859096, 4293.819199720071, 4317.4819021717285, 4331.1376108273425, 4343.9565604344025, 4035.878923632296, 4196.58034196581, 4233.576642335742, 4264.680148988808, 4335.176316499871, 3722.1997270586953, 3731.2350968051483, 3733.906652333686, 3736.6076561961145, 3738.8691395801015, 5341.305630268079, 5376.650517716336, 5378.811741589065, 5425.5856144015925, 5431.266778984826, 4613.538646135393, 4783.049543722231, 4864.7324397158145, 4896.975515122437, 4901.852944411673, 5655.1799989001365, 5678.006348888928, 5712.685802280873, 5726.255586773735, 5774.797882074149, 4077.4087757275324, 4079.2657321682086, 4088.9795551022353, 4095.6279646318517, 4106.835726570934, 5895.616784908967, 5930.7034648267845, 5949.382271800394, 5956.315023772235, 6029.366916473795, 4162.8135981245805, 4195.811188496525, 4199.2704741918, 4206.305959516707, 4213.241616508996, 4265.125649241898, 4270.636995855325, 4278.957210427918, 4282.143571285756, 4290.699651024398, 4711.764411779397, 4796.424429068465, 4877.658563900563, 4884.072026314989, 4888.364512613338, 5712.257406537124, 5727.284089488814, 5740.598158128974, 5748.712564371848, 5797.913031304533, 1440.9567712968628, 1444.5738507140418, 1454.8579365198268, 1465.8754005909404, 1475.7712554554062, 877.4719826376579, 930.3998920696113, 943.4622265308845, 974.5906719177963, 1002.8997100290059, 5593.0, 5653.406392328829, 5689.77240910359, 5690.715464226772, 5706.828795136153, 5887.35239123696, 5924.6149000314845, 5941.881162376728, 5956.970215148896, 5987.730552125077, 5391.757370918318, 5592.832215033555, 5626.35296940857, 5647.915281270784, 5728.510587247346, 3152.858121384543, 3161.8893338733033, 3169.8256595887447, 3173.2066983254185, 3174.714275715197, 5981.760729570856, 6144.446999770043, 6148.200733904564, 6238.313785483593, 6260.248770147611, 5906.468417842415, 5910.926318314539, 5914.940850591525, 5974.550434321994, 5982.4316689914385, 6131.724072416752, 6141.662208578482, 6193.38066193377, 6220.533459990519, 6239.0, 5742.196092546963, 5743.3395159557185, 5787.479126878601, 5806.200077975841, 5821.214136091573, 5752.626079304831, 5776.537876969748, 5807.76768929255, 5872.530197584098, 5909.734061967136, 5991.442225021438, 6097.817065488042, 6139.631622102688, 6255.840800395771, 6269.68651567429, 4192.406885383535, 4196.8111434984885, 4209.0, 4218.49378074633, 4234.724742891703, 5901.911471327848, 5932.673702946379, 5946.910796338145, 5953.702314884152, 5978.880422391615, 5541.1991102892525, 5693.718913244653, 5723.3672510645565, 5735.541156707537, 5789.681567513827, 5693.772249109989, 5702.372738998624, 5764.077747560538, 5775.509081727932, 5783.0, 5092.007058623532, 5662.943370566241, 5682.232898558642, 5707.086866101404, 5745.023346031101, 5750.539956803362, 5787.8553036174435, 5799.217105690678, 5810.4189581041555, 5824.864151490418, 5688.516476099578, 5704.0, 5717.3996730342715, 5718.685472299064, 5758.769649213985], "value": 4386.569728922165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.8731228378896, 707.1867352544573, 737.9040724705789, 768.8324104688684, 802.546561192926, 15507.302171402285, 16009.679806403894, 16043.0, 16085.115318657468, 16133.515994520154, 15474.922625386886, 15585.610359740984, 15601.843981560181, 15629.671477924361, 15668.529944101696, 651.7230177174705, 786.5555960882112, 801.4950581133907, 807.3823525003377, 811.926926576608, 797.2346547314585, 817.2971244729528, 818.2104269380047, 818.251300060444, 819.1767273889762, 863.5078005536847, 870.1472556894247, 870.4037734152095, 871.2463718883153, 871.7689812199741, 863.0290922711949, 865.0, 865.5585651317841, 865.7186414415308, 867.0, 624.8750249950028, 627.0969803482969, 631.2235949781748, 632.6741728010079, 633.3919437340159, 14690.0, 14898.627534311621, 14936.178510181935, 15016.324265408082, 15019.474318398803, 15814.367425302975, 15864.286107125206, 15921.761173582405, 16049.197540122947, 16061.437849675322, 12446.25322480645, 12565.811512827315, 12594.181378210387, 13334.599962001155, 13352.532661356807, 4009.1179940413354, 4066.552679205285, 4203.852865149705, 4208.137331846995, 4214.599613036757, 79163.6041819793, 80279.5986020072, 81088.59455702684, 81115.0, 81395.5930220351, 11859.229150105215, 11932.821007684892, 12352.938235308946, 12389.318587477776, 12671.619851404472, 23888.044478221025, 23913.282601521983, 23924.162654307016, 23935.880320598633, 23962.640560391606, 7794.727184548514, 8000.0, 8015.759527214076, 8446.028706698686, 8524.70163544273, 4860.8298709545, 4881.658283920092, 4889.535494128123, 4932.358793356841, 4997.475265097112, 3481.1819222482695, 3594.263176048904, 3595.496630471736, 3597.1546686528645, 3600.8739694111105, 563.1637019026742, 568.6389142894292, 584.9590528663038, 589.4341432225112, 602.9216201893726, 600.297176820208, 688.7968049425432, 722.1406526233765, 727.5416487612875, 770.872805987017, 9839.75400614976, 9896.505174741234, 10313.9484302578, 10330.276880618285, 10813.783724325469, 619.0188551146483, 688.9345512176335, 736.8784150615088, 736.9742059027908, 755.52401986748, 4626.930596041062, 4658.464276608166, 4727.739974301447, 4734.218853889139, 4824.541668541483, 102282.3060039905, 105022.94977050285, 107043.46478267558, 113742.0, 125170.0, 63355.0, 72675.0, 95492.52253738826, 99237.0, 100639.0, 58522.7073864628, 82547.0, 88344.5582772082, 91544.99999999866, 92424.53787731018, 9570.377925434825, 9615.423074615546, 9752.366096203725, 10319.226058045526, 10452.216083793593, 38935.858527781245, 43012.569874302106, 50626.493735063654, 52226.73886630694, 53916.19125713039, 47057.2941405886, 47169.528304716514, 65025.674871627234, 77139.0, 79184.0, 12952.352382381032, 13264.801027984395, 13308.268045257604, 13507.392167352296, 13934.372953217333, 15163.620909477351, 15216.771748424004, 15385.0, 16130.758038629196, 16134.435294764628, 14208.857911420753, 14309.713805723619, 14763.630909227355, 15212.315445804745, 15316.770248446504, 14274.785878211627, 14534.563963081124, 14600.707985840012, 14922.776158357416, 15144.621384465476, 13320.600381988555, 13491.460341586228, 13689.31553422305, 13831.308434578432, 14273.928630356782, 11746.29522228669, 11767.941160294144, 11971.16201865861, 11975.820362694742, 12459.0, 9822.656207033006, 11120.720252348088, 12232.938835305766, 12272.570460033856, 12525.0], "value": 7659.859507530758, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 108.0, 112.0, 112.0, 113.0, 113.0, 111.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 156.0, 186.0, 122.0, 148.0, 152.0, 122.0, 181.0, 118.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 164.0, 171.0, 166.0, 162.0, 162.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 178.0, 81.0, 76.0, 75.0, 76.0, 170.0, 78.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 144.0, 84.0, 84.0, 83.0, 139.0, 84.0, 84.0, 152.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 57.0, 52.0, 51.0, 52.0, 52.0, 51.0, 54.0, 51.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 78.0, 78.0, 78.0, 83.0, 83.0, 83.0, 83.0, 76.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 126.0, 125.0, 128.0, 135.0, 124.0, 126.0, 135.0, 129.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 157.0, 167.0, 168.0, 158.0, 158.0, 157.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}]}]} 06:54:28 INFO - Return code: 0 06:54:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:54:28 ERROR - # TBPL SUCCESS # 06:54:28 INFO - Running post-action listener: _resource_record_post_action 06:54:28 INFO - [mozharness: 2016-08-06 13:54:28.732678Z] Finished run-tests step (success) 06:54:28 INFO - Running post-run listener: _resource_record_post_run 06:54:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 543920128; Read time: 0; Write time: 399156 06:54:28 INFO - TinderboxPrint: CPU usage
13.3% 06:54:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:54:28 INFO - TinderboxPrint: I/O write bytes / time
543,920,128 / 399,156 06:54:28 INFO - TinderboxPrint: CPU idle
8,241.5 (86.6%) 06:54:28 INFO - TinderboxPrint: CPU user
1,214.0 (12.8%) 06:54:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:54:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248975360; Read time: 0; Write time: 225916 06:54:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294944768; Read time: 0; Write time: 173240 06:54:29 INFO - Running post-run listener: _upload_blobber_files 06:54:29 INFO - Blob upload gear active. 06:54:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:54:29 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 06:54:29 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:54:29 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:54:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:54:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:54:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:30 INFO - (blobuploader) - INFO - Done attempting. 06:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:33 INFO - (blobuploader) - INFO - Done attempting. 06:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:34 INFO - (blobuploader) - INFO - Done attempting. 06:54:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:54:34 INFO - Return code: 0 06:54:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:54:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:54:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4843947f791f8bcd197a9e74ba3cbaea06d00517fe5163f46af0b711ec9761560dc67c7eef443a6cb86d17ff0fc9b5927322a0da428cb6e303c4d2b776a10274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c022b577c150a3e1aca93ad22e41e3df23d24195a4888c813715437331e59d2de9d62f569f55a0e6eb6a6c4d969d9f0d411bd9c8439b11446a889f63abdc34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b68056db4f0573999662853f9bc6b6cfa3635f7ae9ec69ffeb581f26d7d742ef4ed52e2da41fb5c7b0eff83a25f626a9144de1be039d5b5bfaf61c8e1506d58"} 06:54:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:54:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:54:34 INFO - Contents: 06:54:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4843947f791f8bcd197a9e74ba3cbaea06d00517fe5163f46af0b711ec9761560dc67c7eef443a6cb86d17ff0fc9b5927322a0da428cb6e303c4d2b776a10274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c022b577c150a3e1aca93ad22e41e3df23d24195a4888c813715437331e59d2de9d62f569f55a0e6eb6a6c4d969d9f0d411bd9c8439b11446a889f63abdc34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b68056db4f0573999662853f9bc6b6cfa3635f7ae9ec69ffeb581f26d7d742ef4ed52e2da41fb5c7b0eff83a25f626a9144de1be039d5b5bfaf61c8e1506d58"} 06:54:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:54:34 INFO - Copying logs to upload dir... 06:54:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:54:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.773020 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-08-06 06:54:34.262040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 06:54:34.265671) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4843947f791f8bcd197a9e74ba3cbaea06d00517fe5163f46af0b711ec9761560dc67c7eef443a6cb86d17ff0fc9b5927322a0da428cb6e303c4d2b776a10274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c022b577c150a3e1aca93ad22e41e3df23d24195a4888c813715437331e59d2de9d62f569f55a0e6eb6a6c4d969d9f0d411bd9c8439b11446a889f63abdc34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b68056db4f0573999662853f9bc6b6cfa3635f7ae9ec69ffeb581f26d7d742ef4ed52e2da41fb5c7b0eff83a25f626a9144de1be039d5b5bfaf61c8e1506d58"} build_url:https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4843947f791f8bcd197a9e74ba3cbaea06d00517fe5163f46af0b711ec9761560dc67c7eef443a6cb86d17ff0fc9b5927322a0da428cb6e303c4d2b776a10274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c022b577c150a3e1aca93ad22e41e3df23d24195a4888c813715437331e59d2de9d62f569f55a0e6eb6a6c4d969d9f0d411bd9c8439b11446a889f63abdc34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b68056db4f0573999662853f9bc6b6cfa3635f7ae9ec69ffeb581f26d7d742ef4ed52e2da41fb5c7b0eff83a25f626a9144de1be039d5b5bfaf61c8e1506d58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 06:54:34.290774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:54:34.291092) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1470490443.283668-1978380222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:54:34.375156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 06:54:34.375489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 06:54:34.375785) ========= ========= Total master_lag: 0.17 =========