builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1470614248.25 results: success (0) buildid: 20160807150652 builduid: 5d0255e5fbda4650869c42fbb26aebb6 revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.250624) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.251037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.251352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.279842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.280112) ========= 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=920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 16:57:29-- 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% 67.5M=0s 2016-08-07 16:57:29 (67.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.391802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.392519) ========= 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=920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020325 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.441958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:28.442291) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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=920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 16:57:29,834 truncating revision to first 12 chars 2016-08-07 16:57:29,834 Setting DEBUG logging. 2016-08-07 16:57:29,834 attempt 1/10 2016-08-07 16:57:29,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/763fe887c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 16:57:30,135 unpacking tar archive at: fx-team-763fe887c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689687 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:29.151279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:29.152054) ========= script_repo_revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:29.152868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:29.153161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:29.166347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-07 16:57:29.166666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:57:30 INFO - MultiFileLogger online at 20160807 16:57:30 in /builds/slave/test 16:57:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:57:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:30 INFO - {'append_to_log': False, 16:57:30 INFO - 'base_work_dir': '/builds/slave/test', 16:57:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:30 INFO - 'branch': 'Fx-Team-Non-PGO', 16:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:30 INFO - 'config_files': ('talos/linux_config.py',), 16:57:30 INFO - 'default_actions': ('clobber', 16:57:30 INFO - 'read-buildbot-config', 16:57:30 INFO - 'download-and-extract', 16:57:30 INFO - 'populate-webroot', 16:57:30 INFO - 'create-virtualenv', 16:57:30 INFO - 'install', 16:57:30 INFO - 'run-tests'), 16:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:30 INFO - 'download_minidump_stackwalk': True, 16:57:30 INFO - 'download_symbols': 'ondemand', 16:57:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:30 INFO - 'installer_path': 'installer.exe', 16:57:30 INFO - 'log_level': 'info', 16:57:30 INFO - 'log_name': 'talos', 16:57:30 INFO - 'log_to_console': True, 16:57:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:57:30 INFO - 'opt_config_files': (), 16:57:30 INFO - 'pip_index': False, 16:57:30 INFO - 'sps_profile': False, 16:57:30 INFO - 'sps_profile_interval': 0, 16:57:30 INFO - 'suite': 'dromaeojs-e10s', 16:57:30 INFO - 'system_bits': '32', 16:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:30 INFO - 'title': 'talos-linux64-ix-053', 16:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:30 INFO - 'use_talos_json': True, 16:57:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:30 INFO - 'work_dir': 'build'} 16:57:30 INFO - [mozharness: 2016-08-07 23:57:30.650745Z] Running clobber step. 16:57:30 INFO - Running pre-action listener: _resource_record_pre_action 16:57:30 INFO - Running main action method: clobber 16:57:30 INFO - rmtree: /builds/slave/test/build 16:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:31 INFO - Running post-action listener: _resource_record_post_action 16:57:31 INFO - [mozharness: 2016-08-07 23:57:31.108782Z] Finished clobber step (success) 16:57:31 INFO - [mozharness: 2016-08-07 23:57:31.108885Z] Running read-buildbot-config step. 16:57:31 INFO - Running pre-action listener: _resource_record_pre_action 16:57:31 INFO - Running main action method: read_buildbot_config 16:57:31 INFO - Using buildbot properties: 16:57:31 INFO - { 16:57:31 INFO - "project": "", 16:57:31 INFO - "product": "firefox", 16:57:31 INFO - "script_repo_revision": "production", 16:57:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:57:31 INFO - "repository": "", 16:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:57:31 INFO - "buildid": "20160807150652", 16:57:31 INFO - "pgo_build": "False", 16:57:31 INFO - "basedir": "/builds/slave/test", 16:57:31 INFO - "buildnumber": 1732, 16:57:31 INFO - "slavename": "talos-linux64-ix-053", 16:57:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:57:31 INFO - "platform": "ubuntu64_hw", 16:57:31 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 16:57:31 INFO - "branch": "fx-team", 16:57:31 INFO - "repo_path": "integration/fx-team", 16:57:31 INFO - "revision": "763fe887c37cee5fcfe0f00e94fdffc84a41ea1c", 16:57:31 INFO - "stage_platform": "linux64", 16:57:31 INFO - "builduid": "5d0255e5fbda4650869c42fbb26aebb6", 16:57:31 INFO - "slavebuilddir": "test" 16:57:31 INFO - } 16:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:57:31 INFO - Running post-action listener: _resource_record_post_action 16:57:31 INFO - [mozharness: 2016-08-07 23:57:31.111406Z] Finished read-buildbot-config step (success) 16:57:31 INFO - [mozharness: 2016-08-07 23:57:31.111497Z] Running download-and-extract step. 16:57:31 INFO - Running pre-action listener: _resource_record_pre_action 16:57:31 INFO - Running main action method: download_and_extract 16:57:31 INFO - mkdir: /builds/slave/test/build/tests 16:57: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')]} 16:57:31 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:57:31 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:31 INFO - Downloaded 1361 bytes. 16:57:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:57:31 INFO - Using the following test package requirements: 16:57:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:57:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:57:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'jsshell-linux-x86_64.zip'], 16:57:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:57:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:57:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:57:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:57:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:57:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:57: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')]} 16:57:31 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:57:31 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:32 INFO - Downloaded 20257784 bytes. 16:57:32 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'] 16:57:32 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 16:57:33 INFO - Return code: 0 16:57:33 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 16:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:33 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:57:33 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:34 INFO - Downloaded 20257784 bytes. 16:57:34 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'] 16:57:34 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 16:57:35 INFO - Return code: 0 16:57: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')]} 16:57:35 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:35 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:36 INFO - Downloaded 14413723 bytes. 16:57:36 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'] 16:57:36 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 16:57:37 INFO - Return code: 0 16:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:37 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:57:37 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:38 INFO - Downloaded 56131100 bytes. 16:57:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:57:38 INFO - mkdir: /builds/slave/test/properties 16:57:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:38 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:38 INFO - Contents: 16:57:38 INFO - build_url:https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:57:39 INFO - Running post-action listener: _resource_record_post_action 16:57:39 INFO - Running post-action listener: set_extra_try_arguments 16:57:39 INFO - [mozharness: 2016-08-07 23:57:39.075294Z] Finished download-and-extract step (success) 16:57:39 INFO - [mozharness: 2016-08-07 23:57:39.075529Z] Running populate-webroot step. 16:57:39 INFO - Running pre-action listener: _resource_record_pre_action 16:57:39 INFO - Running main action method: populate_webroot 16:57:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:39 INFO - '--tppagecycles', 16:57:39 INFO - '7'], 16:57:39 INFO - 'tests': ['tsvgm']}}, 16:57:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['damp', 'tps']}, 16:57:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'tests': ['damp', 'tps']}, 16:57:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['dromaeo_dom']}, 16:57:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['basic_compositor_video']}, 16:57:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:57:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['a11yr', 16:57:39 INFO - 'ts_paint', 16:57:39 INFO - 'tpaint', 16:57:39 INFO - 'sessionrestore', 16:57:39 INFO - 'sessionrestore_no_auto_restore', 16:57:39 INFO - 'tabpaint']}, 16:57:39 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:39 INFO - 'ts_paint', 16:57:39 INFO - 'tpaint', 16:57:39 INFO - 'sessionrestore', 16:57:39 INFO - 'sessionrestore_no_auto_restore', 16:57:39 INFO - 'tabpaint']}, 16:57:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:39 INFO - 'ts_paint', 16:57:39 INFO - 'tpaint', 16:57:39 INFO - 'sessionrestore', 16:57:39 INFO - 'sessionrestore_no_auto_restore', 16:57:39 INFO - 'tabpaint']}, 16:57:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:39 INFO - 'ts_paint', 16:57:39 INFO - 'tpaint', 16:57:39 INFO - 'sessionrestore', 16:57:39 INFO - 'sessionrestore_no_auto_restore', 16:57:39 INFO - 'tabpaint']}, 16:57:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['a11yr', 16:57:39 INFO - 'ts_paint', 16:57:39 INFO - 'tpaint', 16:57:39 INFO - 'sessionrestore', 16:57:39 INFO - 'sessionrestore_no_auto_restore', 16:57:39 INFO - 'tabpaint']}, 16:57:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['a11yr', 16:57:39 INFO - 'ts_paint', 16:57:39 INFO - 'tpaint', 16:57:39 INFO - 'sessionrestore', 16:57:39 INFO - 'sessionrestore_no_auto_restore', 16:57:39 INFO - 'tabpaint']}, 16:57:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['tsvgx', 16:57:39 INFO - 'tsvgr_opacity', 16:57:39 INFO - 'tart', 16:57:39 INFO - 'tscrollx', 16:57:39 INFO - 'cart']}, 16:57:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:39 INFO - 'tsvgr_opacity', 16:57:39 INFO - 'tart', 16:57:39 INFO - 'tscrollx', 16:57:39 INFO - 'cart']}, 16:57:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'talos_options': ['--disable-e10s'], 16:57:39 INFO - 'tests': ['tp5o']}, 16:57:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'tests': ['tp5o']}, 16:57:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'talos_options': ['--disable-e10s', 16:57:39 INFO - '--xperf_path', 16:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:39 INFO - 'tests': ['tp5n']}, 16:57:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:39 INFO - 'talos_options': ['--xperf_path', 16:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:39 INFO - 'tests': ['tp5n']}}, 16:57:39 INFO - 'talos.zip': {'path': '', 16:57:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:39 INFO - Running post-action listener: _resource_record_post_action 16:57:39 INFO - [mozharness: 2016-08-07 23:57:39.095689Z] Finished populate-webroot step (success) 16:57:39 INFO - [mozharness: 2016-08-07 23:57:39.095778Z] Running create-virtualenv step. 16:57:39 INFO - Running pre-action listener: _resource_record_pre_action 16:57:39 INFO - Running main action method: create_virtualenv 16:57:39 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:39 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 16:57:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:39 INFO - Using real prefix '/usr' 16:57:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:39 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:41 INFO - Installing pip.................done. 16:57:41 INFO - Return code: 0 16:57:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:41 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')]} 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:41 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')]} 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:41 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:41 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 16:57:41 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 16:57:41 INFO - Using env: {'DISPLAY': ':0', 16:57:41 INFO - 'HOME': '/home/cltbld', 16:57:41 INFO - 'LANG': 'en_US.UTF-8', 16:57:41 INFO - 'LANGUAGE': 'en_US:en', 16:57:41 INFO - 'LOGNAME': 'cltbld', 16:57:41 INFO - 'MAIL': '/var/mail/cltbld', 16:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:41 INFO - 'MOZ_NO_REMOTE': '1', 16:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:41 INFO - 'NO_EM_RESTART': '1', 16:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:41 INFO - 'PWD': '/builds/slave/test', 16:57:41 INFO - 'SHELL': '/bin/bash', 16:57:41 INFO - 'SHLVL': '1', 16:57:41 INFO - 'TERM': 'linux', 16:57:41 INFO - 'TMOUT': '86400', 16:57:41 INFO - 'USER': 'cltbld', 16:57:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:41 INFO - '_': '/tools/buildbot/bin/python'} 16:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:41 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 16:57:41 INFO - Cleaning up... 16:57:42 INFO - Return code: 0 16:57:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:42 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:42 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 16:57:42 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 16:57:42 INFO - Using env: {'DISPLAY': ':0', 16:57:42 INFO - 'HOME': '/home/cltbld', 16:57:42 INFO - 'LANG': 'en_US.UTF-8', 16:57:42 INFO - 'LANGUAGE': 'en_US:en', 16:57:42 INFO - 'LOGNAME': 'cltbld', 16:57:42 INFO - 'MAIL': '/var/mail/cltbld', 16:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:42 INFO - 'MOZ_NO_REMOTE': '1', 16:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:42 INFO - 'NO_EM_RESTART': '1', 16:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:42 INFO - 'PWD': '/builds/slave/test', 16:57:42 INFO - 'SHELL': '/bin/bash', 16:57:42 INFO - 'SHLVL': '1', 16:57:42 INFO - 'TERM': 'linux', 16:57:42 INFO - 'TMOUT': '86400', 16:57:42 INFO - 'USER': 'cltbld', 16:57:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:42 INFO - '_': '/tools/buildbot/bin/python'} 16:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:42 INFO - Downloading/unpacking psutil>=3.1.1 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:44 INFO - Installing collected packages: psutil 16:57:44 INFO - Running setup.py install for psutil 16:57:44 INFO - building 'psutil._psutil_linux' extension 16:57:44 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 16:57:44 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 16:57:44 INFO - building 'psutil._psutil_posix' extension 16:57:44 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 16:57:44 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 16:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:44 INFO - Successfully installed psutil 16:57:44 INFO - Cleaning up... 16:57:44 INFO - Return code: 0 16:57:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:44 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:44 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 16:57:44 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 16:57:44 INFO - Using env: {'DISPLAY': ':0', 16:57:44 INFO - 'HOME': '/home/cltbld', 16:57:44 INFO - 'LANG': 'en_US.UTF-8', 16:57:44 INFO - 'LANGUAGE': 'en_US:en', 16:57:44 INFO - 'LOGNAME': 'cltbld', 16:57:44 INFO - 'MAIL': '/var/mail/cltbld', 16:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:44 INFO - 'MOZ_NO_REMOTE': '1', 16:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:44 INFO - 'NO_EM_RESTART': '1', 16:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:44 INFO - 'PWD': '/builds/slave/test', 16:57:44 INFO - 'SHELL': '/bin/bash', 16:57:44 INFO - 'SHLVL': '1', 16:57:44 INFO - 'TERM': 'linux', 16:57:44 INFO - 'TMOUT': '86400', 16:57:44 INFO - 'USER': 'cltbld', 16:57:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:44 INFO - '_': '/tools/buildbot/bin/python'} 16:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57:44 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 16:57:44 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 16:57:44 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 16:57:44 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 16:57:44 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 16:57:44 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 16:57:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:46 INFO - Installing collected packages: mozsystemmonitor 16:57:46 INFO - Running setup.py install for mozsystemmonitor 16:57:46 INFO - Successfully installed mozsystemmonitor 16:57:46 INFO - Cleaning up... 16:57:47 INFO - Return code: 0 16:57:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57:47 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')]} 16:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:47 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')]} 16:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:47 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:47 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 16:57:47 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 16:57:47 INFO - Using env: {'DISPLAY': ':0', 16:57:47 INFO - 'HOME': '/home/cltbld', 16:57:47 INFO - 'LANG': 'en_US.UTF-8', 16:57:47 INFO - 'LANGUAGE': 'en_US:en', 16:57:47 INFO - 'LOGNAME': 'cltbld', 16:57:47 INFO - 'MAIL': '/var/mail/cltbld', 16:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:47 INFO - 'MOZ_NO_REMOTE': '1', 16:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:47 INFO - 'NO_EM_RESTART': '1', 16:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:47 INFO - 'PWD': '/builds/slave/test', 16:57:47 INFO - 'SHELL': '/bin/bash', 16:57:47 INFO - 'SHLVL': '1', 16:57:47 INFO - 'TERM': 'linux', 16:57:47 INFO - 'TMOUT': '86400', 16:57:47 INFO - 'USER': 'cltbld', 16:57:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:47 INFO - '_': '/tools/buildbot/bin/python'} 16:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:47 INFO - Downloading/unpacking jsonschema==2.5.1 16:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:49 INFO - warning: no files found matching '*.txt' 16:57:49 INFO - no previously-included directories found matching 'build' 16:57:49 INFO - no previously-included directories found matching 'dist' 16:57:49 INFO - no previously-included directories found matching '.git*' 16:57:49 INFO - Installing collected packages: jsonschema, functools32 16:57:49 INFO - Running setup.py install for functools32 16:57:49 INFO - warning: no files found matching '*.txt' 16:57:49 INFO - no previously-included directories found matching 'build' 16:57:49 INFO - no previously-included directories found matching 'dist' 16:57:49 INFO - no previously-included directories found matching '.git*' 16:57:49 INFO - Successfully installed jsonschema functools32 16:57:49 INFO - Cleaning up... 16:57:49 INFO - Return code: 0 16:57:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:57:49 INFO - Using env: {'DISPLAY': ':0', 16:57:49 INFO - 'HOME': '/home/cltbld', 16:57:49 INFO - 'LANG': 'en_US.UTF-8', 16:57:49 INFO - 'LANGUAGE': 'en_US:en', 16:57:49 INFO - 'LOGNAME': 'cltbld', 16:57:49 INFO - 'MAIL': '/var/mail/cltbld', 16:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:49 INFO - 'MOZ_NO_REMOTE': '1', 16:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:49 INFO - 'NO_EM_RESTART': '1', 16:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:49 INFO - 'PWD': '/builds/slave/test', 16:57:49 INFO - 'SHELL': '/bin/bash', 16:57:49 INFO - 'SHLVL': '1', 16:57:49 INFO - 'TERM': 'linux', 16:57:49 INFO - 'TMOUT': '86400', 16:57:49 INFO - 'USER': 'cltbld', 16:57:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:49 INFO - '_': '/tools/buildbot/bin/python'} 16:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:57:49 INFO - Cleaning up... 16:57:49 INFO - Return code: 0 16:57:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:57:49 INFO - Using env: {'DISPLAY': ':0', 16:57:49 INFO - 'HOME': '/home/cltbld', 16:57:49 INFO - 'LANG': 'en_US.UTF-8', 16:57:49 INFO - 'LANGUAGE': 'en_US:en', 16:57:49 INFO - 'LOGNAME': 'cltbld', 16:57:49 INFO - 'MAIL': '/var/mail/cltbld', 16:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:49 INFO - 'MOZ_NO_REMOTE': '1', 16:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:49 INFO - 'NO_EM_RESTART': '1', 16:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:49 INFO - 'PWD': '/builds/slave/test', 16:57:49 INFO - 'SHELL': '/bin/bash', 16:57:49 INFO - 'SHLVL': '1', 16:57:49 INFO - 'TERM': 'linux', 16:57:49 INFO - 'TMOUT': '86400', 16:57:49 INFO - 'USER': 'cltbld', 16:57:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:49 INFO - '_': '/tools/buildbot/bin/python'} 16:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:50 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 16:57:50 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 16:57:50 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 16:57:50 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 16:57:50 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 16:57:50 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 16:57:51 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:51 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 16:57:51 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 16:57:51 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 16:57:51 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 16:57:51 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 16:57:51 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 16:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:52 INFO - Downloading docopt-0.6.1.tar.gz 16:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:52 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:52 INFO - Running setup.py install for blobuploader 16:57:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:52 INFO - Running setup.py install for requests 16:57:53 INFO - Running setup.py install for docopt 16:57:53 INFO - Successfully installed blobuploader requests docopt 16:57:53 INFO - Cleaning up... 16:57:53 INFO - Return code: 0 16:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:53 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:53 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 16:57:53 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 16:57:53 INFO - Using env: {'DISPLAY': ':0', 16:57:53 INFO - 'HOME': '/home/cltbld', 16:57:53 INFO - 'LANG': 'en_US.UTF-8', 16:57:53 INFO - 'LANGUAGE': 'en_US:en', 16:57:53 INFO - 'LOGNAME': 'cltbld', 16:57:53 INFO - 'MAIL': '/var/mail/cltbld', 16:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:53 INFO - 'MOZ_NO_REMOTE': '1', 16:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:53 INFO - 'NO_EM_RESTART': '1', 16:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:53 INFO - 'PWD': '/builds/slave/test', 16:57:53 INFO - 'SHELL': '/bin/bash', 16:57:53 INFO - 'SHLVL': '1', 16:57:53 INFO - 'TERM': 'linux', 16:57:53 INFO - 'TMOUT': '86400', 16:57:53 INFO - 'USER': 'cltbld', 16:57:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:53 INFO - '_': '/tools/buildbot/bin/python'} 16:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:53 INFO - Running setup.py (path:/tmp/pip-JmW2mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:53 INFO - Running setup.py (path:/tmp/pip-aQNa7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:53 INFO - Running setup.py (path:/tmp/pip-fSfDVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:53 INFO - Running setup.py (path:/tmp/pip-Ai3nvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:53 INFO - Running setup.py (path:/tmp/pip-EJ_M4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:53 INFO - Running setup.py (path:/tmp/pip-XlHvpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:53 INFO - Running setup.py (path:/tmp/pip-fj0EJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:53 INFO - Running setup.py (path:/tmp/pip-uKV0XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:54 INFO - Running setup.py (path:/tmp/pip-JqCYDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:54 INFO - Running setup.py (path:/tmp/pip-gqKC1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:54 INFO - Running setup.py (path:/tmp/pip-Y7TGPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:54 INFO - Running setup.py (path:/tmp/pip-IeeHKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:54 INFO - Running setup.py (path:/tmp/pip-1lcJx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:54 INFO - Running setup.py (path:/tmp/pip-Gx1gS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:54 INFO - Running setup.py (path:/tmp/pip-7BMxsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:54 INFO - Running setup.py (path:/tmp/pip-hzrJ7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:54 INFO - Running setup.py (path:/tmp/pip-GjHA6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:54 INFO - Running setup.py install for manifestparser 16:57:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:54 INFO - Running setup.py install for mozcrash 16:57:54 INFO - Running setup.py install for mozdebug 16:57:54 INFO - Running setup.py install for mozdevice 16:57:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Running setup.py install for mozfile 16:57:55 INFO - Running setup.py install for mozhttpd 16:57:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Running setup.py install for mozinfo 16:57:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Running setup.py install for mozInstall 16:57:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Running setup.py install for mozleak 16:57:55 INFO - Running setup.py install for mozlog 16:57:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Running setup.py install for moznetwork 16:57:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:55 INFO - Running setup.py install for mozprocess 16:57:55 INFO - Running setup.py install for mozprofile 16:57:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:56 INFO - Running setup.py install for mozrunner 16:57:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:56 INFO - Running setup.py install for mozscreenshot 16:57:56 INFO - Running setup.py install for moztest 16:57:56 INFO - Running setup.py install for mozversion 16:57:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:56 INFO - Cleaning up... 16:57:56 INFO - Return code: 0 16:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:56 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:57:56 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 16:57:56 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 16:57:56 INFO - Using env: {'DISPLAY': ':0', 16:57:56 INFO - 'HOME': '/home/cltbld', 16:57:56 INFO - 'LANG': 'en_US.UTF-8', 16:57:56 INFO - 'LANGUAGE': 'en_US:en', 16:57:56 INFO - 'LOGNAME': 'cltbld', 16:57:56 INFO - 'MAIL': '/var/mail/cltbld', 16:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:56 INFO - 'MOZ_NO_REMOTE': '1', 16:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:56 INFO - 'NO_EM_RESTART': '1', 16:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:56 INFO - 'PWD': '/builds/slave/test', 16:57:56 INFO - 'SHELL': '/bin/bash', 16:57:56 INFO - 'SHLVL': '1', 16:57:56 INFO - 'TERM': 'linux', 16:57:56 INFO - 'TMOUT': '86400', 16:57:56 INFO - 'USER': 'cltbld', 16:57:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:56 INFO - '_': '/tools/buildbot/bin/python'} 16:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:56 INFO - Running setup.py (path:/tmp/pip-1IOuC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:56 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)) 16:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:56 INFO - Running setup.py (path:/tmp/pip-qROhGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:56 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)) 16:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:56 INFO - Running setup.py (path:/tmp/pip-cGl1lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:56 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)) 16:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:56 INFO - Running setup.py (path:/tmp/pip-EIvaIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:56 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)) 16:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:56 INFO - Running setup.py (path:/tmp/pip-ftpLEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:57 INFO - Running setup.py (path:/tmp/pip-1ZoSrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:57 INFO - Running setup.py (path:/tmp/pip-2j_VRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:57 INFO - Running setup.py (path:/tmp/pip-VBKpPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:57 INFO - Running setup.py (path:/tmp/pip-yNyJjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:57 INFO - Running setup.py (path:/tmp/pip-4p1g1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:57 INFO - Running setup.py (path:/tmp/pip-_jZIdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:57 INFO - Running setup.py (path:/tmp/pip-nRK261-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:57 INFO - Running setup.py (path:/tmp/pip-5cEUpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:57 INFO - Running setup.py (path:/tmp/pip-X4kK2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:57 INFO - Running setup.py (path:/tmp/pip-N0zNCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:57 INFO - Running setup.py (path:/tmp/pip-2XrNq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:57 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)) 16:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:57 INFO - Running setup.py (path:/tmp/pip-8ZatBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:57 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)) 16:57:57 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)) 16:57:57 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)) 16:57:57 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)) 16:57:57 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)) 16:57:57 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)) 16:57:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:00 INFO - Downloading blessings-1.6.tar.gz 16:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:00 INFO - Installing collected packages: blessings 16:58:00 INFO - Running setup.py install for blessings 16:58:00 INFO - Successfully installed blessings 16:58:00 INFO - Cleaning up... 16:58:00 INFO - Return code: 0 16:58:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:00 INFO - Reading from file tmpfile_stdout 16:58:00 INFO - Current package versions: 16:58:00 INFO - argparse == 1.2.1 16:58:00 INFO - blessings == 1.6 16:58:00 INFO - blobuploader == 1.2.4 16:58:00 INFO - docopt == 0.6.1 16:58:00 INFO - functools32 == 3.2.3-2 16:58:00 INFO - jsonschema == 2.5.1 16:58:00 INFO - manifestparser == 1.1 16:58:00 INFO - mozInstall == 1.12 16:58:00 INFO - mozcrash == 0.17 16:58:00 INFO - mozdebug == 0.1 16:58:00 INFO - mozdevice == 0.48 16:58:00 INFO - mozfile == 1.2 16:58:00 INFO - mozhttpd == 0.7 16:58:00 INFO - mozinfo == 0.9 16:58:00 INFO - mozleak == 0.1 16:58:00 INFO - mozlog == 3.3 16:58:00 INFO - moznetwork == 0.27 16:58:00 INFO - mozprocess == 0.23 16:58:00 INFO - mozprofile == 0.28 16:58:00 INFO - mozrunner == 6.12 16:58:00 INFO - mozscreenshot == 0.1 16:58:00 INFO - mozsystemmonitor == 0.3 16:58:00 INFO - moztest == 0.7 16:58:00 INFO - mozversion == 1.4 16:58:00 INFO - psutil == 3.1.1 16:58:00 INFO - requests == 1.2.3 16:58:00 INFO - wsgiref == 0.1.2 16:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:00 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 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:58:00 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 16:58:00 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 16:58:00 INFO - Using env: {'DISPLAY': ':0', 16:58:00 INFO - 'HOME': '/home/cltbld', 16:58:00 INFO - 'LANG': 'en_US.UTF-8', 16:58:00 INFO - 'LANGUAGE': 'en_US:en', 16:58:00 INFO - 'LOGNAME': 'cltbld', 16:58:00 INFO - 'MAIL': '/var/mail/cltbld', 16:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:00 INFO - 'MOZ_NO_REMOTE': '1', 16:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:00 INFO - 'NO_EM_RESTART': '1', 16:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:00 INFO - 'PWD': '/builds/slave/test', 16:58:00 INFO - 'SHELL': '/bin/bash', 16:58:00 INFO - 'SHLVL': '1', 16:58:00 INFO - 'TERM': 'linux', 16:58:00 INFO - 'TMOUT': '86400', 16:58:00 INFO - 'USER': 'cltbld', 16:58:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:00 INFO - '_': '/tools/buildbot/bin/python'} 16:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 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)) 16:58:00 INFO - Cleaning up... 16:58:00 INFO - Return code: 0 16:58:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, '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': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', '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 16:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:58:00 INFO - Using env: {'DISPLAY': ':0', 16:58:00 INFO - 'HOME': '/home/cltbld', 16:58:00 INFO - 'LANG': 'en_US.UTF-8', 16:58:00 INFO - 'LANGUAGE': 'en_US:en', 16:58:00 INFO - 'LOGNAME': 'cltbld', 16:58:00 INFO - 'MAIL': '/var/mail/cltbld', 16:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:00 INFO - 'MOZ_NO_REMOTE': '1', 16:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:00 INFO - 'NO_EM_RESTART': '1', 16:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:00 INFO - 'PWD': '/builds/slave/test', 16:58:00 INFO - 'SHELL': '/bin/bash', 16:58:00 INFO - 'SHLVL': '1', 16:58:00 INFO - 'TERM': 'linux', 16:58:00 INFO - 'TMOUT': '86400', 16:58:00 INFO - 'USER': 'cltbld', 16:58:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:00 INFO - '_': '/tools/buildbot/bin/python'} 16:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:00 INFO - Cleaning up... 16:58:00 INFO - Return code: 0 16:58:00 INFO - Running post-action listener: _resource_record_post_action 16:58:00 INFO - Running post-action listener: _start_resource_monitoring 16:58:00 INFO - Starting resource monitoring. 16:58:00 INFO - [mozharness: 2016-08-07 23:58:00.943517Z] Finished create-virtualenv step (success) 16:58:00 INFO - [mozharness: 2016-08-07 23:58:00.944007Z] Running install step. 16:58:00 INFO - Running pre-action listener: _resource_record_pre_action 16:58:00 INFO - Running main action method: install 16:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:01 INFO - Reading from file tmpfile_stdout 16:58:01 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:01 INFO - Reading from file tmpfile_stdout 16:58:01 INFO - Output received: 16:58:01 INFO - Usage: mozinstall [options] installer 16:58:01 INFO - Options: 16:58:01 INFO - -h, --help show this help message and exit 16:58:01 INFO - -d DEST, --destination=DEST 16:58:01 INFO - Directory to install application into. [default: 16:58:01 INFO - "/builds/slave/test"] 16:58:01 INFO - --app=APP Application being installed. [default: firefox] 16:58:01 INFO - mkdir: /builds/slave/test/build/application 16:58:01 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'] 16:58:01 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 16:58:17 INFO - Reading from file tmpfile_stdout 16:58:17 INFO - Output received: 16:58:17 INFO - /builds/slave/test/build/application/firefox/firefox 16:58:17 INFO - Running post-action listener: _resource_record_post_action 16:58:17 INFO - [mozharness: 2016-08-07 23:58:17.412065Z] Finished install step (success) 16:58:17 INFO - [mozharness: 2016-08-07 23:58:17.412406Z] Running run-tests step. 16:58:17 INFO - Running pre-action listener: _resource_record_pre_action 16:58:17 INFO - Running main action method: run_tests 16:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:17 INFO - Python 2.7.3 16:58:17 INFO - Return code: 0 16:58:17 INFO - grabbing minidump binary from tooltool 16:58: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')]} 16:58:17 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 0x13a2570>, '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 0x13a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:17 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 16:58:17 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 16:58:17 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 16:58:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:17 INFO - Return code: 0 16:58:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:58:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:58:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 16:58:17 INFO - Using env: {'DISPLAY': ':0', 16:58:17 INFO - 'HOME': '/home/cltbld', 16:58:17 INFO - 'LANG': 'en_US.UTF-8', 16:58:17 INFO - 'LANGUAGE': 'en_US:en', 16:58:17 INFO - 'LOGNAME': 'cltbld', 16:58:17 INFO - 'MAIL': '/var/mail/cltbld', 16:58:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:17 INFO - 'MOZ_NO_REMOTE': '1', 16:58:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:17 INFO - 'NO_EM_RESTART': '1', 16:58:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:17 INFO - 'PWD': '/builds/slave/test', 16:58:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:17 INFO - 'SHELL': '/bin/bash', 16:58:17 INFO - 'SHLVL': '1', 16:58:17 INFO - 'TERM': 'linux', 16:58:17 INFO - 'TMOUT': '86400', 16:58:17 INFO - 'USER': 'cltbld', 16:58:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541', 16:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:17 INFO - '_': '/tools/buildbot/bin/python'} 16:58:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 16:58:17 INFO - mozversion application_buildid: 20160807150652 16:58:17 INFO - mozversion application_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 16:58:17 INFO - mozversion application_display_name: Nightly 16:58:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:17 INFO - mozversion application_name: Firefox 16:58:17 INFO - mozversion application_remotingname: firefox 16:58:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:58:17 INFO - mozversion application_vendor: Mozilla 16:58:17 INFO - mozversion application_version: 51.0a1 16:58:17 INFO - mozversion platform_buildid: 20160807150652 16:58:17 INFO - mozversion platform_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 16:58:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:58:17 INFO - mozversion platform_version: 51.0a1 16:58:17 INFO - using testdate: 1470614297 16:58:17 INFO - actual date: 1470614297 16:58:17 INFO - starting webserver on 'localhost:43982' 16:58:17 INFO - SUITE-START | Running 2 tests 16:58:17 INFO - TEST-START | dromaeo_css 16:58:17 INFO - operating with platform_type : linux_ 16:58:17 INFO - Initialising browser for dromaeo_css test... 16:58:17 INFO - TEST-INFO | started process 27314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmH4ox/profile http://localhost:43982/getInfo.html) 16:58:22 INFO - PROCESS | 27314 | __metrics Screen width/height:1600/1200 16:58:22 INFO - PROCESS | 27314 | colorDepth:24 16:58:22 INFO - PROCESS | 27314 | Browser inner width/height: 1024/697 16:58:22 INFO - PROCESS | 27314 | __metrics 16:58:23 ERROR - PROCESS | 27314 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:58:24 INFO - TEST-INFO | 27314: exit 0 16:58:24 INFO - Browser initialized. 16:58:24 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:24 INFO - TEST-INFO | started process 27431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmH4ox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:36 INFO - PROCESS | 27431 | RSS: Main: 164691968 16:58:36 INFO - PROCESS | 27431 | 16:59:25 INFO - PROCESS | 27431 | 1470614365882 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] 17:01:38 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:43982/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43982/tests/dromaeo/cssquery-ext.html) 17:01:39 INFO - PROCESS | 27431 | RSS: Main: 167358464 17:01:39 INFO - PROCESS | 27431 | 17:04:42 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:43982/tests/dromaeo/cssquery-ext.html (next: http://localhost:43982/tests/dromaeo/cssquery-jquery.html) 17:04:42 INFO - PROCESS | 27431 | RSS: Main: 166391808 17:04:42 INFO - PROCESS | 27431 | 17:07:44 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:43982/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43982/tests/dromaeo/cssquery-mootools.html) 17:07:45 INFO - PROCESS | 27431 | RSS: Main: 170049536 17:07:45 INFO - PROCESS | 27431 | 17:10:47 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:43982/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43982/tests/dromaeo/cssquery-prototype.html) 17:10:48 INFO - PROCESS | 27431 | RSS: Main: 164646912 17:10:48 INFO - PROCESS | 27431 | 17:13:51 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:43982/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43982/tests/dromaeo/cssquery-yui.html) 17:13:51 INFO - PROCESS | 27431 | RSS: Main: 166764544 17:13:51 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:43982/tests/dromaeo/cssquery-yui.html (next: http://localhost:43982/tests/dromaeo/cssquery-dojo.html) 17:16:54 INFO - PROCESS | 27431 | RSS: Main: 170147840 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | __start_tp_report 17:16:54 INFO - PROCESS | 27431 | _x_x_mozilla_page_load 17:16:54 INFO - PROCESS | 27431 | _x_x_mozilla_page_load_details 17:16:54 INFO - PROCESS | 27431 | |i|pagename|runs| 17:16:54 INFO - PROCESS | 27431 | |0;dojo.html;2693.5555633320505;2710.60696199051;2730.2628290361604;2733.2210320058775;2752.2293757747825;4715.3162791395225;4905.877353066175;4976.651634385595;5001.424836143845;5013.749312534377;4856;4873.098476781798;4941.332920055791;4970.0805351010085;5034.949650503494;4324;4466.173757854791;4523.841665541707;4554.863354099366;4582.610478109348;4480.865574032784;4510.639148868099;4510.684252102355;4526.660500462462;4550.089982003596;4296.548862369437;4446.911061778778;4453.109378124388;4542.841000564964;4564.863054108382;4386.166628340637;4386.539413361615;4402.7578483183415;4495.325701144821;4552.271636538138;4442.888927776799;4453.955460445386;4455.710378825398;4468.664850136252;4498.460184777848;4829.492903245144;4840.951590484121;4875.585575226075;4891.315215869781;4921.360223170965;5309.230161626542;5329.413764485904;5330.200469929503;5331.067063263913;5354.491323324278;5359.088954877641;5370.570354371641;5387.973060134675;5405.081136206815;5424.349078110652;4648.023914977893;4861.368022157168;4892.657513974059;4907.803687852446;4932.728699921467;5322.813701520428;5363.410024897258;5393.325834270716;5400.621956463088;5408.513233808897;5121.820736274212;5157;5166.354205724285;5167;5219.19102539107;4988.575971042502;5184.7926082956255;5203.765830537559;5210.739463026834;5299.258103865462;5162.225666150032;5201.713905735221;5215.061288967946;5216.530512253916;5219.608529360313;5191.61062920275;5195.9740201298755;5202;5205.401378841406;5242.659227150223;4194.412782210493;4386.1447017831215;4432.822687092545;4442.111577684476;4448.866534003985;3873.1091848874917;3881.068543549528;3887.1642596841816;3897.162110146332;3922.5096862892137;4497.2129877271345;4515.390422293014;4543.432070991126;4547.977260113745;4567.885802854888;5000.74996250186;5226.843194704165;5249.921251181236;5285.180796976475;5320.068987927175;4533.637309015271;4537.160625284333;4547.727136371762;4561.749103799323;4602.562756538124;4762.452317983407;4768.260919557474;4769;4775.570198682135;4816.662833601685;4599.4710608280475;4824.155772739827;4886.291487734187;4907.435644900882;4973.751312434436;5251.816186433456;5265.947340526699;5281.973590132178;5284.9471505284455;5302.098643230737;4906.116898958079;4918.778654960463;4933.925991110208;4937.407511098548;4939.036887806843;4925.433575138905;5146.588272938231;5208.062548741263;5212.061828870688;5274.736263186902;5307.681539107666;5315.468453154654;5317.202419637086;5320.0955837506945;5342.3856256531;5176.378834539879;5193.532582067481;5196.32447781786;5196.480351964773;5236.89526209466;4808.7595620219545;5079.822206222764;5134.8973020540125;5164.018836421068;5195.5843532518065;5068.974655126701;5075.3402057732255;5089.185730283137;5099.031184075014;5148.099082660594;5199.706051758821;5215.191645294985;5216.243644671577;5224.738763061908;5245.134552798745;4766.5471780182215;4965.4289756678445;5046.798128074836;5048.217526283432;5105.693658380509 17:16:54 INFO - PROCESS | 27431 | |1;ext.html;569.5842035314221;570.3270141233346;570.3982298674899;573.3521121133119;604.9697515124243;34893.3021339573;39314.213715725666;39553.80223098888;39555.80222098889;39588.20823583534;38536.229275414546;38966.61033389665;39028.60971390285;39055.21889562207;39180.60819391805;7662.08055033394;7760.6895724171245;7788.883166752503;7808.219178082203;7824.256695613936;7700.306972372486;7726.7681969541;7744.574048427335;7787.182345853689;7789.298963093321;7740.225977402271;7779.066512018566;7791.181925897784;7836.4906281091835;7840.921590784076;7721.420893433015;7802.102758182825;7802.609869506502;7822.687092516349;7832.56920869352;7674.501157424749;7704.807379815494;7738;7741.961290193569;7760.611969401507;36831.4475282871;36964.81517592422;37259.81370093159;37358.62641373579;37385;2730.235534050469;2875.1374587623836;2938.9559156612668;3116.4546204414364;3241.983790081058;25732;26780.196594102013;27538.449231015267;28130.296742581395;28305.716942830513;3278.065751260879;3288.293017001356;3348.9497657535157;3404.114930118162;3428.297199074209;217550;218197;218431;219201.9039904806;219899;31458.213544661565;31966.200844979063;32070.19824504406;32196.517052244235;32499.837500812344;33799.493007604906;33908.49137262943;34184.65815341865;34407;34502.48246276308;12333.753324933452;12435.191712538655;12449.813252801216;12475.376231188404;12479.625611231677;9784.461854598065;9841.311108222355;9844.753881153028;9858.063483969012;9891.406515609087;7860.489068210548;7878.527288362602;7878.881816772753;7930.325922296554;7932.762017139495;3099.8140111593375;3105.813651180936;3116.9064928052194;3127.640321363027;3156.794808337451;872.4329186029132;930.4649826349876;1010.7473131717071;1016.7051555049101;1018.0786388318584;28696.426071478454;28776.568351474743;28848.278793030342;29531.114066578037;29751.702482975325;943.9433633981984;959;962.100436092256;982.1504398695077;986.6004268271362;14718.55844324672;15320.616984575252;15492.380304787908;15705.607359816097;15721.135337556316;376283;378119;381660;381866;381911;49704.75147624239;49716.254256186185;49772.253416198786;50049.74975125174;50088.24867626988;1180.4451907603413;1193.7612477504533;1210.5036934856666;1217.701663092548;1223.2293654997472;26703.332416689736;28066.85966570236;28241.576376354784;28908.42183156367;29039.41921161607;42644.360334594385;42659.786701066296;42949.14101717886;42992.570074298856;43158.35262471002;315739;319463;320224;321100;321337;24680.506389872462;25527;25566;25765.613515797653;26143.869280653475;41887;41904.58095419007;42807.785961069996;42911.78544107259;43219;36852.81573592115;36904.63095369012;37130.44304335491;37917;38210.80894595509;35880.282394351445;36987.44518832166;37012.62987370092;37226.8138659305;37591.43612845864;36258.274834502634;36997.65768364277;37282.440763388026;37370;37387.252254954205;31232.843835780677;33641;33870.32259354848;33914.830425847715;34064;23830.16594419187;24086.036558537464;24949.87525062363;25805.354866127745;26306.71856892411 17:16:54 INFO - PROCESS | 27431 | |2;jquery.html;358.55897246386945;365.29680365296804;366.081136347767;368.1807977250618;389.0817670298096;15622.453214137508;16937.237824297907;17906.820931790677;17984.73022904654;18046.81953180468;16854.83145168551;17039.659206815857;17397.91301043496;17569.91215043926;17667.73498397525;4962.776675049613;5132.409772876111;5148.819791307305;5176.8705782355555;5177.637565370425;3699.3526132926763;5114.258432527281;5702.7433765480655;5951.821445356624;6014.548908831834;6077.544184186182;6084.239470066242;6087.54343424245;6097.57316987811;6102.786402475915;5134.127198376266;5381.569474442035;5400.621956463069;5469.507744302992;5476.7535460904355;5216.426193118754;5250.842474725764;5266.394364648077;5283.63014588979;5304.177852432879;11716.707082322924;11882.28706277626;12096.274223546616;20064.39806805798;20490.463215258766;1908.3225454963426;1932.391296741536;2247.8985297204254;2272.102519504803;2412.3486658602255;9424.387414818015;9542.666006689733;9586;10985.285956412808;13565.914726821831;1640;1746.8340507651753;1782.9821701782946;1827.7441158237857;1871.7739880378374;72212.63893680551;72400.27599723988;72859.27140728578;74014.62992685055;76448.88408927273;10019.298649094639;10043.598256069821;10281.12610428122;10343.482825858828;10490.580376784843;14199.645008874653;14258.714825703635;14292.142471451747;14308.785368219485;14315.28423578817;6795.1845778506895;6826.351496607815;7005.229424763272;7102.147742270858;7118.501704880712;6346.2067241594805;6421.775237866652;6483;6625.569337993015;6630.701618427182;4116.382542618571;4293.3130699088;4310.6335961443;4367.759773212504;4502.4371953505815;1469.2800527741545;1537.8692811110957;1555.7744127101507;1813.3018787766541;1855.2300795170124;817.6198067898456;856.8886044814134;878.2666473494576;889.155302462663;891.5586784541694;17026.659466810594;17123.74314385285;17164;17479.737803932952;17631.294748209926;831.6174559702483;843.9198276163754;851.3997631669658;862.1938487514069;879.243850288764;6808.6255255960405;9796.9020309796;9909.851352229722;9915.603375865028;9945.602175913027;373016;373333;373687;379677;384533;54033;78426.60786696144;79545;80501.19498805054;81504;839.2404873589411;849.3884403229665;854.6709516836063;859.0550394565928;870.5081628879663;15336.693266134838;15356.232188390759;16054.357825686842;16069.839301606835;16123.355065797237;37295;38138;38962;39324;39437.60562394454;51746;52276.73861630668;53241.73379133079;54247.45752542424;55632.44367556435;6554.279029306867;6563.9343606563325;6633.70148343316;6645.933540664531;6672.099266599141;10384.844227336445;10566.31318964265;10684.305520141166;11462.312261264016;11763.88236117662;10235.795284094127;10300.896991029993;10442.582296708046;10494.370337779757;10716;10126.8480972784;10270.6405275815;10307.123894469054;10463.738406539898;10640.308379955279;9484.52577371115;9690.56392462355;9730.464824434725;10621.203409744145;10803.891961080288;6271.3415091414745;6684.231313399021;6799.864002720017;6895.310468953266;7172.354488096096;8799.384043116921;10693.625723099654;10718.946405267923;10723.249372543847;11142.554297827995 17:16:54 INFO - PROCESS | 27431 | |3;mootools.html;1367.4803574641635;1389.86101389861;1467.1710483576778;1641.9261133249004;1656.726640104382;6449.580777249487;7275.090613673291;7491.475596708233;7842.215778422155;7868.370530357572;7570.977917981085;7853.646585903633;7861.606919654023;7867.921320786791;7903.644336004893;2173.717416735826;2211.159759291467;2211.9004644790944;2212.424769559918;2212.469007438211;2130.6803979403057;2157.244964262511;2168.143583284602;2182.443476913385;2188.124750099957;2158.5359147783224;2165.5560610074895;2165.6210163221454;2173.0438607012943;2186.8031877131057;2108.546662467569;2115.978840211609;2120.6182887080395;2124.362691192644;2126.755423126345;2081.5420607466335;2097.161135545794;2101.7057611934342;2121.2363549122306;2121.2469573301564;7838.804029899241;7855.96072019642;7866.370690344758;7895.368370530344;7897.289243968071;4382.320740285229;4521.434820647419;4556.225441674923;4565.223911934979;4569.360289559464;2679.6516452861197;2734.8769305381306;2757.4071574611353;2778.166550035002;2806.803523753338;813.6540725779446;858.4034096303072;863.4991704811194;863.7279257034014;865.8008658008694;10449;10475.26673132881;10493;10527.578896844117;10544.578216871316;3862.942055869164;4006.779627120478;4057.5130984282073;4163.479565054368;4164.6251837334175;9017.413868098552;9034.774130646654;9037.367384283169;9046.86429703555;9053.77365565853;4445.177642136216;4473.821047158077;4493.820247190076;4494.056248187917;4494.303382975644;3249.77251592391;4044.656204222674;4082;4088.652464540488;4118.732282401635;3609.4224924012033;3614.566252049771;3712.3874560697723;3746.606606306353;3757.868474603376;1135.2564070533813;1158.623447379605;1161.384466232898;1164.574930150489;1173.8708742038368;745.4446437404168;750.9812254693567;852.228732996639;859.9551544873009;869.1482347299682;5108.591312694975;5402.756875940592;5409.26974858397;5409.350877894678;5414.675119492843;900.6532484993324;908.7410088124985;916.4466229740526;947.1381043250609;955.5604421965835;3543.2027793746715;3677.7057835373107;3681.208540163878;3771.5662698789442;3795.2978698940783;8896.377253592316;9339.813203735886;9634.807303853884;9674.22606191503;9761.51192440375;9249.213816825646;9587.664431744855;9606.327557071078;9611.279154063473;9649.614015439303;6980.965095174593;7044.119485064367;7183.92816071843;7305.269473052758;7355.59544225062;5644.322681278109;5722.284714410699;5736.483716465538;5763.596548241583;6014.969925150522;8899.555022248733;8907.55462226899;9018.954905225695;9022.007579166155;9097.818043638958;8763.474191548528;8808;9083.04628014049;9100.317476189444;9141.177294043568;5684.687342196054;6579.144711187515;6636.767713130017;6698.698558564974;6755.831104222434;7638.197989211275;7719.228077192236;7736.613169341623;7753.37972962173;7765.107012693613;6658.267590565131;6683.365080317362;6729.596224226562;6790.42281406086;6999.265077166824;6618.8345291368105;6639.402453779183;6658.533902626963;6711.63086030273;6785.830354240986;6344.1118243445035;6424.743010279536;6450.129232553545;6455.386738259858;6498.902516462352;4551.317302404534;4563.475200352002;4586.931196031996;4588.334691469785;4606.378138951199;4419.049904270597;4484.461864576272;4538.500764915922;4550.408446901882;4680.227762419163 17:16:54 INFO - PROCESS | 27431 | |4;prototype.html;283.518019367076;293.1118710307767;298.4091498832312;300.72483677435156;302.63230175336986;4930.556249937505;5023.346964894558;5110.795568177273;5129.102407078761;5130.204818253172;5033.439633713551;5038.2694509296225;5064.822731204408;5068.315777370063;5071.315372424721;3967.642912137907;3968.9206215875665;3971.98014009931;3974.7813870237123;3990.4612877261634;3867.4778904847767;3969.2656858481273;3980.0049987503126;3987.4018897165365;3987.441758153861;3929.2534418460546;3934.2131573685233;3940.8423663053445;3942.2903877302074;3952.8814135575835;3915.177812659345;3931.0761970936805;3949.8025098744947;3964.702647301464;3965.156202365885;3487.134383105052;3489.7033752130847;3492.3539145257955;3493.91265218369;3508.3684936711384;4865.540337898617;4938.728369939652;4942.5304596063315;4963.528464795875;5013.5989120870245;4501.594856462902;4505.504394516601;4508.932366014513;4512.774361281956;4525.502194758574;5338.172583249602;5338.85214678842;5343.412224655285;5350.27771250884;5361.973190134025;3467.6705712957482;3675.228202077567;3676.283124790667;3785.167263202091;3798.734088613798;5524.447555244484;5558.86102847428;5564.8052318169075;5567.3040869891265;5575.912697024082;3780.9432858507143;3785.8674946377296;3791.3175628386603;3792.6965842732516;3793.3172029034486;3610.1335679436747;3842.404427313715;3846.2884016612898;3848.5958974307855;3854.672352849983;4377.124575084996;4401.163778882066;4412.36020776992;4414.977925110418;4420.734755914591;5296.549793267538;5303.973480132652;5319.867003324948;5321.467853214725;5325.360956685223;1236.9876301237052;1274.2736640115231;1299.5061876487064;1305.595265467708;1323.7683405404016;858.965641374338;882.2104216725994;890.6081324217324;897.717219075989;897.8159477307137;4583.220852455091;4606.516315786861;4618.145643056046;4624.699394539344;4633.328167415706;5413.377461591967;5432.619716619799;5433.809816656477;5437.238786569884;5451.563874890078;4492.910141797146;4635.258358662665;4639.559241872017;4653.185692503798;4655.208614535537;2557.744225577427;2560.257525317637;2583.2895953612906;2591.922242332733;2597.909073182467;4448.733076015449;4542.341360502709;4553.203189441834;4565.402109261799;4566.26939689648;4686.531346865286;4843.200871856105;4850.95149048512;4851.781669824796;4893.657443978958;4392.890177745518;4464.330350447459;4525.411696479502;4540.841070562515;4545.250033744462;4710.952890471051;4750.976245118753;4752.405949256343;4753.5008824072975;4793.257045158006;4652.278896771006;4661.836835710734;4677.883052923704;4682.789274482589;4692.756419548754;4137.296659567821;4408.382826404242;4424.668149888836;4456.888577785451;4512.9774351128035;3409;3411.385950528929;3414.146463384154;3418.5555877735737;3436.862525498952;4762;4765.855365085795;4790.592799612072;4800.871795128072;5185.870353241199;5176.275321455075;5222.529972302511;5235.764390602356;5257.4216836147225;5280.406046739361;5311.229871668664;5321.217392173665;5322.228276899906;5322.41453440129;5334.306540149756;4948.876278092933;5128.640910158885;5174.172132458939;5182.637215395037;5239.790408383622;5355.651882627617;5371.140617501337;5374;5374.919376209438;5384.380796208487;5254.343207099113;5256.371814092953;5256.421793602777;5267.499587539178;5272.44639312882 17:16:54 INFO - PROCESS | 27431 | |5;yui.html;528.2261486921659;549.8048192891526;549.925760022397;606.0878378041049;614.3919063575124;11643.767124657501;11956.820647690292;12242.571509997151;12264;12659.430325635345;12783.29691866947;13105.279209643466;13113;13125.93437032816;13132.73734525309;639.6545865232792;766.8657984852642;790.7430085222297;792.3700657976922;795.5425630262594;764.3235736373322;775.7944144801633;782.6438970268542;790.5928446849877;792.093053453795;831.1231650608605;831.5301854452246;832.1719888710742;832.5296207642692;834.1116710703081;824.6907409721355;824.7979245084932;824.9422540422173;826.2522417212402;826.2893911236332;605.1316361021948;606.9271687397496;607.4259824465881;608.7838817219912;609.232367217305;11555.94222028893;11671.591494297743;11690.41547922609;11695.766084678344;11708.88291117095;11926.224795388272;11959.641210763692;12142.939285303517;12282.671056898418;12661.810072848915;10129.645462408855;10235.79528409435;10276.383416995004;10280.48597570126;10346.43094629795;3306.983465082659;3348;3352.1284466039006;3388.0852169914233;3394.8642054317797;67318.66340668315;67891.56867450592;68277.3172268276;69170.65414672944;69829;9607.423554586747;9685.225181985565;9733.318667693335;9902.702918912444;9951.900480995097;18255.361062362754;18319.90840045818;18387.356442524448;18409.90795046016;18438.262469501336;6639.933600664028;6738.831529211809;6786.151731033621;6795.014722865157;6889.138857642794;3690;3699.8705045323286;3823.8279277432584;3853.5183102112237;3859.3439115350457;2712.823666461674;2835.9858200709277;2848.31640406301;2852.6006359109742;2852.7717782577342;466.56143225368044;471.8843883248626;474.3217199404815;482.2982560374646;493.48184406373167;470.2499513276319;487.4004973882145;488.92177251639566;489.84080173943613;505.1286530734454;7097.290270972861;7220.9638951805955;7525.24747525254;7545.962270188614;7598.316151546387;502.58787794009294;512.3952990710335;520.3131865936926;524.1325606121875;526.3736153976755;3464.272502774395;3566.8573257069947;3580.838862251205;3583.283343331344;3734.7012239020814;61158;102420;104597.47701261444;107505.4624726887;108506;87411.56294218489;91133.54433227792;92830;92986.53506732424;94708.52645736728;45063;49825;51270.74364628153;81511.18488815155;85159.57420212984;6965.860533903827;7282.689115958966;7364.815879603053;7381.8154546136775;7404.851902962018;46785.29822052604;48368.75815620899;48470;48825;49140.50859491359;38464.6153538461;40072.59927400688;40201.39697904592;43661.34507982319;51372.74313628408;8637.093105223861;8778.780530486789;8795;8838.646454141763;8913.910860891308;9606.615735370508;9609.30246414001;9796.363236389612;9988.800223995624;10034.29759916828;9130.680426185052;9252.814943701223;9265.119813617695;9349.906500934903;9469.857952130862;9020.458772473672;9074.682386116454;9182.265418766616;9337.623277610883;9474;8946.003207730255;9220;9367.718968430958;9429.481378524248;9638.373505722106;7296.343329100407;7339.9633001834645;7347.302006309392;7360.728500904244;7691.38468922496;9200.217981471382;10138.49307534635;10224.64213752515;10522.15822734164;10694.572217111228 17:16:54 INFO - PROCESS | 27431 | __end_tp_report 17:16:54 INFO - PROCESS | 27431 | __start_cc_report 17:16:54 INFO - PROCESS | 27431 | _x_x_mozilla_cycle_collect,369 17:16:54 INFO - PROCESS | 27431 | __end_cc_report 17:16:54 INFO - PROCESS | 27431 | __startTimestamp1470615414528__endTimestamp 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | ------- Summary: start ------- 17:16:54 INFO - PROCESS | 27431 | Number of tests: 6 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | [#0] dojo.html Cycles:165 Average:4848.02 Median:4965.43 stddev:524.11 (10.6%) stddev-sans-first:497.72 17:16:54 INFO - PROCESS | 27431 | Values: 2693.6 2710.6 2730.3 2733.2 2752.2 4715.3 4905.9 4976.7 5001.4 5013.7 4856.0 4873.1 4941.3 4970.1 5034.9 4324.0 4466.2 4523.8 4554.9 4582.6 4480.9 4510.6 4510.7 4526.7 4550.1 4296.5 4446.9 4453.1 4542.8 4564.9 4386.2 4386.5 4402.8 4495.3 4552.3 4442.9 4454.0 4455.7 4468.7 4498.5 4829.5 4841.0 4875.6 4891.3 4921.4 5309.2 5329.4 5330.2 5331.1 5354.5 5359.1 5370.6 5388.0 5405.1 5424.3 4648.0 4861.4 4892.7 4907.8 4932.7 5322.8 5363.4 5393.3 5400.6 5408.5 5121.8 5157.0 5166.4 5167.0 5219.2 4988.6 5184.8 5203.8 5210.7 5299.3 5162.2 5201.7 5215.1 5216.5 5219.6 5191.6 5196.0 5202.0 5205.4 5242.7 4194.4 4386.1 4432.8 4442.1 4448.9 3873.1 3881.1 3887.2 3897.2 3922.5 4497.2 4515.4 4543.4 4548.0 4567.9 5000.7 5226.8 5249.9 5285.2 5320.1 4533.6 4537.2 4547.7 4561.7 4602.6 4762.5 4768.3 4769.0 4775.6 4816.7 4599.5 4824.2 4886.3 4907.4 4973.8 5251.8 5265.9 5282.0 5284.9 5302.1 4906.1 4918.8 4933.9 4937.4 4939.0 4925.4 5146.6 5208.1 5212.1 5274.7 5307.7 5315.5 5317.2 5320.1 5342.4 5176.4 5193.5 5196.3 5196.5 5236.9 4808.8 5079.8 5134.9 5164.0 5195.6 5069.0 5075.3 5089.2 5099.0 5148.1 5199.7 5215.2 5216.2 5224.7 5245.1 4766.5 4965.4 5046.8 5048.2 5105.7 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | [#1] ext.html Cycles:180 Average:44773.47 Median:36992.55 stddev:82671.74 (223.5%) stddev-sans-first:82837.03 17:16:54 INFO - PROCESS | 27431 | Values: 569.6 570.3 570.4 573.4 605.0 34893.3 39314.2 39553.8 39555.8 39588.2 38536.2 38966.6 39028.6 39055.2 39180.6 7662.1 7760.7 7788.9 7808.2 7824.3 7700.3 7726.8 7744.6 7787.2 7789.3 7740.2 7779.1 7791.2 7836.5 7840.9 7721.4 7802.1 7802.6 7822.7 7832.6 7674.5 7704.8 7738.0 7742.0 7760.6 36831.4 36964.8 37259.8 37358.6 37385.0 2730.2 2875.1 2939.0 3116.5 3242.0 25732.0 26780.2 27538.4 28130.3 28305.7 3278.1 3288.3 3348.9 3404.1 3428.3 217550.0 218197.0 218431.0 219201.9 219899.0 31458.2 31966.2 32070.2 32196.5 32499.8 33799.5 33908.5 34184.7 34407.0 34502.5 12333.8 12435.2 12449.8 12475.4 12479.6 9784.5 9841.3 9844.8 9858.1 9891.4 7860.5 7878.5 7878.9 7930.3 7932.8 3099.8 3105.8 3116.9 3127.6 3156.8 872.4 930.5 1010.7 1016.7 1018.1 28696.4 28776.6 28848.3 29531.1 29751.7 943.9 959.0 962.1 982.2 986.6 14718.6 15320.6 15492.4 15705.6 15721.1 376283.0 378119.0 381660.0 381866.0 381911.0 49704.8 49716.3 49772.3 50049.7 50088.2 1180.4 1193.8 1210.5 1217.7 1223.2 26703.3 28066.9 28241.6 28908.4 29039.4 42644.4 42659.8 42949.1 42992.6 43158.4 315739.0 319463.0 320224.0 321100.0 321337.0 24680.5 25527.0 25566.0 25765.6 26143.9 41887.0 41904.6 42807.8 42911.8 43219.0 36852.8 36904.6 37130.4 37917.0 38210.8 35880.3 36987.4 37012.6 37226.8 37591.4 36258.3 36997.7 37282.4 37370.0 37387.3 31232.8 33641.0 33870.3 33914.8 34064.0 23830.2 24086.0 24949.9 25805.4 26306.7 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | [#2] jquery.html Cycles:180 Average:23992.15 Median:4301.97 stddev:62446.05 (1451.6%) stddev-sans-first:62596.02 17:16:54 INFO - PROCESS | 27431 | Values: 358.6 365.3 366.1 368.2 389.1 15622.5 16937.2 17906.8 17984.7 18046.8 16854.8 17039.7 17397.9 17569.9 17667.7 4962.8 5132.4 5148.8 5176.9 5177.6 3699.4 5114.3 5702.7 5951.8 6014.5 6077.5 6084.2 6087.5 6097.6 6102.8 5134.1 5381.6 5400.6 5469.5 5476.8 5216.4 5250.8 5266.4 5283.6 5304.2 11716.7 11882.3 12096.3 20064.4 20490.5 1908.3 1932.4 2247.9 2272.1 2412.3 9424.4 9542.7 9586.0 10985.3 13565.9 1640.0 1746.8 1783.0 1827.7 1871.8 72212.6 72400.3 72859.3 74014.6 76448.9 10019.3 10043.6 10281.1 10343.5 10490.6 14199.6 14258.7 14292.1 14308.8 14315.3 6795.2 6826.4 7005.2 7102.1 7118.5 6346.2 6421.8 6483.0 6625.6 6630.7 4116.4 4293.3 4310.6 4367.8 4502.4 1469.3 1537.9 1555.8 1813.3 1855.2 817.6 856.9 878.3 889.2 891.6 17026.7 17123.7 17164.0 17479.7 17631.3 831.6 843.9 851.4 862.2 879.2 6808.6 9796.9 9909.9 9915.6 9945.6 373016.0 373333.0 373687.0 379677.0 384533.0 54033.0 78426.6 79545.0 80501.2 81504.0 839.2 849.4 854.7 859.1 870.5 15336.7 15356.2 16054.4 16069.8 16123.4 37295.0 38138.0 38962.0 39324.0 39437.6 51746.0 52276.7 53241.7 54247.5 55632.4 6554.3 6563.9 6633.7 6645.9 6672.1 10384.8 10566.3 10684.3 11462.3 11763.9 10235.8 10300.9 10442.6 10494.4 10716.0 10126.8 10270.6 10307.1 10463.7 10640.3 9484.5 9690.6 9730.5 10621.2 10803.9 6271.3 6684.2 6799.9 6895.3 7172.4 8799.4 10693.6 10718.9 10723.2 11142.6 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | [#3] mootools.html Cycles:180 Average:5116.44 Median:5664.51 stddev:2867.29 (50.6%) stddev-sans-first:2861.49 17:16:54 INFO - PROCESS | 27431 | Values: 1367.5 1389.9 1467.2 1641.9 1656.7 6449.6 7275.1 7491.5 7842.2 7868.4 7571.0 7853.6 7861.6 7867.9 7903.6 2173.7 2211.2 2211.9 2212.4 2212.5 2130.7 2157.2 2168.1 2182.4 2188.1 2158.5 2165.6 2165.6 2173.0 2186.8 2108.5 2116.0 2120.6 2124.4 2126.8 2081.5 2097.2 2101.7 2121.2 2121.2 7838.8 7856.0 7866.4 7895.4 7897.3 4382.3 4521.4 4556.2 4565.2 4569.4 2679.7 2734.9 2757.4 2778.2 2806.8 813.7 858.4 863.5 863.7 865.8 10449.0 10475.3 10493.0 10527.6 10544.6 3862.9 4006.8 4057.5 4163.5 4164.6 9017.4 9034.8 9037.4 9046.9 9053.8 4445.2 4473.8 4493.8 4494.1 4494.3 3249.8 4044.7 4082.0 4088.7 4118.7 3609.4 3614.6 3712.4 3746.6 3757.9 1135.3 1158.6 1161.4 1164.6 1173.9 745.4 751.0 852.2 860.0 869.1 5108.6 5402.8 5409.3 5409.4 5414.7 900.7 908.7 916.4 947.1 955.6 3543.2 3677.7 3681.2 3771.6 3795.3 8896.4 9339.8 9634.8 9674.2 9761.5 9249.2 9587.7 9606.3 9611.3 9649.6 6981.0 7044.1 7183.9 7305.3 7355.6 5644.3 5722.3 5736.5 5763.6 6015.0 8899.6 8907.6 9019.0 9022.0 9097.8 8763.5 8808.0 9083.0 9100.3 9141.2 5684.7 6579.1 6636.8 6698.7 6755.8 7638.2 7719.2 7736.6 7753.4 7765.1 6658.3 6683.4 6729.6 6790.4 6999.3 6618.8 6639.4 6658.5 6711.6 6785.8 6344.1 6424.7 6450.1 6455.4 6498.9 4551.3 4563.5 4586.9 4588.3 4606.4 4419.0 4484.5 4538.5 4550.4 4680.2 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | [#4] prototype.html Cycles:180 Average:4243.42 Median:4634.29 stddev:1240.17 (26.8%) stddev-sans-first:1207.50 17:16:54 INFO - PROCESS | 27431 | Values: 283.5 293.1 298.4 300.7 302.6 4930.6 5023.3 5110.8 5129.1 5130.2 5033.4 5038.3 5064.8 5068.3 5071.3 3967.6 3968.9 3972.0 3974.8 3990.5 3867.5 3969.3 3980.0 3987.4 3987.4 3929.3 3934.2 3940.8 3942.3 3952.9 3915.2 3931.1 3949.8 3964.7 3965.2 3487.1 3489.7 3492.4 3493.9 3508.4 4865.5 4938.7 4942.5 4963.5 5013.6 4501.6 4505.5 4508.9 4512.8 4525.5 5338.2 5338.9 5343.4 5350.3 5362.0 3467.7 3675.2 3676.3 3785.2 3798.7 5524.4 5558.9 5564.8 5567.3 5575.9 3780.9 3785.9 3791.3 3792.7 3793.3 3610.1 3842.4 3846.3 3848.6 3854.7 4377.1 4401.2 4412.4 4415.0 4420.7 5296.5 5304.0 5319.9 5321.5 5325.4 1237.0 1274.3 1299.5 1305.6 1323.8 859.0 882.2 890.6 897.7 897.8 4583.2 4606.5 4618.1 4624.7 4633.3 5413.4 5432.6 5433.8 5437.2 5451.6 4492.9 4635.3 4639.6 4653.2 4655.2 2557.7 2560.3 2583.3 2591.9 2597.9 4448.7 4542.3 4553.2 4565.4 4566.3 4686.5 4843.2 4851.0 4851.8 4893.7 4392.9 4464.3 4525.4 4540.8 4545.3 4711.0 4751.0 4752.4 4753.5 4793.3 4652.3 4661.8 4677.9 4682.8 4692.8 4137.3 4408.4 4424.7 4456.9 4513.0 3409.0 3411.4 3414.1 3418.6 3436.9 4762.0 4765.9 4790.6 4800.9 5185.9 5176.3 5222.5 5235.8 5257.4 5280.4 5311.2 5321.2 5322.2 5322.4 5334.3 4948.9 5128.6 5174.2 5182.6 5239.8 5355.7 5371.1 5374.0 5374.9 5384.4 5254.3 5256.4 5256.4 5267.5 5272.4 17:16:54 INFO - PROCESS | 27431 | 17:16:54 INFO - PROCESS | 27431 | [#5] yui.html Cycles:180 Average:16752.55 Median:605.61 stddev:25376.00 (4190.2%) stddev-sans-first:25417.95 17:16:54 INFO - PROCESS | 27431 | Values: 528.2 549.8 549.9 606.1 614.4 11643.8 11956.8 12242.6 12264.0 12659.4 12783.3 13105.3 13113.0 13125.9 13132.7 639.7 766.9 790.7 792.4 795.5 764.3 775.8 782.6 790.6 792.1 831.1 831.5 832.2 832.5 834.1 824.7 824.8 824.9 826.3 826.3 605.1 606.9 607.4 608.8 609.2 11555.9 11671.6 11690.4 11695.8 11708.9 11926.2 11959.6 12142.9 12282.7 12661.8 10129.6 10235.8 10276.4 10280.5 10346.4 3307.0 3348.0 3352.1 3388.1 3394.9 67318.7 67891.6 68277.3 69170.7 69829.0 9607.4 9685.2 9733.3 9902.7 9951.9 18255.4 18319.9 18387.4 18409.9 18438.3 6639.9 6738.8 6786.2 6795.0 6889.1 3690.0 3699.9 3823.8 3853.5 3859.3 2712.8 2836.0 2848.3 2852.6 2852.8 466.6 471.9 474.3 482.3 493.5 470.2 487.4 488.9 489.8 505.1 7097.3 7221.0 7525.2 7546.0 7598.3 502.6 512.4 520.3 524.1 526.4 3464.3 3566.9 3580.8 3583.3 3734.7 61158.0 102420.0 104597.5 107505.5 108506.0 87411.6 91133.5 92830.0 92986.5 94708.5 45063.0 49825.0 51270.7 81511.2 85159.6 6965.9 7282.7 7364.8 7381.8 7404.9 46785.3 48368.8 48470.0 48825.0 49140.5 38464.6 40072.6 40201.4 43661.3 51372.7 8637.1 8778.8 8795.0 8838.6 8913.9 9606.6 9609.3 9796.4 9988.8 10034.3 9130.7 9252.8 9265.1 9349.9 9469.9 9020.5 9074.7 9182.3 9337.6 9474.0 8946.0 9220.0 9367.7 9429.5 9638.4 7296.3 7340.0 7347.3 7360.7 7691.4 9200.2 10138.5 10224.6 10522.2 10694.6 17:16:54 INFO - PROCESS | 27431 | -------- Summary: end -------- 17:16:54 INFO - PROCESS | 27431 | 17:16:55 INFO - TEST-INFO | 27431: exit 0 17:16:55 INFO - TEST-OK | dromaeo_css | took 1117673ms 17:16:55 INFO - TEST-START | kraken 17:16:55 INFO - operating with platform_type : linux_ 17:16:55 INFO - Initialising browser for kraken test... 17:16:55 INFO - TEST-INFO | started process 27678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOUvCZ/profile http://localhost:43982/getInfo.html) 17:17:00 INFO - PROCESS | 27678 | __metrics Screen width/height:1600/1200 17:17:00 INFO - PROCESS | 27678 | colorDepth:24 17:17:00 INFO - PROCESS | 27678 | Browser inner width/height: 1024/697 17:17:00 INFO - PROCESS | 27678 | __metrics 17:17:00 ERROR - PROCESS | 27678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:17:01 INFO - TEST-INFO | 27678: exit 0 17:17:01 INFO - Browser initialized. 17:17:01 INFO - Running cycle 1/1 for kraken test... 17:17:01 INFO - TEST-INFO | started process 27803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOUvCZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:13 INFO - PROCESS | 27803 | RSS: Main: 165249024 17:17:13 INFO - PROCESS | 27803 | 17:17:16 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43982/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:17 INFO - PROCESS | 27803 | RSS: Main: 170192896 17:17:17 INFO - PROCESS | 27803 | 17:17:20 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43982/tests/kraken/driver.html?testName=audio-dft) 17:17:20 INFO - PROCESS | 27803 | RSS: Main: 169033728 17:17:20 INFO - PROCESS | 27803 | 17:17:23 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43982/tests/kraken/driver.html?testName=audio-fft) 17:17:24 INFO - PROCESS | 27803 | RSS: Main: 165605376 17:17:24 INFO - PROCESS | 27803 | 17:17:26 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43982/tests/kraken/driver.html?testName=audio-oscillator) 17:17:27 INFO - PROCESS | 27803 | RSS: Main: 166166528 17:17:27 INFO - PROCESS | 27803 | 17:17:29 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43982/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:30 INFO - PROCESS | 27803 | RSS: Main: 166572032 17:17:30 INFO - PROCESS | 27803 | 17:17:33 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43982/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:34 INFO - PROCESS | 27803 | RSS: Main: 166789120 17:17:34 INFO - PROCESS | 27803 | 17:17:37 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43982/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:38 INFO - PROCESS | 27803 | RSS: Main: 164360192 17:17:38 INFO - PROCESS | 27803 | 17:17:41 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43982/tests/kraken/driver.html?testName=json-parse-financial) 17:17:41 INFO - PROCESS | 27803 | RSS: Main: 165859328 17:17:41 INFO - PROCESS | 27803 | 17:17:43 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43982/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:44 INFO - PROCESS | 27803 | RSS: Main: 165855232 17:17:44 INFO - PROCESS | 27803 | 17:17:46 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:46 INFO - PROCESS | 27803 | RSS: Main: 166031360 17:17:46 INFO - PROCESS | 27803 | 17:17:48 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:49 INFO - PROCESS | 27803 | RSS: Main: 166555648 17:17:49 INFO - PROCESS | 27803 | 17:17:52 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:53 INFO - PROCESS | 27803 | RSS: Main: 166678528 17:17:53 INFO - PROCESS | 27803 | 17:17:56 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:56 INFO - PROCESS | 27803 | RSS: Main: 166920192 17:17:56 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | Cycle 1(1): loaded http://localhost:43982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43982/tests/kraken/driver.html?testName=ai-astar) 17:17:58 INFO - PROCESS | 27803 | RSS: Main: 167002112 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | __start_tp_report 17:17:58 INFO - PROCESS | 27803 | _x_x_mozilla_page_load 17:17:58 INFO - PROCESS | 27803 | _x_x_mozilla_page_load_details 17:17:58 INFO - PROCESS | 27803 | |i|pagename|runs| 17:17:58 INFO - PROCESS | 27803 | |0;ai-astar;105;114;110;114;115;117;115;115;114;115 17:17:58 INFO - PROCESS | 27803 | |1;audio-beat-detection;154;122;150;193;132;150;155;125;192;123 17:17:58 INFO - PROCESS | 27803 | |2;audio-dft;164;163;165;171;162;163;162;162;165;162 17:17:58 INFO - PROCESS | 27803 | |3;audio-fft;76;75;75;174;78;75;75;76;157;77 17:17:58 INFO - PROCESS | 27803 | |4;audio-oscillator;85;85;139;87;85;86;139;85;85;138 17:17:58 INFO - PROCESS | 27803 | |5;imaging-gaussian-blur;117;118;118;118;117;117;118;118;118;118 17:17:58 INFO - PROCESS | 27803 | |6;imaging-darkroom;147;149;149;148;147;148;148;149;147;147 17:17:58 INFO - PROCESS | 27803 | |7;imaging-desaturate;95;97;95;95;95;96;96;96;95;95 17:17:58 INFO - PROCESS | 27803 | |8;json-parse-financial;64;64;64;64;65;63;63;64;62;65 17:17:58 INFO - PROCESS | 27803 | |9;json-stringify-tinderbox;66;66;68;65;66;65;65;66;65;66 17:17:58 INFO - PROCESS | 27803 | |10;stanford-crypto-aes;80;80;96;80;81;79;83;79;87;79 17:17:58 INFO - PROCESS | 27803 | |11;stanford-crypto-ccm;132;133;134;139;130;148;132;138;133;142 17:17:58 INFO - PROCESS | 27803 | |12;stanford-crypto-pbkdf2;172;166;165;165;166;171;167;166;166;171 17:17:58 INFO - PROCESS | 27803 | |13;stanford-crypto-sha256-iterative;70;69;69;72;68;69;68;68;67;67 17:17:58 INFO - PROCESS | 27803 | __end_tp_report 17:17:58 INFO - PROCESS | 27803 | __start_cc_report 17:17:58 INFO - PROCESS | 27803 | _x_x_mozilla_cycle_collect,967 17:17:58 INFO - PROCESS | 27803 | __end_cc_report 17:17:58 INFO - PROCESS | 27803 | __startTimestamp1470615478757__endTimestamp 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | ------- Summary: start ------- 17:17:58 INFO - PROCESS | 27803 | Number of tests: 14 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:3.44 (3.0%) stddev-sans-first:1.87 17:17:58 INFO - PROCESS | 27803 | Values: 105.0 114.0 110.0 114.0 115.0 117.0 115.0 115.0 114.0 115.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:152.00 stddev:26.06 (17.1%) stddev-sans-first:27.60 17:17:58 INFO - PROCESS | 27803 | Values: 154.0 122.0 150.0 193.0 132.0 150.0 155.0 125.0 192.0 123.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.77 (1.7%) stddev-sans-first:2.93 17:17:58 INFO - PROCESS | 27803 | Values: 164.0 163.0 165.0 171.0 162.0 163.0 162.0 162.0 165.0 162.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.01 (50.3%) stddev-sans-first:39.77 17:17:58 INFO - PROCESS | 27803 | Values: 76.0 75.0 75.0 174.0 78.0 75.0 75.0 76.0 157.0 77.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:85.00 stddev:25.73 (30.3%) stddev-sans-first:26.59 17:17:58 INFO - PROCESS | 27803 | Values: 85.0 85.0 139.0 87.0 85.0 86.0 139.0 85.0 85.0 138.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:17:58 INFO - PROCESS | 27803 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 17:17:58 INFO - PROCESS | 27803 | Values: 147.0 149.0 149.0 148.0 147.0 148.0 148.0 149.0 147.0 147.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 17:17:58 INFO - PROCESS | 27803 | Values: 95.0 97.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 17:17:58 INFO - PROCESS | 27803 | Values: 64.0 64.0 64.0 64.0 65.0 63.0 63.0 64.0 62.0 65.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 17:17:58 INFO - PROCESS | 27803 | Values: 66.0 66.0 68.0 65.0 66.0 65.0 65.0 66.0 65.0 66.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:80.50 stddev:5.38 (6.7%) stddev-sans-first:5.63 17:17:58 INFO - PROCESS | 27803 | Values: 80.0 80.0 96.0 80.0 81.0 79.0 83.0 79.0 87.0 79.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:136.00 stddev:5.61 (4.1%) stddev-sans-first:5.75 17:17:58 INFO - PROCESS | 27803 | Values: 132.0 133.0 134.0 139.0 130.0 148.0 132.0 138.0 133.0 142.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:166.50 stddev:2.72 (1.6%) stddev-sans-first:2.35 17:17:58 INFO - PROCESS | 27803 | Values: 172.0 166.0 165.0 165.0 166.0 171.0 167.0 166.0 166.0 171.0 17:17:58 INFO - PROCESS | 27803 | 17:17:58 INFO - PROCESS | 27803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.51 17:17:58 INFO - PROCESS | 27803 | Values: 70.0 69.0 69.0 72.0 68.0 69.0 68.0 68.0 67.0 67.0 17:17:58 INFO - PROCESS | 27803 | -------- Summary: end -------- 17:17:58 INFO - PROCESS | 27803 | 17:17:59 INFO - TEST-INFO | 27803: exit 0 17:17:59 INFO - TEST-OK | kraken | took 64473ms 17:17:59 INFO - SUITE-END | took 1182s 17:17:59 INFO - Completed test suite (00:19:42) 17:17:59 INFO - javascript benchmark 17:17:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6265.771129276178, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.5555633320505, 2710.60696199051, 2730.2628290361604, 2733.2210320058775, 2752.2293757747825, 4715.3162791395225, 4905.877353066175, 4976.651634385595, 5001.424836143845, 5013.749312534377, 4856.0, 4873.098476781798, 4941.332920055791, 4970.0805351010085, 5034.949650503494, 4324.0, 4466.173757854791, 4523.841665541707, 4554.863354099366, 4582.610478109348, 4480.865574032784, 4510.639148868099, 4510.684252102355, 4526.660500462462, 4550.089982003596, 4296.548862369437, 4446.911061778778, 4453.109378124388, 4542.841000564964, 4564.863054108382, 4386.166628340637, 4386.539413361615, 4402.7578483183415, 4495.325701144821, 4552.271636538138, 4442.888927776799, 4453.955460445386, 4455.710378825398, 4468.664850136252, 4498.460184777848, 4829.492903245144, 4840.951590484121, 4875.585575226075, 4891.315215869781, 4921.360223170965, 5309.230161626542, 5329.413764485904, 5330.200469929503, 5331.067063263913, 5354.491323324278, 5359.088954877641, 5370.570354371641, 5387.973060134675, 5405.081136206815, 5424.349078110652, 4648.023914977893, 4861.368022157168, 4892.657513974059, 4907.803687852446, 4932.728699921467, 5322.813701520428, 5363.410024897258, 5393.325834270716, 5400.621956463088, 5408.513233808897, 5121.820736274212, 5157.0, 5166.354205724285, 5167.0, 5219.19102539107, 4988.575971042502, 5184.7926082956255, 5203.765830537559, 5210.739463026834, 5299.258103865462, 5162.225666150032, 5201.713905735221, 5215.061288967946, 5216.530512253916, 5219.608529360313, 5191.61062920275, 5195.9740201298755, 5202.0, 5205.401378841406, 5242.659227150223, 4194.412782210493, 4386.1447017831215, 4432.822687092545, 4442.111577684476, 4448.866534003985, 3873.1091848874917, 3881.068543549528, 3887.1642596841816, 3897.162110146332, 3922.5096862892137, 4497.2129877271345, 4515.390422293014, 4543.432070991126, 4547.977260113745, 4567.885802854888, 5000.74996250186, 5226.843194704165, 5249.921251181236, 5285.180796976475, 5320.068987927175, 4533.637309015271, 4537.160625284333, 4547.727136371762, 4561.749103799323, 4602.562756538124, 4762.452317983407, 4768.260919557474, 4769.0, 4775.570198682135, 4816.662833601685, 4599.4710608280475, 4824.155772739827, 4886.291487734187, 4907.435644900882, 4973.751312434436, 5251.816186433456, 5265.947340526699, 5281.973590132178, 5284.9471505284455, 5302.098643230737, 4906.116898958079, 4918.778654960463, 4933.925991110208, 4937.407511098548, 4939.036887806843, 4925.433575138905, 5146.588272938231, 5208.062548741263, 5212.061828870688, 5274.736263186902, 5307.681539107666, 5315.468453154654, 5317.202419637086, 5320.0955837506945, 5342.3856256531, 5176.378834539879, 5193.532582067481, 5196.32447781786, 5196.480351964773, 5236.89526209466, 4808.7595620219545, 5079.822206222764, 5134.8973020540125, 5164.018836421068, 5195.5843532518065, 5068.974655126701, 5075.3402057732255, 5089.185730283137, 5099.031184075014, 5148.099082660594, 5199.706051758821, 5215.191645294985, 5216.243644671577, 5224.738763061908, 5245.134552798745, 4766.5471780182215, 4965.4289756678445, 5046.798128074836, 5048.217526283432, 5105.693658380509], "value": 4814.007992612393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5842035314221, 570.3270141233346, 570.3982298674899, 573.3521121133119, 604.9697515124243, 34893.3021339573, 39314.213715725666, 39553.80223098888, 39555.80222098889, 39588.20823583534, 38536.229275414546, 38966.61033389665, 39028.60971390285, 39055.21889562207, 39180.60819391805, 7662.08055033394, 7760.6895724171245, 7788.883166752503, 7808.219178082203, 7824.256695613936, 7700.306972372486, 7726.7681969541, 7744.574048427335, 7787.182345853689, 7789.298963093321, 7740.225977402271, 7779.066512018566, 7791.181925897784, 7836.4906281091835, 7840.921590784076, 7721.420893433015, 7802.102758182825, 7802.609869506502, 7822.687092516349, 7832.56920869352, 7674.501157424749, 7704.807379815494, 7738.0, 7741.961290193569, 7760.611969401507, 36831.4475282871, 36964.81517592422, 37259.81370093159, 37358.62641373579, 37385.0, 2730.235534050469, 2875.1374587623836, 2938.9559156612668, 3116.4546204414364, 3241.983790081058, 25732.0, 26780.196594102013, 27538.449231015267, 28130.296742581395, 28305.716942830513, 3278.065751260879, 3288.293017001356, 3348.9497657535157, 3404.114930118162, 3428.297199074209, 217550.0, 218197.0, 218431.0, 219201.9039904806, 219899.0, 31458.213544661565, 31966.200844979063, 32070.19824504406, 32196.517052244235, 32499.837500812344, 33799.493007604906, 33908.49137262943, 34184.65815341865, 34407.0, 34502.48246276308, 12333.753324933452, 12435.191712538655, 12449.813252801216, 12475.376231188404, 12479.625611231677, 9784.461854598065, 9841.311108222355, 9844.753881153028, 9858.063483969012, 9891.406515609087, 7860.489068210548, 7878.527288362602, 7878.881816772753, 7930.325922296554, 7932.762017139495, 3099.8140111593375, 3105.813651180936, 3116.9064928052194, 3127.640321363027, 3156.794808337451, 872.4329186029132, 930.4649826349876, 1010.7473131717071, 1016.7051555049101, 1018.0786388318584, 28696.426071478454, 28776.568351474743, 28848.278793030342, 29531.114066578037, 29751.702482975325, 943.9433633981984, 959.0, 962.100436092256, 982.1504398695077, 986.6004268271362, 14718.55844324672, 15320.616984575252, 15492.380304787908, 15705.607359816097, 15721.135337556316, 376283.0, 378119.0, 381660.0, 381866.0, 381911.0, 49704.75147624239, 49716.254256186185, 49772.253416198786, 50049.74975125174, 50088.24867626988, 1180.4451907603413, 1193.7612477504533, 1210.5036934856666, 1217.701663092548, 1223.2293654997472, 26703.332416689736, 28066.85966570236, 28241.576376354784, 28908.42183156367, 29039.41921161607, 42644.360334594385, 42659.786701066296, 42949.14101717886, 42992.570074298856, 43158.35262471002, 315739.0, 319463.0, 320224.0, 321100.0, 321337.0, 24680.506389872462, 25527.0, 25566.0, 25765.613515797653, 26143.869280653475, 41887.0, 41904.58095419007, 42807.785961069996, 42911.78544107259, 43219.0, 36852.81573592115, 36904.63095369012, 37130.44304335491, 37917.0, 38210.80894595509, 35880.282394351445, 36987.44518832166, 37012.62987370092, 37226.8138659305, 37591.43612845864, 36258.274834502634, 36997.65768364277, 37282.440763388026, 37370.0, 37387.252254954205, 31232.843835780677, 33641.0, 33870.32259354848, 33914.830425847715, 34064.0, 23830.16594419187, 24086.036558537464, 24949.87525062363, 25805.354866127745, 26306.71856892411], "value": 16146.974114276552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.55897246386945, 365.29680365296804, 366.081136347767, 368.1807977250618, 389.0817670298096, 15622.453214137508, 16937.237824297907, 17906.820931790677, 17984.73022904654, 18046.81953180468, 16854.83145168551, 17039.659206815857, 17397.91301043496, 17569.91215043926, 17667.73498397525, 4962.776675049613, 5132.409772876111, 5148.819791307305, 5176.8705782355555, 5177.637565370425, 3699.3526132926763, 5114.258432527281, 5702.7433765480655, 5951.821445356624, 6014.548908831834, 6077.544184186182, 6084.239470066242, 6087.54343424245, 6097.57316987811, 6102.786402475915, 5134.127198376266, 5381.569474442035, 5400.621956463069, 5469.507744302992, 5476.7535460904355, 5216.426193118754, 5250.842474725764, 5266.394364648077, 5283.63014588979, 5304.177852432879, 11716.707082322924, 11882.28706277626, 12096.274223546616, 20064.39806805798, 20490.463215258766, 1908.3225454963426, 1932.391296741536, 2247.8985297204254, 2272.102519504803, 2412.3486658602255, 9424.387414818015, 9542.666006689733, 9586.0, 10985.285956412808, 13565.914726821831, 1640.0, 1746.8340507651753, 1782.9821701782946, 1827.7441158237857, 1871.7739880378374, 72212.63893680551, 72400.27599723988, 72859.27140728578, 74014.62992685055, 76448.88408927273, 10019.298649094639, 10043.598256069821, 10281.12610428122, 10343.482825858828, 10490.580376784843, 14199.645008874653, 14258.714825703635, 14292.142471451747, 14308.785368219485, 14315.28423578817, 6795.1845778506895, 6826.351496607815, 7005.229424763272, 7102.147742270858, 7118.501704880712, 6346.2067241594805, 6421.775237866652, 6483.0, 6625.569337993015, 6630.701618427182, 4116.382542618571, 4293.3130699088, 4310.6335961443, 4367.759773212504, 4502.4371953505815, 1469.2800527741545, 1537.8692811110957, 1555.7744127101507, 1813.3018787766541, 1855.2300795170124, 817.6198067898456, 856.8886044814134, 878.2666473494576, 889.155302462663, 891.5586784541694, 17026.659466810594, 17123.74314385285, 17164.0, 17479.737803932952, 17631.294748209926, 831.6174559702483, 843.9198276163754, 851.3997631669658, 862.1938487514069, 879.243850288764, 6808.6255255960405, 9796.9020309796, 9909.851352229722, 9915.603375865028, 9945.602175913027, 373016.0, 373333.0, 373687.0, 379677.0, 384533.0, 54033.0, 78426.60786696144, 79545.0, 80501.19498805054, 81504.0, 839.2404873589411, 849.3884403229665, 854.6709516836063, 859.0550394565928, 870.5081628879663, 15336.693266134838, 15356.232188390759, 16054.357825686842, 16069.839301606835, 16123.355065797237, 37295.0, 38138.0, 38962.0, 39324.0, 39437.60562394454, 51746.0, 52276.73861630668, 53241.73379133079, 54247.45752542424, 55632.44367556435, 6554.279029306867, 6563.9343606563325, 6633.70148343316, 6645.933540664531, 6672.099266599141, 10384.844227336445, 10566.31318964265, 10684.305520141166, 11462.312261264016, 11763.88236117662, 10235.795284094127, 10300.896991029993, 10442.582296708046, 10494.370337779757, 10716.0, 10126.8480972784, 10270.6405275815, 10307.123894469054, 10463.738406539898, 10640.308379955279, 9484.52577371115, 9690.56392462355, 9730.464824434725, 10621.203409744145, 10803.891961080288, 6271.3415091414745, 6684.231313399021, 6799.864002720017, 6895.310468953266, 7172.354488096096, 8799.384043116921, 10693.625723099654, 10718.946405267923, 10723.249372543847, 11142.554297827995], "value": 8129.225051117104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.4803574641635, 1389.86101389861, 1467.1710483576778, 1641.9261133249004, 1656.726640104382, 6449.580777249487, 7275.090613673291, 7491.475596708233, 7842.215778422155, 7868.370530357572, 7570.977917981085, 7853.646585903633, 7861.606919654023, 7867.921320786791, 7903.644336004893, 2173.717416735826, 2211.159759291467, 2211.9004644790944, 2212.424769559918, 2212.469007438211, 2130.6803979403057, 2157.244964262511, 2168.143583284602, 2182.443476913385, 2188.124750099957, 2158.5359147783224, 2165.5560610074895, 2165.6210163221454, 2173.0438607012943, 2186.8031877131057, 2108.546662467569, 2115.978840211609, 2120.6182887080395, 2124.362691192644, 2126.755423126345, 2081.5420607466335, 2097.161135545794, 2101.7057611934342, 2121.2363549122306, 2121.2469573301564, 7838.804029899241, 7855.96072019642, 7866.370690344758, 7895.368370530344, 7897.289243968071, 4382.320740285229, 4521.434820647419, 4556.225441674923, 4565.223911934979, 4569.360289559464, 2679.6516452861197, 2734.8769305381306, 2757.4071574611353, 2778.166550035002, 2806.803523753338, 813.6540725779446, 858.4034096303072, 863.4991704811194, 863.7279257034014, 865.8008658008694, 10449.0, 10475.26673132881, 10493.0, 10527.578896844117, 10544.578216871316, 3862.942055869164, 4006.779627120478, 4057.5130984282073, 4163.479565054368, 4164.6251837334175, 9017.413868098552, 9034.774130646654, 9037.367384283169, 9046.86429703555, 9053.77365565853, 4445.177642136216, 4473.821047158077, 4493.820247190076, 4494.056248187917, 4494.303382975644, 3249.77251592391, 4044.656204222674, 4082.0, 4088.652464540488, 4118.732282401635, 3609.4224924012033, 3614.566252049771, 3712.3874560697723, 3746.606606306353, 3757.868474603376, 1135.2564070533813, 1158.623447379605, 1161.384466232898, 1164.574930150489, 1173.8708742038368, 745.4446437404168, 750.9812254693567, 852.228732996639, 859.9551544873009, 869.1482347299682, 5108.591312694975, 5402.756875940592, 5409.26974858397, 5409.350877894678, 5414.675119492843, 900.6532484993324, 908.7410088124985, 916.4466229740526, 947.1381043250609, 955.5604421965835, 3543.2027793746715, 3677.7057835373107, 3681.208540163878, 3771.5662698789442, 3795.2978698940783, 8896.377253592316, 9339.813203735886, 9634.807303853884, 9674.22606191503, 9761.51192440375, 9249.213816825646, 9587.664431744855, 9606.327557071078, 9611.279154063473, 9649.614015439303, 6980.965095174593, 7044.119485064367, 7183.92816071843, 7305.269473052758, 7355.59544225062, 5644.322681278109, 5722.284714410699, 5736.483716465538, 5763.596548241583, 6014.969925150522, 8899.555022248733, 8907.55462226899, 9018.954905225695, 9022.007579166155, 9097.818043638958, 8763.474191548528, 8808.0, 9083.04628014049, 9100.317476189444, 9141.177294043568, 5684.687342196054, 6579.144711187515, 6636.767713130017, 6698.698558564974, 6755.831104222434, 7638.197989211275, 7719.228077192236, 7736.613169341623, 7753.37972962173, 7765.107012693613, 6658.267590565131, 6683.365080317362, 6729.596224226562, 6790.42281406086, 6999.265077166824, 6618.8345291368105, 6639.402453779183, 6658.533902626963, 6711.63086030273, 6785.830354240986, 6344.1118243445035, 6424.743010279536, 6450.129232553545, 6455.386738259858, 6498.902516462352, 4551.317302404534, 4563.475200352002, 4586.931196031996, 4588.334691469785, 4606.378138951199, 4419.049904270597, 4484.461864576272, 4538.500764915922, 4550.408446901882, 4680.227762419163], "value": 4115.620957603763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.518019367076, 293.1118710307767, 298.4091498832312, 300.72483677435156, 302.63230175336986, 4930.556249937505, 5023.346964894558, 5110.795568177273, 5129.102407078761, 5130.204818253172, 5033.439633713551, 5038.2694509296225, 5064.822731204408, 5068.315777370063, 5071.315372424721, 3967.642912137907, 3968.9206215875665, 3971.98014009931, 3974.7813870237123, 3990.4612877261634, 3867.4778904847767, 3969.2656858481273, 3980.0049987503126, 3987.4018897165365, 3987.441758153861, 3929.2534418460546, 3934.2131573685233, 3940.8423663053445, 3942.2903877302074, 3952.8814135575835, 3915.177812659345, 3931.0761970936805, 3949.8025098744947, 3964.702647301464, 3965.156202365885, 3487.134383105052, 3489.7033752130847, 3492.3539145257955, 3493.91265218369, 3508.3684936711384, 4865.540337898617, 4938.728369939652, 4942.5304596063315, 4963.528464795875, 5013.5989120870245, 4501.594856462902, 4505.504394516601, 4508.932366014513, 4512.774361281956, 4525.502194758574, 5338.172583249602, 5338.85214678842, 5343.412224655285, 5350.27771250884, 5361.973190134025, 3467.6705712957482, 3675.228202077567, 3676.283124790667, 3785.167263202091, 3798.734088613798, 5524.447555244484, 5558.86102847428, 5564.8052318169075, 5567.3040869891265, 5575.912697024082, 3780.9432858507143, 3785.8674946377296, 3791.3175628386603, 3792.6965842732516, 3793.3172029034486, 3610.1335679436747, 3842.404427313715, 3846.2884016612898, 3848.5958974307855, 3854.672352849983, 4377.124575084996, 4401.163778882066, 4412.36020776992, 4414.977925110418, 4420.734755914591, 5296.549793267538, 5303.973480132652, 5319.867003324948, 5321.467853214725, 5325.360956685223, 1236.9876301237052, 1274.2736640115231, 1299.5061876487064, 1305.595265467708, 1323.7683405404016, 858.965641374338, 882.2104216725994, 890.6081324217324, 897.717219075989, 897.8159477307137, 4583.220852455091, 4606.516315786861, 4618.145643056046, 4624.699394539344, 4633.328167415706, 5413.377461591967, 5432.619716619799, 5433.809816656477, 5437.238786569884, 5451.563874890078, 4492.910141797146, 4635.258358662665, 4639.559241872017, 4653.185692503798, 4655.208614535537, 2557.744225577427, 2560.257525317637, 2583.2895953612906, 2591.922242332733, 2597.909073182467, 4448.733076015449, 4542.341360502709, 4553.203189441834, 4565.402109261799, 4566.26939689648, 4686.531346865286, 4843.200871856105, 4850.95149048512, 4851.781669824796, 4893.657443978958, 4392.890177745518, 4464.330350447459, 4525.411696479502, 4540.841070562515, 4545.250033744462, 4710.952890471051, 4750.976245118753, 4752.405949256343, 4753.5008824072975, 4793.257045158006, 4652.278896771006, 4661.836835710734, 4677.883052923704, 4682.789274482589, 4692.756419548754, 4137.296659567821, 4408.382826404242, 4424.668149888836, 4456.888577785451, 4512.9774351128035, 3409.0, 3411.385950528929, 3414.146463384154, 3418.5555877735737, 3436.862525498952, 4762.0, 4765.855365085795, 4790.592799612072, 4800.871795128072, 5185.870353241199, 5176.275321455075, 5222.529972302511, 5235.764390602356, 5257.4216836147225, 5280.406046739361, 5311.229871668664, 5321.217392173665, 5322.228276899906, 5322.41453440129, 5334.306540149756, 4948.876278092933, 5128.640910158885, 5174.172132458939, 5182.637215395037, 5239.790408383622, 5355.651882627617, 5371.140617501337, 5374.0, 5374.919376209438, 5384.380796208487, 5254.343207099113, 5256.371814092953, 5256.421793602777, 5267.499587539178, 5272.44639312882], "value": 3847.8431352840066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.2261486921659, 549.8048192891526, 549.925760022397, 606.0878378041049, 614.3919063575124, 11643.767124657501, 11956.820647690292, 12242.571509997151, 12264.0, 12659.430325635345, 12783.29691866947, 13105.279209643466, 13113.0, 13125.93437032816, 13132.73734525309, 639.6545865232792, 766.8657984852642, 790.7430085222297, 792.3700657976922, 795.5425630262594, 764.3235736373322, 775.7944144801633, 782.6438970268542, 790.5928446849877, 792.093053453795, 831.1231650608605, 831.5301854452246, 832.1719888710742, 832.5296207642692, 834.1116710703081, 824.6907409721355, 824.7979245084932, 824.9422540422173, 826.2522417212402, 826.2893911236332, 605.1316361021948, 606.9271687397496, 607.4259824465881, 608.7838817219912, 609.232367217305, 11555.94222028893, 11671.591494297743, 11690.41547922609, 11695.766084678344, 11708.88291117095, 11926.224795388272, 11959.641210763692, 12142.939285303517, 12282.671056898418, 12661.810072848915, 10129.645462408855, 10235.79528409435, 10276.383416995004, 10280.48597570126, 10346.43094629795, 3306.983465082659, 3348.0, 3352.1284466039006, 3388.0852169914233, 3394.8642054317797, 67318.66340668315, 67891.56867450592, 68277.3172268276, 69170.65414672944, 69829.0, 9607.423554586747, 9685.225181985565, 9733.318667693335, 9902.702918912444, 9951.900480995097, 18255.361062362754, 18319.90840045818, 18387.356442524448, 18409.90795046016, 18438.262469501336, 6639.933600664028, 6738.831529211809, 6786.151731033621, 6795.014722865157, 6889.138857642794, 3690.0, 3699.8705045323286, 3823.8279277432584, 3853.5183102112237, 3859.3439115350457, 2712.823666461674, 2835.9858200709277, 2848.31640406301, 2852.6006359109742, 2852.7717782577342, 466.56143225368044, 471.8843883248626, 474.3217199404815, 482.2982560374646, 493.48184406373167, 470.2499513276319, 487.4004973882145, 488.92177251639566, 489.84080173943613, 505.1286530734454, 7097.290270972861, 7220.9638951805955, 7525.24747525254, 7545.962270188614, 7598.316151546387, 502.58787794009294, 512.3952990710335, 520.3131865936926, 524.1325606121875, 526.3736153976755, 3464.272502774395, 3566.8573257069947, 3580.838862251205, 3583.283343331344, 3734.7012239020814, 61158.0, 102420.0, 104597.47701261444, 107505.4624726887, 108506.0, 87411.56294218489, 91133.54433227792, 92830.0, 92986.53506732424, 94708.52645736728, 45063.0, 49825.0, 51270.74364628153, 81511.18488815155, 85159.57420212984, 6965.860533903827, 7282.689115958966, 7364.815879603053, 7381.8154546136775, 7404.851902962018, 46785.29822052604, 48368.75815620899, 48470.0, 48825.0, 49140.50859491359, 38464.6153538461, 40072.59927400688, 40201.39697904592, 43661.34507982319, 51372.74313628408, 8637.093105223861, 8778.780530486789, 8795.0, 8838.646454141763, 8913.910860891308, 9606.615735370508, 9609.30246414001, 9796.363236389612, 9988.800223995624, 10034.29759916828, 9130.680426185052, 9252.814943701223, 9265.119813617695, 9349.906500934903, 9469.857952130862, 9020.458772473672, 9074.682386116454, 9182.265418766616, 9337.623277610883, 9474.0, 8946.003207730255, 9220.0, 9367.718968430958, 9429.481378524248, 9638.373505722106, 7296.343329100407, 7339.9633001834645, 7347.302006309392, 7360.728500904244, 7691.38468922496, 9200.217981471382, 10138.49307534635, 10224.64213752515, 10522.15822734164, 10694.572217111228], "value": 6046.477868864257, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 110.0, 114.0, 115.0, 117.0, 115.0, 115.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 150.0, 193.0, 132.0, 150.0, 155.0, 125.0, 192.0, 123.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 171.0, 162.0, 163.0, 162.0, 162.0, 165.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 174.0, 78.0, 75.0, 75.0, 76.0, 157.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 139.0, 87.0, 85.0, 86.0, 139.0, 85.0, 85.0, 138.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 63.0, 64.0, 62.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 96.0, 80.0, 81.0, 79.0, 83.0, 79.0, 87.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 134.0, 139.0, 130.0, 148.0, 132.0, 138.0, 133.0, 142.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 165.0, 165.0, 166.0, 171.0, 167.0, 166.0, 166.0, 171.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 72.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0], "value": 68.7, "unit": "score"}]}]} 17:17:59 INFO - Return code: 0 17:18:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:00 ERROR - # TBPL SUCCESS # 17:18:00 INFO - Running post-action listener: _resource_record_post_action 17:18:00 INFO - [mozharness: 2016-08-08 00:18:00.040715Z] Finished run-tests step (success) 17:18:00 INFO - Running post-run listener: _resource_record_post_run 17:18:00 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547135488; Read time: 16; Write time: 457616 17:18:00 INFO - TinderboxPrint: CPU usage
13.4% 17:18:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:18:00 INFO - TinderboxPrint: I/O write bytes / time
547,135,488 / 457,616 17:18:00 INFO - TinderboxPrint: CPU idle
8,285.0 (86.6%) 17:18:00 INFO - TinderboxPrint: CPU user
1,222.9 (12.8%) 17:18:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:18:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248680448; Read time: 0; Write time: 247728 17:18:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 298455040; Read time: 0; Write time: 209888 17:18:00 INFO - Running post-run listener: _upload_blobber_files 17:18:00 INFO - Blob upload gear active. 17:18:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:00 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 17:18:00 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:18:00 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:18:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:01 INFO - (blobuploader) - INFO - Done attempting. 17:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:03 INFO - (blobuploader) - INFO - Done attempting. 17:18:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:06 INFO - (blobuploader) - INFO - Done attempting. 17:18:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:06 INFO - Return code: 0 17:18:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d007d00098b86d71fa1eead3a5c274d2db4e55cd18adef0c8de2eca66306a2d57ab3a8fb45b5fbc1e9c4a49d814a4e8221e1299fd8a431b2e2cfba27356dbe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3b4e3c975f2a69fca207569d4bde045463ba618ec72cf90869232aac2b13617bf5e3573ad94617251c827c19c2a36640a75a40b67ec49fea8f1491b1ff72a17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccbae9160bf27b4105b61efc973904172bec674cd422f52a1d734b23cca16398617d46675bc1a5d18edceac8c7fe3f601f61497026796556dd36ad224e9060a1"} 17:18:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:06 INFO - Contents: 17:18:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d007d00098b86d71fa1eead3a5c274d2db4e55cd18adef0c8de2eca66306a2d57ab3a8fb45b5fbc1e9c4a49d814a4e8221e1299fd8a431b2e2cfba27356dbe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3b4e3c975f2a69fca207569d4bde045463ba618ec72cf90869232aac2b13617bf5e3573ad94617251c827c19c2a36640a75a40b67ec49fea8f1491b1ff72a17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccbae9160bf27b4105b61efc973904172bec674cd422f52a1d734b23cca16398617d46675bc1a5d18edceac8c7fe3f601f61497026796556dd36ad224e9060a1"} 17:18:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:06 INFO - Copying logs to upload dir... 17:18:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.239367 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-07 17:18:05.419228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 17:18:05.422693) ========= 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=920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541 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-Non-PGO/sha512/0d007d00098b86d71fa1eead3a5c274d2db4e55cd18adef0c8de2eca66306a2d57ab3a8fb45b5fbc1e9c4a49d814a4e8221e1299fd8a431b2e2cfba27356dbe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3b4e3c975f2a69fca207569d4bde045463ba618ec72cf90869232aac2b13617bf5e3573ad94617251c827c19c2a36640a75a40b67ec49fea8f1491b1ff72a17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccbae9160bf27b4105b61efc973904172bec674cd422f52a1d734b23cca16398617d46675bc1a5d18edceac8c7fe3f601f61497026796556dd36ad224e9060a1"} build_url:https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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-Non-PGO/sha512/0d007d00098b86d71fa1eead3a5c274d2db4e55cd18adef0c8de2eca66306a2d57ab3a8fb45b5fbc1e9c4a49d814a4e8221e1299fd8a431b2e2cfba27356dbe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3b4e3c975f2a69fca207569d4bde045463ba618ec72cf90869232aac2b13617bf5e3573ad94617251c827c19c2a36640a75a40b67ec49fea8f1491b1ff72a17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccbae9160bf27b4105b61efc973904172bec674cd422f52a1d734b23cca16398617d46675bc1a5d18edceac8c7fe3f601f61497026796556dd36ad224e9060a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 17:18:05.449993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:18:05.450284) ========= 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=920470bf432669ad7e3a5387000001ca-1470613636.163671-1388663541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:18:05.536707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 17:18:05.537434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 17:18:05.538062) ========= ========= Total master_lag: 0.18 =========