builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1469747563.07 results: success (0) buildid: 20160728155146 builduid: 4b3aec176eec4934b83b43373d266e98 revision: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.066889) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.067424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.067707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.084065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.084788) ========= 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=7de08804244eb36560b44971000001c3-1469747320.576093-473822977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 16:12:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-07-28 16:12:43 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.189409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.189769) ========= 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=7de08804244eb36560b44971000001c3-1469747320.576093-473822977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015208 ========= master_lag: 0.50 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:43.702450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-28 16:12:43.702853) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06e51ce8f72f94112afcbb9a5a90364a8d811a4b --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 06e51ce8f72f94112afcbb9a5a90364a8d811a4b --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=7de08804244eb36560b44971000001c3-1469747320.576093-473822977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 16:12:43,772 truncating revision to first 12 chars 2016-07-28 16:12:43,772 Setting DEBUG logging. 2016-07-28 16:12:43,772 attempt 1/10 2016-07-28 16:12:43,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06e51ce8f72f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 16:12:44,994 unpacking tar archive at: fx-team-06e51ce8f72f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.545821 ========= master_lag: 2.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-28 16:12:47.585081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:47.585409) ========= script_repo_revision: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:47.585809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:47.586144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 16:12:47.607571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-28 16:12:47.607852) ========= /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=7de08804244eb36560b44971000001c3-1469747320.576093-473822977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:12:47 INFO - MultiFileLogger online at 20160728 16:12:47 in /builds/slave/test 16:12:47 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:12:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:47 INFO - {'append_to_log': False, 16:12:47 INFO - 'base_work_dir': '/builds/slave/test', 16:12:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:12:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:47 INFO - 'branch': 'Fx-Team-Non-PGO', 16:12:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:47 INFO - 'config_files': ('talos/linux_config.py',), 16:12:47 INFO - 'default_actions': ('clobber', 16:12:47 INFO - 'read-buildbot-config', 16:12:47 INFO - 'download-and-extract', 16:12:47 INFO - 'populate-webroot', 16:12:47 INFO - 'create-virtualenv', 16:12:47 INFO - 'install', 16:12:47 INFO - 'run-tests'), 16:12:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:47 INFO - 'download_minidump_stackwalk': True, 16:12:47 INFO - 'download_symbols': 'ondemand', 16:12:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:47 INFO - 'installer_path': 'installer.exe', 16:12:47 INFO - 'log_level': 'info', 16:12:47 INFO - 'log_name': 'talos', 16:12:47 INFO - 'log_to_console': True, 16:12:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:12:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:12:47 INFO - 'opt_config_files': (), 16:12:47 INFO - 'pip_index': False, 16:12:47 INFO - 'sps_profile': False, 16:12:47 INFO - 'sps_profile_interval': 0, 16:12:47 INFO - 'suite': 'dromaeojs-e10s', 16:12:47 INFO - 'system_bits': '32', 16:12:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:47 INFO - 'title': 'talos-linux64-ix-003', 16:12:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:47 INFO - 'use_talos_json': True, 16:12:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:47 INFO - 'work_dir': 'build'} 16:12:47 INFO - [mozharness: 2016-07-28 23:12:47.759893Z] Running clobber step. 16:12:47 INFO - Running pre-action listener: _resource_record_pre_action 16:12:47 INFO - Running main action method: clobber 16:12:47 INFO - rmtree: /builds/slave/test/build 16:12:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:48 INFO - Running post-action listener: _resource_record_post_action 16:12:48 INFO - [mozharness: 2016-07-28 23:12:48.290855Z] Finished clobber step (success) 16:12:48 INFO - [mozharness: 2016-07-28 23:12:48.290957Z] Running read-buildbot-config step. 16:12:48 INFO - Running pre-action listener: _resource_record_pre_action 16:12:48 INFO - Running main action method: read_buildbot_config 16:12:48 INFO - Using buildbot properties: 16:12:48 INFO - { 16:12:48 INFO - "project": "", 16:12:48 INFO - "product": "firefox", 16:12:48 INFO - "script_repo_revision": "production", 16:12:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:12:48 INFO - "repository": "", 16:12:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:12:48 INFO - "buildid": "20160728155146", 16:12:48 INFO - "pgo_build": "False", 16:12:48 INFO - "basedir": "/builds/slave/test", 16:12:48 INFO - "buildnumber": 1710, 16:12:48 INFO - "slavename": "talos-linux64-ix-003", 16:12:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:12:48 INFO - "platform": "ubuntu64_hw", 16:12:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:12:48 INFO - "branch": "fx-team", 16:12:48 INFO - "repo_path": "integration/fx-team", 16:12:48 INFO - "revision": "06e51ce8f72f94112afcbb9a5a90364a8d811a4b", 16:12:48 INFO - "stage_platform": "linux64", 16:12:48 INFO - "builduid": "4b3aec176eec4934b83b43373d266e98", 16:12:48 INFO - "slavebuilddir": "test" 16:12:48 INFO - } 16:12:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:12:48 INFO - Running post-action listener: _resource_record_post_action 16:12:48 INFO - [mozharness: 2016-07-28 23:12:48.293406Z] Finished read-buildbot-config step (success) 16:12:48 INFO - [mozharness: 2016-07-28 23:12:48.293494Z] Running download-and-extract step. 16:12:48 INFO - Running pre-action listener: _resource_record_pre_action 16:12:48 INFO - Running main action method: download_and_extract 16:12:48 INFO - mkdir: /builds/slave/test/build/tests 16:12:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:48 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:12:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:12:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:12:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:12:52 INFO - Downloaded 1361 bytes. 16:12:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:12:52 INFO - Using the following test package requirements: 16:12:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:12:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:12:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'jsshell-linux-x86_64.zip'], 16:12:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:12:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:12:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:12:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:12:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:12:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:12:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:12:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:52 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:54 INFO - Downloaded 22750234 bytes. 16:12:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:12:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:12:55 INFO - Return code: 0 16:12:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:55 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:12:56 INFO - Downloaded 22750234 bytes. 16:12:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:12:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:12:58 INFO - Return code: 0 16:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:58 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:12:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:12:58 INFO - Downloaded 14413725 bytes. 16:12:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:12:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:12:59 INFO - Return code: 0 16:12:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:59 INFO - https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:13:00 INFO - Downloaded 57164909 bytes. 16:13:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:13:00 INFO - mkdir: /builds/slave/test/properties 16:13:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:00 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:00 INFO - Contents: 16:13:00 INFO - build_url:https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:13:01 INFO - Running post-action listener: _resource_record_post_action 16:13:01 INFO - Running post-action listener: set_extra_try_arguments 16:13:01 INFO - [mozharness: 2016-07-28 23:13:01.667115Z] Finished download-and-extract step (success) 16:13:01 INFO - [mozharness: 2016-07-28 23:13:01.667351Z] Running populate-webroot step. 16:13:01 INFO - Running pre-action listener: _resource_record_pre_action 16:13:01 INFO - Running main action method: populate_webroot 16:13:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:01 INFO - '--tppagecycles', 16:13:01 INFO - '7'], 16:13:01 INFO - 'tests': ['tsvgm']}}, 16:13:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['damp', 'tps']}, 16:13:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'tests': ['damp', 'tps']}, 16:13:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['dromaeo_dom']}, 16:13:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['basic_compositor_video']}, 16:13:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:13:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['a11yr', 16:13:01 INFO - 'ts_paint', 16:13:01 INFO - 'tpaint', 16:13:01 INFO - 'sessionrestore', 16:13:01 INFO - 'sessionrestore_no_auto_restore', 16:13:01 INFO - 'tabpaint']}, 16:13:01 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:01 INFO - 'ts_paint', 16:13:01 INFO - 'tpaint', 16:13:01 INFO - 'sessionrestore', 16:13:01 INFO - 'sessionrestore_no_auto_restore', 16:13:01 INFO - 'tabpaint']}, 16:13:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:01 INFO - 'ts_paint', 16:13:01 INFO - 'tpaint', 16:13:01 INFO - 'sessionrestore', 16:13:01 INFO - 'sessionrestore_no_auto_restore', 16:13:01 INFO - 'tabpaint']}, 16:13:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:01 INFO - 'ts_paint', 16:13:01 INFO - 'tpaint', 16:13:01 INFO - 'sessionrestore', 16:13:01 INFO - 'sessionrestore_no_auto_restore', 16:13:01 INFO - 'tabpaint']}, 16:13:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['a11yr', 16:13:01 INFO - 'ts_paint', 16:13:01 INFO - 'tpaint', 16:13:01 INFO - 'sessionrestore', 16:13:01 INFO - 'sessionrestore_no_auto_restore', 16:13:01 INFO - 'tabpaint']}, 16:13:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['a11yr', 16:13:01 INFO - 'ts_paint', 16:13:01 INFO - 'tpaint', 16:13:01 INFO - 'sessionrestore', 16:13:01 INFO - 'sessionrestore_no_auto_restore', 16:13:01 INFO - 'tabpaint']}, 16:13:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['tsvgx', 16:13:01 INFO - 'tsvgr_opacity', 16:13:01 INFO - 'tart', 16:13:01 INFO - 'tscrollx', 16:13:01 INFO - 'cart']}, 16:13:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:01 INFO - 'tsvgr_opacity', 16:13:01 INFO - 'tart', 16:13:01 INFO - 'tscrollx', 16:13:01 INFO - 'cart']}, 16:13:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'talos_options': ['--disable-e10s'], 16:13:01 INFO - 'tests': ['tp5o']}, 16:13:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'tests': ['tp5o']}, 16:13:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'talos_options': ['--disable-e10s', 16:13:01 INFO - '--xperf_path', 16:13:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:01 INFO - 'tests': ['tp5n']}, 16:13:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:01 INFO - 'talos_options': ['--xperf_path', 16:13:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:01 INFO - 'tests': ['tp5n']}}, 16:13:01 INFO - 'talos.zip': {'path': '', 16:13:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:01 INFO - Running post-action listener: _resource_record_post_action 16:13:01 INFO - [mozharness: 2016-07-28 23:13:01.686186Z] Finished populate-webroot step (success) 16:13:01 INFO - [mozharness: 2016-07-28 23:13:01.686276Z] Running create-virtualenv step. 16:13:01 INFO - Running pre-action listener: _resource_record_pre_action 16:13:01 INFO - Running main action method: create_virtualenv 16:13:01 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:01 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:13:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:01 INFO - Using real prefix '/usr' 16:13:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:04 INFO - Installing pip.................done. 16:13:04 INFO - Return code: 0 16:13:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:04 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:04 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:13:04 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:13:04 INFO - Using env: {'DISPLAY': ':0', 16:13:04 INFO - 'HOME': '/home/cltbld', 16:13:04 INFO - 'LANG': 'en_US.UTF-8', 16:13:04 INFO - 'LANGUAGE': 'en_US:en', 16:13:04 INFO - 'LOGNAME': 'cltbld', 16:13:04 INFO - 'MAIL': '/var/mail/cltbld', 16:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:04 INFO - 'MOZ_NO_REMOTE': '1', 16:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:04 INFO - 'NO_EM_RESTART': '1', 16:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:04 INFO - 'PWD': '/builds/slave/test', 16:13:04 INFO - 'SHELL': '/bin/bash', 16:13:04 INFO - 'SHLVL': '1', 16:13:04 INFO - 'TERM': 'linux', 16:13:04 INFO - 'TMOUT': '86400', 16:13:04 INFO - 'USER': 'cltbld', 16:13:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:04 INFO - '_': '/tools/buildbot/bin/python'} 16:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:04 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:13:04 INFO - Cleaning up... 16:13:04 INFO - Return code: 0 16:13:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:13:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:04 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:04 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:13:04 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:13:04 INFO - Using env: {'DISPLAY': ':0', 16:13:04 INFO - 'HOME': '/home/cltbld', 16:13:04 INFO - 'LANG': 'en_US.UTF-8', 16:13:04 INFO - 'LANGUAGE': 'en_US:en', 16:13:04 INFO - 'LOGNAME': 'cltbld', 16:13:04 INFO - 'MAIL': '/var/mail/cltbld', 16:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:04 INFO - 'MOZ_NO_REMOTE': '1', 16:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:04 INFO - 'NO_EM_RESTART': '1', 16:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:04 INFO - 'PWD': '/builds/slave/test', 16:13:04 INFO - 'SHELL': '/bin/bash', 16:13:04 INFO - 'SHLVL': '1', 16:13:04 INFO - 'TERM': 'linux', 16:13:04 INFO - 'TMOUT': '86400', 16:13:04 INFO - 'USER': 'cltbld', 16:13:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:04 INFO - '_': '/tools/buildbot/bin/python'} 16:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:04 INFO - Downloading/unpacking psutil>=3.1.1 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:06 INFO - Installing collected packages: psutil 16:13:06 INFO - Running setup.py install for psutil 16:13:06 INFO - building 'psutil._psutil_linux' extension 16:13:06 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:13:06 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:13:06 INFO - building 'psutil._psutil_posix' extension 16:13:06 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:13:07 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:13:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:07 INFO - Successfully installed psutil 16:13:07 INFO - Cleaning up... 16:13:07 INFO - Return code: 0 16:13:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:13:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:07 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:07 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:13:07 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:13:07 INFO - Using env: {'DISPLAY': ':0', 16:13:07 INFO - 'HOME': '/home/cltbld', 16:13:07 INFO - 'LANG': 'en_US.UTF-8', 16:13:07 INFO - 'LANGUAGE': 'en_US:en', 16:13:07 INFO - 'LOGNAME': 'cltbld', 16:13:07 INFO - 'MAIL': '/var/mail/cltbld', 16:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:07 INFO - 'MOZ_NO_REMOTE': '1', 16:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:07 INFO - 'NO_EM_RESTART': '1', 16:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:07 INFO - 'PWD': '/builds/slave/test', 16:13:07 INFO - 'SHELL': '/bin/bash', 16:13:07 INFO - 'SHLVL': '1', 16:13:07 INFO - 'TERM': 'linux', 16:13:07 INFO - 'TMOUT': '86400', 16:13:07 INFO - 'USER': 'cltbld', 16:13:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:07 INFO - '_': '/tools/buildbot/bin/python'} 16:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:13:07 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:13:07 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:13:07 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:13:07 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:13:07 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:13:07 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:13:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:13:09 INFO - Installing collected packages: mozsystemmonitor 16:13:09 INFO - Running setup.py install for mozsystemmonitor 16:13:09 INFO - Successfully installed mozsystemmonitor 16:13:09 INFO - Cleaning up... 16:13:09 INFO - Return code: 0 16:13:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:09 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:09 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:13:09 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:13:09 INFO - Using env: {'DISPLAY': ':0', 16:13:09 INFO - 'HOME': '/home/cltbld', 16:13:09 INFO - 'LANG': 'en_US.UTF-8', 16:13:09 INFO - 'LANGUAGE': 'en_US:en', 16:13:09 INFO - 'LOGNAME': 'cltbld', 16:13:09 INFO - 'MAIL': '/var/mail/cltbld', 16:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:09 INFO - 'MOZ_NO_REMOTE': '1', 16:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:09 INFO - 'NO_EM_RESTART': '1', 16:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:09 INFO - 'PWD': '/builds/slave/test', 16:13:09 INFO - 'SHELL': '/bin/bash', 16:13:09 INFO - 'SHLVL': '1', 16:13:09 INFO - 'TERM': 'linux', 16:13:09 INFO - 'TMOUT': '86400', 16:13:09 INFO - 'USER': 'cltbld', 16:13:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:09 INFO - '_': '/tools/buildbot/bin/python'} 16:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:09 INFO - Downloading/unpacking jsonschema==2.5.1 16:13:09 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:13:09 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:13:09 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:13:09 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:13:09 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:13:09 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:13:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:13:11 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:13:11 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:13:11 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:13:11 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:13:11 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:13:11 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:13:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:11 INFO - warning: no files found matching '*.txt' 16:13:11 INFO - no previously-included directories found matching 'build' 16:13:11 INFO - no previously-included directories found matching 'dist' 16:13:11 INFO - no previously-included directories found matching '.git*' 16:13:11 INFO - Installing collected packages: jsonschema, functools32 16:13:11 INFO - Running setup.py install for functools32 16:13:12 INFO - warning: no files found matching '*.txt' 16:13:12 INFO - no previously-included directories found matching 'build' 16:13:12 INFO - no previously-included directories found matching 'dist' 16:13:12 INFO - no previously-included directories found matching '.git*' 16:13:12 INFO - Successfully installed jsonschema functools32 16:13:12 INFO - Cleaning up... 16:13:12 INFO - Return code: 0 16:13:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:13:12 INFO - Using env: {'DISPLAY': ':0', 16:13:12 INFO - 'HOME': '/home/cltbld', 16:13:12 INFO - 'LANG': 'en_US.UTF-8', 16:13:12 INFO - 'LANGUAGE': 'en_US:en', 16:13:12 INFO - 'LOGNAME': 'cltbld', 16:13:12 INFO - 'MAIL': '/var/mail/cltbld', 16:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:12 INFO - 'MOZ_NO_REMOTE': '1', 16:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:12 INFO - 'NO_EM_RESTART': '1', 16:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:12 INFO - 'PWD': '/builds/slave/test', 16:13:12 INFO - 'SHELL': '/bin/bash', 16:13:12 INFO - 'SHLVL': '1', 16:13:12 INFO - 'TERM': 'linux', 16:13:12 INFO - 'TMOUT': '86400', 16:13:12 INFO - 'USER': 'cltbld', 16:13:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:12 INFO - '_': '/tools/buildbot/bin/python'} 16:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:13:12 INFO - Cleaning up... 16:13:12 INFO - Return code: 0 16:13:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:13:12 INFO - Using env: {'DISPLAY': ':0', 16:13:12 INFO - 'HOME': '/home/cltbld', 16:13:12 INFO - 'LANG': 'en_US.UTF-8', 16:13:12 INFO - 'LANGUAGE': 'en_US:en', 16:13:12 INFO - 'LOGNAME': 'cltbld', 16:13:12 INFO - 'MAIL': '/var/mail/cltbld', 16:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:12 INFO - 'MOZ_NO_REMOTE': '1', 16:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:12 INFO - 'NO_EM_RESTART': '1', 16:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:12 INFO - 'PWD': '/builds/slave/test', 16:13:12 INFO - 'SHELL': '/bin/bash', 16:13:12 INFO - 'SHLVL': '1', 16:13:12 INFO - 'TERM': 'linux', 16:13:12 INFO - 'TMOUT': '86400', 16:13:12 INFO - 'USER': 'cltbld', 16:13:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:12 INFO - '_': '/tools/buildbot/bin/python'} 16:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:12 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:13:12 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:13:12 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:13:12 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:13:12 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:13:12 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:13:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:15 INFO - Downloading docopt-0.6.1.tar.gz 16:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:15 INFO - Running setup.py install for blobuploader 16:13:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:15 INFO - Running setup.py install for requests 16:13:15 INFO - Running setup.py install for docopt 16:13:15 INFO - Successfully installed blobuploader requests docopt 16:13:15 INFO - Cleaning up... 16:13:15 INFO - Return code: 0 16:13:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:15 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:15 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:13:15 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:13:15 INFO - Using env: {'DISPLAY': ':0', 16:13:15 INFO - 'HOME': '/home/cltbld', 16:13:15 INFO - 'LANG': 'en_US.UTF-8', 16:13:15 INFO - 'LANGUAGE': 'en_US:en', 16:13:15 INFO - 'LOGNAME': 'cltbld', 16:13:15 INFO - 'MAIL': '/var/mail/cltbld', 16:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:15 INFO - 'MOZ_NO_REMOTE': '1', 16:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:15 INFO - 'NO_EM_RESTART': '1', 16:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:15 INFO - 'PWD': '/builds/slave/test', 16:13:15 INFO - 'SHELL': '/bin/bash', 16:13:15 INFO - 'SHLVL': '1', 16:13:15 INFO - 'TERM': 'linux', 16:13:15 INFO - 'TMOUT': '86400', 16:13:15 INFO - 'USER': 'cltbld', 16:13:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:15 INFO - '_': '/tools/buildbot/bin/python'} 16:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:15 INFO - Running setup.py (path:/tmp/pip-zNOgbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:16 INFO - Running setup.py (path:/tmp/pip-W4FKxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:16 INFO - Running setup.py (path:/tmp/pip-WXBWFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:16 INFO - Running setup.py (path:/tmp/pip-yRtjZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:16 INFO - Running setup.py (path:/tmp/pip-rEbpgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:16 INFO - Running setup.py (path:/tmp/pip-wyge95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:16 INFO - Running setup.py (path:/tmp/pip-P4o5_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:16 INFO - Running setup.py (path:/tmp/pip-Z4uruB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:16 INFO - Running setup.py (path:/tmp/pip-sN3Q7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:16 INFO - Running setup.py (path:/tmp/pip-Bvp_cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:16 INFO - Running setup.py (path:/tmp/pip-MOgRKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:16 INFO - Running setup.py (path:/tmp/pip-fx8uvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:16 INFO - Running setup.py (path:/tmp/pip-oPyhnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:16 INFO - Running setup.py (path:/tmp/pip-aTabt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:17 INFO - Running setup.py (path:/tmp/pip-sRVMnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:17 INFO - Running setup.py (path:/tmp/pip-cBUd_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:17 INFO - Running setup.py (path:/tmp/pip-awa5Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:17 INFO - Running setup.py install for manifestparser 16:13:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Running setup.py install for mozcrash 16:13:17 INFO - Running setup.py install for mozdebug 16:13:17 INFO - Running setup.py install for mozdevice 16:13:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Running setup.py install for mozfile 16:13:17 INFO - Running setup.py install for mozhttpd 16:13:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Running setup.py install for mozinfo 16:13:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Running setup.py install for mozInstall 16:13:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Running setup.py install for mozleak 16:13:18 INFO - Running setup.py install for mozlog 16:13:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Running setup.py install for moznetwork 16:13:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Running setup.py install for mozprocess 16:13:18 INFO - Running setup.py install for mozprofile 16:13:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Running setup.py install for mozrunner 16:13:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Running setup.py install for mozscreenshot 16:13:18 INFO - Running setup.py install for moztest 16:13:18 INFO - Running setup.py install for mozversion 16:13:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:18 INFO - Cleaning up... 16:13:19 INFO - Return code: 0 16:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:19 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:19 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:13:19 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:13:19 INFO - Using env: {'DISPLAY': ':0', 16:13:19 INFO - 'HOME': '/home/cltbld', 16:13:19 INFO - 'LANG': 'en_US.UTF-8', 16:13:19 INFO - 'LANGUAGE': 'en_US:en', 16:13:19 INFO - 'LOGNAME': 'cltbld', 16:13:19 INFO - 'MAIL': '/var/mail/cltbld', 16:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:19 INFO - 'MOZ_NO_REMOTE': '1', 16:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:19 INFO - 'NO_EM_RESTART': '1', 16:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:19 INFO - 'PWD': '/builds/slave/test', 16:13:19 INFO - 'SHELL': '/bin/bash', 16:13:19 INFO - 'SHLVL': '1', 16:13:19 INFO - 'TERM': 'linux', 16:13:19 INFO - 'TMOUT': '86400', 16:13:19 INFO - 'USER': 'cltbld', 16:13:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:19 INFO - '_': '/tools/buildbot/bin/python'} 16:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:19 INFO - Running setup.py (path:/tmp/pip-5D8SuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:19 INFO - Running setup.py (path:/tmp/pip-g5Rf7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:19 INFO - Running setup.py (path:/tmp/pip-ghNd9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:19 INFO - Running setup.py (path:/tmp/pip-tD1akK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:19 INFO - Running setup.py (path:/tmp/pip-OOkUue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:19 INFO - Running setup.py (path:/tmp/pip-lxrAi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:19 INFO - Running setup.py (path:/tmp/pip-1x6yYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:19 INFO - Running setup.py (path:/tmp/pip-J_QLnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:19 INFO - Running setup.py (path:/tmp/pip-_OrnRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:19 INFO - Running setup.py (path:/tmp/pip-3jrv9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:19 INFO - Running setup.py (path:/tmp/pip-hLHlN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:20 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:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:20 INFO - Running setup.py (path:/tmp/pip-Su0m1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:20 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:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:20 INFO - Running setup.py (path:/tmp/pip-_AWf8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:20 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:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:20 INFO - Running setup.py (path:/tmp/pip-4U7PAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:20 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:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:20 INFO - Running setup.py (path:/tmp/pip-3J6wrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:20 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:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:20 INFO - Running setup.py (path:/tmp/pip-3tGeiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:20 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:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:20 INFO - Running setup.py (path:/tmp/pip-H9rMr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:20 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:13:20 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:13:20 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:13:20 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:13:20 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:13:20 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:13:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:22 INFO - Downloading blessings-1.6.tar.gz 16:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:22 INFO - Installing collected packages: blessings 16:13:22 INFO - Running setup.py install for blessings 16:13:22 INFO - Successfully installed blessings 16:13:22 INFO - Cleaning up... 16:13:22 INFO - Return code: 0 16:13:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:22 INFO - Reading from file tmpfile_stdout 16:13:22 INFO - Current package versions: 16:13:22 INFO - argparse == 1.2.1 16:13:22 INFO - blessings == 1.6 16:13:22 INFO - blobuploader == 1.2.4 16:13:22 INFO - docopt == 0.6.1 16:13:22 INFO - functools32 == 3.2.3-2 16:13:22 INFO - jsonschema == 2.5.1 16:13:22 INFO - manifestparser == 1.1 16:13:22 INFO - mozInstall == 1.12 16:13:22 INFO - mozcrash == 0.17 16:13:22 INFO - mozdebug == 0.1 16:13:22 INFO - mozdevice == 0.48 16:13:22 INFO - mozfile == 1.2 16:13:22 INFO - mozhttpd == 0.7 16:13:22 INFO - mozinfo == 0.9 16:13:22 INFO - mozleak == 0.1 16:13:22 INFO - mozlog == 3.3 16:13:22 INFO - moznetwork == 0.27 16:13:22 INFO - mozprocess == 0.23 16:13:22 INFO - mozprofile == 0.28 16:13:22 INFO - mozrunner == 6.12 16:13:22 INFO - mozscreenshot == 0.1 16:13:22 INFO - mozsystemmonitor == 0.3 16:13:22 INFO - moztest == 0.7 16:13:22 INFO - mozversion == 1.4 16:13:22 INFO - psutil == 3.1.1 16:13:22 INFO - requests == 1.2.3 16:13:22 INFO - wsgiref == 0.1.2 16:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:22 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:22 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:13:22 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:13:22 INFO - Using env: {'DISPLAY': ':0', 16:13:22 INFO - 'HOME': '/home/cltbld', 16:13:22 INFO - 'LANG': 'en_US.UTF-8', 16:13:22 INFO - 'LANGUAGE': 'en_US:en', 16:13:22 INFO - 'LOGNAME': 'cltbld', 16:13:22 INFO - 'MAIL': '/var/mail/cltbld', 16:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:22 INFO - 'MOZ_NO_REMOTE': '1', 16:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:22 INFO - 'NO_EM_RESTART': '1', 16:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:22 INFO - 'PWD': '/builds/slave/test', 16:13:22 INFO - 'SHELL': '/bin/bash', 16:13:22 INFO - 'SHLVL': '1', 16:13:22 INFO - 'TERM': 'linux', 16:13:22 INFO - 'TMOUT': '86400', 16:13:22 INFO - 'USER': 'cltbld', 16:13:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:22 INFO - '_': '/tools/buildbot/bin/python'} 16:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 INFO - Cleaning up... 16:13:23 INFO - Return code: 0 16:13:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:23 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 0xfa5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, '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': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', '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:13:23 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:13:23 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:13:23 INFO - Using env: {'DISPLAY': ':0', 16:13:23 INFO - 'HOME': '/home/cltbld', 16:13:23 INFO - 'LANG': 'en_US.UTF-8', 16:13:23 INFO - 'LANGUAGE': 'en_US:en', 16:13:23 INFO - 'LOGNAME': 'cltbld', 16:13:23 INFO - 'MAIL': '/var/mail/cltbld', 16:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:23 INFO - 'MOZ_NO_REMOTE': '1', 16:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:23 INFO - 'NO_EM_RESTART': '1', 16:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:23 INFO - 'PWD': '/builds/slave/test', 16:13:23 INFO - 'SHELL': '/bin/bash', 16:13:23 INFO - 'SHLVL': '1', 16:13:23 INFO - 'TERM': 'linux', 16:13:23 INFO - 'TMOUT': '86400', 16:13:23 INFO - 'USER': 'cltbld', 16:13:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:23 INFO - '_': '/tools/buildbot/bin/python'} 16:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:23 INFO - Cleaning up... 16:13:23 INFO - Return code: 0 16:13:23 INFO - Running post-action listener: _resource_record_post_action 16:13:23 INFO - Running post-action listener: _start_resource_monitoring 16:13:23 INFO - Starting resource monitoring. 16:13:23 INFO - [mozharness: 2016-07-28 23:13:23.292957Z] Finished create-virtualenv step (success) 16:13:23 INFO - [mozharness: 2016-07-28 23:13:23.293388Z] Running install step. 16:13:23 INFO - Running pre-action listener: _resource_record_pre_action 16:13:23 INFO - Running main action method: install 16:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:23 INFO - Reading from file tmpfile_stdout 16:13:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:23 INFO - Reading from file tmpfile_stdout 16:13:23 INFO - Output received: 16:13:23 INFO - Usage: mozinstall [options] installer 16:13:23 INFO - Options: 16:13:23 INFO - -h, --help show this help message and exit 16:13:23 INFO - -d DEST, --destination=DEST 16:13:23 INFO - Directory to install application into. [default: 16:13:23 INFO - "/builds/slave/test"] 16:13:23 INFO - --app=APP Application being installed. [default: firefox] 16:13:23 INFO - mkdir: /builds/slave/test/build/application 16:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:13:40 INFO - Reading from file tmpfile_stdout 16:13:40 INFO - Output received: 16:13:40 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:40 INFO - Running post-action listener: _resource_record_post_action 16:13:40 INFO - [mozharness: 2016-07-28 23:13:40.161650Z] Finished install step (success) 16:13:40 INFO - [mozharness: 2016-07-28 23:13:40.161928Z] Running run-tests step. 16:13:40 INFO - Running pre-action listener: _resource_record_pre_action 16:13:40 INFO - Running main action method: run_tests 16:13:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:40 INFO - Python 2.7.3 16:13:40 INFO - Return code: 0 16:13:40 INFO - grabbing minidump binary from tooltool 16:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:40 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 0x1263570>, '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 0x1264470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:40 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:13:40 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:13:40 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:13:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:40 INFO - Return code: 0 16:13:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:40 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/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:13:40 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/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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:13:40 INFO - Using env: {'DISPLAY': ':0', 16:13:40 INFO - 'HOME': '/home/cltbld', 16:13:40 INFO - 'LANG': 'en_US.UTF-8', 16:13:40 INFO - 'LANGUAGE': 'en_US:en', 16:13:40 INFO - 'LOGNAME': 'cltbld', 16:13:40 INFO - 'MAIL': '/var/mail/cltbld', 16:13:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:40 INFO - 'MOZ_NO_REMOTE': '1', 16:13:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:40 INFO - 'NO_EM_RESTART': '1', 16:13:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:40 INFO - 'PWD': '/builds/slave/test', 16:13:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:40 INFO - 'SHELL': '/bin/bash', 16:13:40 INFO - 'SHLVL': '1', 16:13:40 INFO - 'TERM': 'linux', 16:13:40 INFO - 'TMOUT': '86400', 16:13:40 INFO - 'USER': 'cltbld', 16:13:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469747320.576093-473822977', 16:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:40 INFO - '_': '/tools/buildbot/bin/python'} 16:13:40 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/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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:13:40 INFO - mozversion application_buildid: 20160728155146 16:13:40 INFO - mozversion application_changeset: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b 16:13:40 INFO - mozversion application_display_name: Nightly 16:13:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:40 INFO - mozversion application_name: Firefox 16:13:40 INFO - mozversion application_remotingname: firefox 16:13:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:13:40 INFO - mozversion application_vendor: Mozilla 16:13:40 INFO - mozversion application_version: 50.0a1 16:13:40 INFO - mozversion platform_buildid: 20160728155146 16:13:40 INFO - mozversion platform_changeset: 06e51ce8f72f94112afcbb9a5a90364a8d811a4b 16:13:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:13:40 INFO - mozversion platform_version: 50.0a1 16:13:40 INFO - using testdate: 1469747620 16:13:40 INFO - actual date: 1469747620 16:13:40 INFO - starting webserver on 'localhost:60859' 16:13:40 INFO - SUITE-START | Running 2 tests 16:13:40 INFO - TEST-START | dromaeo_css 16:13:40 INFO - operating with platform_type : linux_ 16:13:40 INFO - Initialising browser for dromaeo_css test... 16:13:40 INFO - TEST-INFO | started process 14880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9X8vWe/profile http://localhost:60859/getInfo.html) 16:13:44 INFO - PROCESS | 14880 | JavaScript error: , line 0: uncaught exception: undefined 16:13:45 INFO - PROCESS | 14880 | __metrics Screen width/height:1600/1200 16:13:45 INFO - PROCESS | 14880 | colorDepth:24 16:13:45 INFO - PROCESS | 14880 | Browser inner width/height: 1024/697 16:13:45 INFO - PROCESS | 14880 | __metrics 16:13:46 ERROR - PROCESS | 14880 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:13:47 INFO - TEST-INFO | 14880: exit 0 16:13:47 INFO - Browser initialized. 16:13:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:47 INFO - TEST-INFO | started process 14996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9X8vWe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:59 INFO - PROCESS | 14996 | RSS: Main: 165638144 16:13:59 INFO - PROCESS | 14996 | 16:14:48 INFO - PROCESS | 14996 | 1469747688731 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] 16:17:00 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:60859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60859/tests/dromaeo/cssquery-ext.html) 16:17:01 INFO - PROCESS | 14996 | RSS: Main: 168071168 16:17:01 INFO - PROCESS | 14996 | 16:20:04 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:60859/tests/dromaeo/cssquery-ext.html (next: http://localhost:60859/tests/dromaeo/cssquery-jquery.html) 16:20:04 INFO - PROCESS | 14996 | RSS: Main: 168091648 16:20:04 INFO - PROCESS | 14996 | 16:23:06 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:60859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60859/tests/dromaeo/cssquery-mootools.html) 16:23:07 INFO - PROCESS | 14996 | RSS: Main: 171220992 16:23:07 INFO - PROCESS | 14996 | 16:26:09 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:60859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60859/tests/dromaeo/cssquery-prototype.html) 16:26:10 INFO - PROCESS | 14996 | RSS: Main: 165384192 16:26:10 INFO - PROCESS | 14996 | 16:29:12 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:60859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60859/tests/dromaeo/cssquery-yui.html) 16:29:13 INFO - PROCESS | 14996 | RSS: Main: 167534592 16:29:13 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:60859/tests/dromaeo/cssquery-yui.html (next: http://localhost:60859/tests/dromaeo/cssquery-dojo.html) 16:32:16 INFO - PROCESS | 14996 | RSS: Main: 170844160 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | __start_tp_report 16:32:16 INFO - PROCESS | 14996 | _x_x_mozilla_page_load 16:32:16 INFO - PROCESS | 14996 | _x_x_mozilla_page_load_details 16:32:16 INFO - PROCESS | 14996 | |i|pagename|runs| 16:32:16 INFO - PROCESS | 14996 | |0;dojo.html;2508.260063281334;2600.6879174499063;2617.2148355493346;2633.2495238856923;2663.8135330526866;4435.112977404524;4699.2951057341415;4809.062232864593;4835.661503694742;4841.104395686796;4709.64677649176;4710.481846996836;4712.882177945553;4751.928721069178;4809.230523116302;4321.070969741497;4373.081652852905;4440.644748420134;4462.419885414892;4511.436070491189;4411.955880441186;4472.597466228039;4485.753283569403;4512.9097418051615;4534.569215924498;4221.936670949938;4315.5900189481945;4383.715058521186;4384.013596940663;4417.690761646702;4325.978370108161;4333.4366532350905;4335.674824388184;4429.202743506167;4459.152760975404;4359.869203923888;4361.934570981438;4382.8904277393;4386.298192289219;4397.032652816375;4687.95312046882;4717.834875779331;4734.124187025412;4768.976155119237;4808.038392321515;5112.821051263225;5124.128898087297;5124.128898087334;5143.974280128576;5213.296205012312;5186.299849520305;5200.76596553156;5202.4277329493725;5208.192730126836;5208.6093542984045;4599.701019433726;4793.13723529768;4809.182438985381;4839.903201936012;4885.389326334208;5313.043652142652;5318.521333080042;5321.095413779667;5322.308099946982;5331.360236771612;5085.7711402986215;5085.9745701271995;5095.337606111256;5098.490150984871;5127.743612819344;4956.975215123901;4958.281049247839;5075.289459475676;5094.719790411489;5109.693418394908;5045.621578381636;5071.822486213038;5080.7205603692155;5081.390233171969;5123.641345105807;5042.571381432546;5108.029474399927;5117.283580298761;5119.6416250862085;5164.638475306692;4214.262504061777;4298.763568003727;4328.307470804656;4359.411479450297;4362;3751.2122454284904;3805.847766089381;3813.828377723009;3819.980900095482;3820.9426858597144;4375.518692943773;4394.912101757947;4422.358757980075;4425.601695847389;4461.754603496839;4984.277279794482;5032.874178145576;5148.279240906276;5169.81905633301;5210.97394513025;4317.222899878052;4325.4593175853015;4338.609525142752;4367.432233809648;4384.758838263926;4554.453465584085;4567.771611419482;4569.794359253775;4596.218642830727;4608.861734147981;4699.130660827758;4786.8085276589245;4798.0164066366315;4800.039992001543;4834.685745426536;5150.0472412603785;5163.328767260232;5202.193659982709;5232.136697445031;5240.5807535397835;4888.853334399973;4904.435989861212;4904.730239836843;4905.5094490550655;4926.3842019747535;4845.781939812647;4994;5087.821926232564;5105.846824595268;5124.077666020003;5074.974625126851;5097.464766199496;5113.284140220447;5134.895997360585;5182.792688292577;4965.900681986413;4979.751012449436;4981.551660350586;4987.600991920565;5028.522290382408;4811.831585894477;4866.221404575251;4965.751712414437;4989.276554899592;5042.890564075898;4813.927791083207;4835.95164048355;4838.346823178826;4891.706497610155;4909.754512274443;4928.556429921325;4950.9257361140335;4958.404991401055;4986.526280003394;5018.949810501995;4747.026859493864;4857.392825896763;4860.243210537694;4873.610111191168;4914.36113305268 16:32:16 INFO - PROCESS | 14996 | |1;ext.html;570.1248583424442;574.5575906551956;583.8948989181948;587.4008511318456;592.4460629311591;33300.16749581262;37989.24021519568;38110.809445952735;38115.61884381156;38135.237295254075;36315.81842090786;36327.27345453089;36759;36864.26271474569;36897;7615.6192190390675;7788.454808163431;7793.103793063785;7802.921970780277;7816.452848300622;7690.731029380146;7698.461107722462;7741.8838717419;7786.1435242123325;7822;7810;7824.5696486693205;7825.608719563999;7864.134945156028;7914.881276780853;7731.613419329011;7779.144294127642;7796.688132474751;7813.570253636048;7820.882686759646;7714.228577142241;7738.690452381898;7742.993410856552;7750.069991600988;7756.6509507072315;36720.63279367199;36980.260394792225;37172.81413592942;37214.25571488555;37291;2549.987250063738;2977.285451491626;3000.8649610767566;3067.2791893904914;3078.4920488119433;27084.729152708416;27470.72529274722;27596.310092247655;28051;28455.430891382264;3227.951580726291;3282.3107147499054;3290.720288775457;3292.1275861896615;3317.369699757063;229359.4128117445;229790;229986;230475;231442;31702.682973169973;31870.68129318677;32007;32094.679053209635;32183.67816321807;32900.34199316;33184.668153318155;33877.32245355079;35259.82370088133;35340;14874.181919994504;14997.850021499864;15041.473548425753;15047.322870470636;15048.473303434546;10610.522526486327;10614.787704245871;10620.946895265473;10635.893641063645;10636;17969.910150449425;18048.548786280448;18066.728999065024;18087.638247235245;18108.00405977684;6657.900131498031;6691.1636045494315;6710.530262881649;6820.35206655367;7035.226125126232;807.7536351412758;922.8246633139682;964.8552717092352;976.6581696406201;977.0571398600242;28327.433451330857;28639.57040644392;28816.423671526452;28844.855775721408;29172.416551668848;970.6505657963128;1026.712520494263;1040.2770074797943;1040.3913710479455;1041.3907863899703;14400.783988240184;15324.310406031533;15536.288978755258;15546.611334716723;15645.843541564438;398123;398788;400466;401094;403395;48604.27093593599;49059.26411103836;49237.753811230716;49334.75332623314;49449.75275123601;1142.3374442823142;1166.935818529972;1189.8096304591397;1197.3653963399413;1198.4547031100828;26771.33071673224;27979.860100699367;28452.288692782848;28787.28031799222;29013.56479652849;42193.578064218964;42395.7880210597;42530.5746942539;42651.3602295972;42760.78619606882;267425;268211;268661;268887;273466;25128;25328.873355633103;25382.873085634452;25964.610530841674;26101.347466313495;41296.1740765189;41529.169416610894;42193.36709949292;42275;42873.14253714971;35680.464793027604;35825.82567643458;36523.269534608626;37103.81448092742;37516.43725344067;36033.27933441264;36626;36638.81680591687;36660.633393665725;36676.0830979217;35352.823235883654;35668.46497302491;36161.63838361688;36263.63736362708;36406;30846;33312.1671958203;33342.16644583905;33515.16212094717;33671.663283366855;25290.36774080663;25413.87293063523;25744.227673169837;25894.35264118412;25980.740192598587 16:32:16 INFO - PROCESS | 14996 | |2;jquery.html;339.15719437198555;354.37983528824554;358.74170597170036;362.6899001353844;383.8196047857506;16058.357665693373;16809;17644.382446614356;17892.105394730275;17939.91030044848;16615.584610384718;16763.497095087136;17360.305587776504;17492.912535437306;17600.64798704025;4930.556249937505;5159.071367153911;5160;5163.81926632568;5166.560842328407;3734.8319325630277;5146.202338637517;5701.458361455655;5952.047672372421;5967.522598192156;6015.458608725214;6048.183495228154;6049.546284028694;6051.727672254737;6051.969740151293;5957.612755170921;5964.284285885678;6028;6035.245594300713;6037.969810150965;5110;5215.504527069922;5222.4255331913455;5225.190095535198;5273.815416460444;18665;19464.513387165294;20934.895325523426;21167.788322116736;21194.894025529775;1775.9200835962413;1820.6722789897813;1998.2007197121122;2036.5417780999305;2415.973211385172;9313.161815436642;9357.39176953496;9394.718158455258;9404.106609872051;9437.386569873004;1727.853132483728;1771.406578796105;1780.830821071996;1787.4101546489628;1804.4586624012743;65357.673211634115;65506.3449365505;66445;66511.33488665099;68616;9690.56392462341;9777.168940639984;9785.434330507085;9873.80252394948;9949.950250248703;13326.466941322238;13327;13334.066615337028;13377.264250466123;13391.598252052454;7086.114235720535;7087.362137407555;7155.92844071563;7215.927840721631;7329.267073292628;6727.529072964846;6836.418904393083;6861.2795656455355;6919.8962015569805;6940.618265995317;4121.464209652726;4271.295236286041;4290.528041915387;4349.934750978738;4374.803133858984;1465.377214683755;1551.2941611566935;1556.3930067273773;1792.4891405949502;1868.8037756035692;789.9210078992055;792.6433105102611;818.7216346442119;854.9957250213834;918.7106061590712;16689.415870444474;17543.561410964827;18313.3590324338;18817.435476935712;18999.715004274945;830.8421399933993;837.2883049407955;842.9578521073922;848.3298194426458;858.1461445861283;9284;10045;10077.344972576759;10113.898861011296;10284.023017813295;415177.7098946563;417066;419645;423927;427105;79719;80159;81849.18150818415;82020;87901;884.5444596032919;908.9136532029447;943.0899182289124;947.7062110745691;949.7530642033121;16011.279492422636;16187.352505899633;16367.91816040912;16694.833051669328;16866.24101915441;38069.80965095267;39248.80375598104;39381.80309098551;39447.408288875115;40967.795161024005;54905;54995.17507237475;56016.15975760285;56211;57407.42592574021;7734.419918506247;7868.84262314739;7921.524708517507;7971.960140199262;8061;9900.603975841173;11815.704607384883;12046.216995895238;12110;12169.148159628741;10623.36259824413;10788.136949044214;10821.729456763644;11006.724831879266;11063.889361106609;10559.208059395422;10700.571977121139;10794.244402891722;10912.508937098008;11047.502862371051;10118.696439106838;10333.173346132442;10619.1504679627;10637.361758294526;10871.130309575374;7551.811204719926;7622.656980436004;7635.618219089134;7641.121271053677;7709.151993280622;9187.770305742142;9637.614495420105;10069.748256293651;10178.541965611714;10504.159667226451 16:32:16 INFO - PROCESS | 14996 | |3;mootools.html;1379.951701690441;1416.4546649539927;1491.1425930090202;1633.199732131256;1682.3943380383068;6725.865482690343;7241;7399.963000184992;7742.845143097142;7755.650995705193;7522.285382888631;7817.648205830737;7823.765287041384;7830.216978302167;7831.647575859086;2143.2605751015913;2179.487820362214;2185.3007037747925;2185.562887422514;2186.223890518867;2111.461577297787;2118.3962570667363;2201.0645475672854;2202.746684131321;2204.0853045985896;2206.249875042485;2209.558088382322;2210.8452408331423;2214.9557008859815;2240.9887950560305;2110.9788902110936;2130.3928380411508;2132.616129096762;2140.785921407862;2148.688440176166;2091.2262462888675;2116.7248257726396;2126.6384714598557;2134.1356750516065;2144.571085782834;7755.844883102306;7757.5733334666575;7781.844363112763;7792.18182090878;7824.765257042298;4548.113117942003;4626.352310676508;4668.4631267404;4682.672212945095;4687.250039993584;2836.163331817119;2884.682684904659;2909.0690978886764;2951.7048295170525;2975.6280464941883;840.5209030852417;840.8276303357858;893.8391089603869;900.2527901841456;907.3648446087765;10420.947895260551;10460.37237765729;10506.106980906632;10518.421486818223;10530.631427899987;4010.418489319091;4170.854020109282;4309.633681137138;4316.568343165658;4317.762523061262;9131.406458580172;9143.54282285883;9152.908470915205;9154.26765858743;9175.587098580447;4665.766711664403;4689.249720044776;4726.172919739032;4731.692439991459;4732.266498692708;3640.3629364861044;4027.1744292419985;4139.689523285766;4322.783860806947;4338.392625032498;3630.056185391817;3697.574778900461;3716.349638813197;3757.0231739747314;3900.7659540427667;1208.6736581123048;1212.3512023647831;1229.5327775445453;1236.7402845402387;1237.300924977385;782.9608519574113;792.0732742691065;863.2964134230707;864.7189663359434;874.9956250218836;5171.621054314982;5225.843224703265;5345.091334473149;5406.216098665672;5420.810271640553;392.7427534964603;396.6806720589953;400.9278329900646;401.4319737571304;403.1815414708147;3721.813909304578;3863.7295389322476;3901.180752042103;3901.804909754501;3984.42225877252;9077.591508382138;9615.182709469773;9619.086186812241;9630.518474076269;9636;8974.730758077269;9216.861747073799;9359.953200234091;9565.713028609152;9594.42433453981;7071.080759501232;7230.783076507713;7277.2358902315555;7286.599237042014;7290.380317672951;5206.687598744087;5371.248025276386;5396.9730151348995;5397.433269506645;5510.752016159202;8470.745877623682;8622.180892815173;8709.433886797338;8852.690155844515;8891.688790892287;8843.46939183651;8912.73261802147;9049.77375565616;9102.635894564144;9117.817643647222;6105.786297479567;6413.326600707045;6561.278259391368;6734.057231987624;6929.480288978246;7601.353884919844;7601.885971710318;7654.196309387434;7667.539947603162;7669.69321227167;6762.4928130389435;6806.659667016728;6857.7256909723055;6876.553024053421;7023.543469674455;6664.400203981471;6686.598804071771;6730;6737.3599508046655;6951.8609627806145;5876.206712093813;6055.515558755201;6066.120412540069;6093.725782339894;6118.051701986199;4395.7582332972;4471.396361491157;4482.148391805546;4522.186006518858;4565.201089809204;4423.513413524574;4450.618918878385;4487.259602165736;4561.771911404483;4691.202495575692 16:32:16 INFO - PROCESS | 14996 | |4;prototype.html;289.1412504860563;292.6561290483681;301.28895805898077;301.98037127586707;306.75153125967955;4877.658563900528;4980;5062.734316420895;5065.316182315386;5079.822206222783;4988.276699878525;4990.326305948696;5011.248312753089;5015.22264049073;5015.272785446108;3945.1320709443876;3957.881263562098;3960.9899475633674;3973.9006524836964;3986.222686576119;3897.922041559167;3953.229120321524;3984.2828290907623;3988.0229343810806;3997.8400863965408;3930.233604447134;3946.5264168299846;3956.4263181838614;3968.2063587282514;3975.026118600947;3952.288588054149;3957.485526881516;3964.980175099135;3965.940510892339;3983.6215559521797;3502.579690437138;3511.1397707561555;3517.7009954153928;3519.296140771856;3533.593636731783;4711.3639658646325;4927.753612319406;4939.777710003059;4999.8250061248045;5032.345795046621;4422.712523685982;4437.866863994085;4459.175052615276;4461.955380446219;4471.932921006188;5319.255304257407;5321.866953326159;5342.626016178869;5356.143017117242;5372.597055220874;3633.636636336372;3704.1665625234377;3719.6652301292743;3732.664060234592;3750.79370634615;5532.197831314437;5533.6956467394275;5539.612227144102;5541.889162216773;5556.027695153332;3721.218544105714;3740.0836794985403;3752;3757.962420375816;3771.7171212159196;3711.350513660099;3796.6393192646656;3802.239552089538;3813.5995720448955;3821.063839359375;4291.570842915684;4341;4356.978215108904;4360.324149756792;4427.535108813592;5306.8407947761625;5315.415304316522;5320.255164277004;5320.733963301819;5340.946590534123;1270.84749830021;1292.9741405172033;1311.8622544632676;1324.265032906746;1331.407523651985;864.3387808326635;890.0921060518235;911.8586619074055;914.2092090341939;917.2432742987062;4526.985491456337;4580.450345958507;4590.908181836345;4605.585497305258;4614.653900957442;5430;5443.618946673774;5463.235147079412;5474.343078830486;5482.753276102585;4478.41780568524;4606.792694328763;4620.3762492063815;4643;4645.559876438315;2550.7321731218326;2552.3108760634896;2558.411565339982;2563.6410902473667;2583.276682528895;4515.683902126885;4522.570355816192;4530.29780384041;4548.339855952553;4553.704009239389;4700.506446823103;4776.044791041805;4826.576160032799;4830.130576496264;4868.464468908417;4574.313852922089;4579.656525760582;4589;4594.632429405573;4615.815367385267;4779.498152694056;4795.760211989456;4802.255650374198;4810.687305325143;4815.662903596714;4493.820247190076;4662.790174442091;4675.462321832897;4741.454732705783;4743.644226682944;4542.818287268605;4543.363929050001;4560.954390456053;4581.5647513486165;4602.033572949718;3480.7817263958427;3505;3508.561429821272;3526.977176618752;3537.4788840797673;4864.27035944597;4890.902181956412;4891.1685013548495;4897.338859254098;5217.556507696889;5120.846374608767;5276.9472305278;5294.470552944675;5299.41706412302;5300.17847233664;5286.259923610774;5297.417284098669;5317.57459403239;5318.441563635917;5350.732463376893;5129.563987060992;5210.687358758487;5215.817446389358;5227.947720522746;5263.894582137641;5325.946740532545;5326.920096198638;5337.893242135213;5353.491418315254;5368.939704368472;5218.817341393033;5248.343957005374;5253.395859476056;5261.973690131525;5271.077561426811 16:32:16 INFO - PROCESS | 14996 | |5;yui.html;625.3683779382824;662.2648859765659;715.6171448275173;732.7105793211681;749.4079677055125;12556.309402982832;13107.148035377693;13215.735685286289;13220.867791322084;13239.338033098342;12563.434645440955;12696.4921403144;12720.936395318033;12721.363931803397;12731.61805145847;618.6288227063749;761.3072104385011;767.263427109975;780.5433821214597;789.0688986995343;785.7132146766418;786.4455558831039;787.5235482533071;788.5229436191108;789.2383849585149;829.8091438969041;838.4256784102909;841.9579021048954;843.5065486690294;844.5945945945949;826.5412695953743;829.4691397505601;831.8669012957928;832.0847068224965;834.0325222741621;606.2270604978644;607.8571535689109;609.402785270433;612.4182027074297;612.6660969771485;12441.253524788543;12465.127441079128;12488.375581220902;12507.874921250763;12509.186902851285;13082.411291491906;13239.801402978963;13335.133216340906;13503.324833758274;13647.727045459034;10346.482675866251;10396.896031039669;10412;10511.369317840878;10557.049865512065;3288.786228895114;3307.4542700454394;3320.93358132836;3334.1664583854035;3360.680735330164;60490.39509604892;60801.08798368028;61406.0789088164;61536.69231653858;61610.69194654043;10257.794844103077;10277.94861025705;10343.586256549654;10426.791464170674;10623.628173013907;17919.37282195117;18024.459266222035;18106.63786724258;18171.818281817013;18866.905665471586;6176.166217560662;6223.159873417121;6463.15978922737;6569.770058047945;6670.39966403026;3652.415613501827;3742.326381251401;3775.0751065989007;3781.4516895050065;3817.7136714746507;2762.8204166729097;2864.484392809314;2867.3978464522265;2878.280429892527;2882.6396700412447;492.5862275688367;496.1763472635408;498.62353922788066;503.1120073071033;515.5463192390747;566.9971650141805;612.2989177391861;619.3001907844107;632.2002666626721;633.7243299164878;7837.3338266246865;8023.558704271204;8275.255227029596;8425.747227583182;8428.448637735553;455.59679683480357;532.2016974538193;578.2396149063967;616.211249600512;617.1267656266423;3980.920381592352;4097.508299004138;4212.452381190487;4240.300350442204;4360.542143074995;92039;95003.52498237602;97181.51409242909;100190;100597.49701251448;82661.90719020902;84484.57757711296;84940.57529712311;85485;86676.13323866807;43293.78353108277;48419.75790121097;75207;78513.21486785059;79704;7828.647710852912;8049.154838741848;8123.75628731139;8162.755117346489;8196.197156360087;43351;43529.78235108804;43624.345634816134;43798.34302485529;46034.76982615065;34795.82602086973;35050.82474587713;60546.18361449164;62810.37189628045;63488.36511634824;10207.183425325808;10300.381977081399;10343.482825858828;11354.943225283821;11686.766264674829;12482.875171248172;12626.684332891751;13577.253251071286;13620.250886201355;14101;11775.411229438323;12064.577739779066;12213.511459541518;12301.200421972542;12439.315837629018;11628.709282268012;12071.336076515525;12377.876221237673;12449.688757781129;12450.319206907314;11067.83398249043;11606.419679015846;11626.418679066182;12234.571789987307;12259;9997.250206234707;10241.539130738985;10498;10674.412907290174;10801.729956751144;8931.598078086372;9361.485118318285;10252.128569071414;10410.219233557666;10450.634227801991 16:32:16 INFO - PROCESS | 14996 | __end_tp_report 16:32:16 INFO - PROCESS | 14996 | __start_cc_report 16:32:16 INFO - PROCESS | 14996 | _x_x_mozilla_cycle_collect,365 16:32:16 INFO - PROCESS | 14996 | __end_cc_report 16:32:16 INFO - PROCESS | 14996 | __startTimestamp1469748736522__endTimestamp 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | ------- Summary: start ------- 16:32:16 INFO - PROCESS | 14996 | Number of tests: 6 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | [#0] dojo.html Cycles:165 Average:4721.28 Median:4839.90 stddev:510.74 (10.6%) stddev-sans-first:481.90 16:32:16 INFO - PROCESS | 14996 | Values: 2508.3 2600.7 2617.2 2633.2 2663.8 4435.1 4699.3 4809.1 4835.7 4841.1 4709.6 4710.5 4712.9 4751.9 4809.2 4321.1 4373.1 4440.6 4462.4 4511.4 4412.0 4472.6 4485.8 4512.9 4534.6 4221.9 4315.6 4383.7 4384.0 4417.7 4326.0 4333.4 4335.7 4429.2 4459.2 4359.9 4361.9 4382.9 4386.3 4397.0 4688.0 4717.8 4734.1 4769.0 4808.0 5112.8 5124.1 5124.1 5144.0 5213.3 5186.3 5200.8 5202.4 5208.2 5208.6 4599.7 4793.1 4809.2 4839.9 4885.4 5313.0 5318.5 5321.1 5322.3 5331.4 5085.8 5086.0 5095.3 5098.5 5127.7 4957.0 4958.3 5075.3 5094.7 5109.7 5045.6 5071.8 5080.7 5081.4 5123.6 5042.6 5108.0 5117.3 5119.6 5164.6 4214.3 4298.8 4328.3 4359.4 4362.0 3751.2 3805.8 3813.8 3820.0 3820.9 4375.5 4394.9 4422.4 4425.6 4461.8 4984.3 5032.9 5148.3 5169.8 5211.0 4317.2 4325.5 4338.6 4367.4 4384.8 4554.5 4567.8 4569.8 4596.2 4608.9 4699.1 4786.8 4798.0 4800.0 4834.7 5150.0 5163.3 5202.2 5232.1 5240.6 4888.9 4904.4 4904.7 4905.5 4926.4 4845.8 4994.0 5087.8 5105.8 5124.1 5075.0 5097.5 5113.3 5134.9 5182.8 4965.9 4979.8 4981.6 4987.6 5028.5 4811.8 4866.2 4965.8 4989.3 5042.9 4813.9 4836.0 4838.3 4891.7 4909.8 4928.6 4950.9 4958.4 4986.5 5018.9 4747.0 4857.4 4860.2 4873.6 4914.4 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | [#1] ext.html Cycles:180 Average:44527.54 Median:35510.64 stddev:81323.61 (229.0%) stddev-sans-first:81484.77 16:32:16 INFO - PROCESS | 14996 | Values: 570.1 574.6 583.9 587.4 592.4 33300.2 37989.2 38110.8 38115.6 38135.2 36315.8 36327.3 36759.0 36864.3 36897.0 7615.6 7788.5 7793.1 7802.9 7816.5 7690.7 7698.5 7741.9 7786.1 7822.0 7810.0 7824.6 7825.6 7864.1 7914.9 7731.6 7779.1 7796.7 7813.6 7820.9 7714.2 7738.7 7743.0 7750.1 7756.7 36720.6 36980.3 37172.8 37214.3 37291.0 2550.0 2977.3 3000.9 3067.3 3078.5 27084.7 27470.7 27596.3 28051.0 28455.4 3228.0 3282.3 3290.7 3292.1 3317.4 229359.4 229790.0 229986.0 230475.0 231442.0 31702.7 31870.7 32007.0 32094.7 32183.7 32900.3 33184.7 33877.3 35259.8 35340.0 14874.2 14997.9 15041.5 15047.3 15048.5 10610.5 10614.8 10620.9 10635.9 10636.0 17969.9 18048.5 18066.7 18087.6 18108.0 6657.9 6691.2 6710.5 6820.4 7035.2 807.8 922.8 964.9 976.7 977.1 28327.4 28639.6 28816.4 28844.9 29172.4 970.7 1026.7 1040.3 1040.4 1041.4 14400.8 15324.3 15536.3 15546.6 15645.8 398123.0 398788.0 400466.0 401094.0 403395.0 48604.3 49059.3 49237.8 49334.8 49449.8 1142.3 1166.9 1189.8 1197.4 1198.5 26771.3 27979.9 28452.3 28787.3 29013.6 42193.6 42395.8 42530.6 42651.4 42760.8 267425.0 268211.0 268661.0 268887.0 273466.0 25128.0 25328.9 25382.9 25964.6 26101.3 41296.2 41529.2 42193.4 42275.0 42873.1 35680.5 35825.8 36523.3 37103.8 37516.4 36033.3 36626.0 36638.8 36660.6 36676.1 35352.8 35668.5 36161.6 36263.6 36406.0 30846.0 33312.2 33342.2 33515.2 33671.7 25290.4 25413.9 25744.2 25894.4 25980.7 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | [#2] jquery.html Cycles:180 Average:25558.03 Median:4362.37 stddev:69381.59 (1590.5%) stddev-sans-first:69550.39 16:32:16 INFO - PROCESS | 14996 | Values: 339.2 354.4 358.7 362.7 383.8 16058.4 16809.0 17644.4 17892.1 17939.9 16615.6 16763.5 17360.3 17492.9 17600.6 4930.6 5159.1 5160.0 5163.8 5166.6 3734.8 5146.2 5701.5 5952.0 5967.5 6015.5 6048.2 6049.5 6051.7 6052.0 5957.6 5964.3 6028.0 6035.2 6038.0 5110.0 5215.5 5222.4 5225.2 5273.8 18665.0 19464.5 20934.9 21167.8 21194.9 1775.9 1820.7 1998.2 2036.5 2416.0 9313.2 9357.4 9394.7 9404.1 9437.4 1727.9 1771.4 1780.8 1787.4 1804.5 65357.7 65506.3 66445.0 66511.3 68616.0 9690.6 9777.2 9785.4 9873.8 9950.0 13326.5 13327.0 13334.1 13377.3 13391.6 7086.1 7087.4 7155.9 7215.9 7329.3 6727.5 6836.4 6861.3 6919.9 6940.6 4121.5 4271.3 4290.5 4349.9 4374.8 1465.4 1551.3 1556.4 1792.5 1868.8 789.9 792.6 818.7 855.0 918.7 16689.4 17543.6 18313.4 18817.4 18999.7 830.8 837.3 843.0 848.3 858.1 9284.0 10045.0 10077.3 10113.9 10284.0 415177.7 417066.0 419645.0 423927.0 427105.0 79719.0 80159.0 81849.2 82020.0 87901.0 884.5 908.9 943.1 947.7 949.8 16011.3 16187.4 16367.9 16694.8 16866.2 38069.8 39248.8 39381.8 39447.4 40967.8 54905.0 54995.2 56016.2 56211.0 57407.4 7734.4 7868.8 7921.5 7972.0 8061.0 9900.6 11815.7 12046.2 12110.0 12169.1 10623.4 10788.1 10821.7 11006.7 11063.9 10559.2 10700.6 10794.2 10912.5 11047.5 10118.7 10333.2 10619.2 10637.4 10871.1 7551.8 7622.7 7635.6 7641.1 7709.2 9187.8 9637.6 10069.7 10178.5 10504.2 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | [#3] mootools.html Cycles:180 Average:5105.05 Median:5189.15 stddev:2852.32 (55.0%) stddev-sans-first:2846.59 16:32:16 INFO - PROCESS | 14996 | Values: 1380.0 1416.5 1491.1 1633.2 1682.4 6725.9 7241.0 7400.0 7742.8 7755.7 7522.3 7817.6 7823.8 7830.2 7831.6 2143.3 2179.5 2185.3 2185.6 2186.2 2111.5 2118.4 2201.1 2202.7 2204.1 2206.2 2209.6 2210.8 2215.0 2241.0 2111.0 2130.4 2132.6 2140.8 2148.7 2091.2 2116.7 2126.6 2134.1 2144.6 7755.8 7757.6 7781.8 7792.2 7824.8 4548.1 4626.4 4668.5 4682.7 4687.3 2836.2 2884.7 2909.1 2951.7 2975.6 840.5 840.8 893.8 900.3 907.4 10420.9 10460.4 10506.1 10518.4 10530.6 4010.4 4170.9 4309.6 4316.6 4317.8 9131.4 9143.5 9152.9 9154.3 9175.6 4665.8 4689.2 4726.2 4731.7 4732.3 3640.4 4027.2 4139.7 4322.8 4338.4 3630.1 3697.6 3716.3 3757.0 3900.8 1208.7 1212.4 1229.5 1236.7 1237.3 783.0 792.1 863.3 864.7 875.0 5171.6 5225.8 5345.1 5406.2 5420.8 392.7 396.7 400.9 401.4 403.2 3721.8 3863.7 3901.2 3901.8 3984.4 9077.6 9615.2 9619.1 9630.5 9636.0 8974.7 9216.9 9360.0 9565.7 9594.4 7071.1 7230.8 7277.2 7286.6 7290.4 5206.7 5371.2 5397.0 5397.4 5510.8 8470.7 8622.2 8709.4 8852.7 8891.7 8843.5 8912.7 9049.8 9102.6 9117.8 6105.8 6413.3 6561.3 6734.1 6929.5 7601.4 7601.9 7654.2 7667.5 7669.7 6762.5 6806.7 6857.7 6876.6 7023.5 6664.4 6686.6 6730.0 6737.4 6951.9 5876.2 6055.5 6066.1 6093.7 6118.1 4395.8 4471.4 4482.1 4522.2 4565.2 4423.5 4450.6 4487.3 4561.8 4691.2 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | [#4] prototype.html Cycles:180 Average:4251.77 Median:4610.72 stddev:1237.07 (26.8%) stddev-sans-first:1204.26 16:32:16 INFO - PROCESS | 14996 | Values: 289.1 292.7 301.3 302.0 306.8 4877.7 4980.0 5062.7 5065.3 5079.8 4988.3 4990.3 5011.2 5015.2 5015.3 3945.1 3957.9 3961.0 3973.9 3986.2 3897.9 3953.2 3984.3 3988.0 3997.8 3930.2 3946.5 3956.4 3968.2 3975.0 3952.3 3957.5 3965.0 3965.9 3983.6 3502.6 3511.1 3517.7 3519.3 3533.6 4711.4 4927.8 4939.8 4999.8 5032.3 4422.7 4437.9 4459.2 4462.0 4471.9 5319.3 5321.9 5342.6 5356.1 5372.6 3633.6 3704.2 3719.7 3732.7 3750.8 5532.2 5533.7 5539.6 5541.9 5556.0 3721.2 3740.1 3752.0 3758.0 3771.7 3711.4 3796.6 3802.2 3813.6 3821.1 4291.6 4341.0 4357.0 4360.3 4427.5 5306.8 5315.4 5320.3 5320.7 5340.9 1270.8 1293.0 1311.9 1324.3 1331.4 864.3 890.1 911.9 914.2 917.2 4527.0 4580.5 4590.9 4605.6 4614.7 5430.0 5443.6 5463.2 5474.3 5482.8 4478.4 4606.8 4620.4 4643.0 4645.6 2550.7 2552.3 2558.4 2563.6 2583.3 4515.7 4522.6 4530.3 4548.3 4553.7 4700.5 4776.0 4826.6 4830.1 4868.5 4574.3 4579.7 4589.0 4594.6 4615.8 4779.5 4795.8 4802.3 4810.7 4815.7 4493.8 4662.8 4675.5 4741.5 4743.6 4542.8 4543.4 4561.0 4581.6 4602.0 3480.8 3505.0 3508.6 3527.0 3537.5 4864.3 4890.9 4891.2 4897.3 5217.6 5120.8 5276.9 5294.5 5299.4 5300.2 5286.3 5297.4 5317.6 5318.4 5350.7 5129.6 5210.7 5215.8 5227.9 5263.9 5325.9 5326.9 5337.9 5353.5 5368.9 5218.8 5248.3 5253.4 5262.0 5271.1 16:32:16 INFO - PROCESS | 14996 | 16:32:16 INFO - PROCESS | 14996 | [#5] yui.html Cycles:180 Average:17154.93 Median:43322.39 stddev:24440.99 (56.4%) stddev-sans-first:24478.04 16:32:16 INFO - PROCESS | 14996 | Values: 625.4 662.3 715.6 732.7 749.4 12556.3 13107.1 13215.7 13220.9 13239.3 12563.4 12696.5 12720.9 12721.4 12731.6 618.6 761.3 767.3 780.5 789.1 785.7 786.4 787.5 788.5 789.2 829.8 838.4 842.0 843.5 844.6 826.5 829.5 831.9 832.1 834.0 606.2 607.9 609.4 612.4 612.7 12441.3 12465.1 12488.4 12507.9 12509.2 13082.4 13239.8 13335.1 13503.3 13647.7 10346.5 10396.9 10412.0 10511.4 10557.0 3288.8 3307.5 3320.9 3334.2 3360.7 60490.4 60801.1 61406.1 61536.7 61610.7 10257.8 10277.9 10343.6 10426.8 10623.6 17919.4 18024.5 18106.6 18171.8 18866.9 6176.2 6223.2 6463.2 6569.8 6670.4 3652.4 3742.3 3775.1 3781.5 3817.7 2762.8 2864.5 2867.4 2878.3 2882.6 492.6 496.2 498.6 503.1 515.5 567.0 612.3 619.3 632.2 633.7 7837.3 8023.6 8275.3 8425.7 8428.4 455.6 532.2 578.2 616.2 617.1 3980.9 4097.5 4212.5 4240.3 4360.5 92039.0 95003.5 97181.5 100190.0 100597.5 82661.9 84484.6 84940.6 85485.0 86676.1 43293.8 48419.8 75207.0 78513.2 79704.0 7828.6 8049.2 8123.8 8162.8 8196.2 43351.0 43529.8 43624.3 43798.3 46034.8 34795.8 35050.8 60546.2 62810.4 63488.4 10207.2 10300.4 10343.5 11354.9 11686.8 12482.9 12626.7 13577.3 13620.3 14101.0 11775.4 12064.6 12213.5 12301.2 12439.3 11628.7 12071.3 12377.9 12449.7 12450.3 11067.8 11606.4 11626.4 12234.6 12259.0 9997.3 10241.5 10498.0 10674.4 10801.7 8931.6 9361.5 10252.1 10410.2 10450.6 16:32:16 INFO - PROCESS | 14996 | -------- Summary: end -------- 16:32:16 INFO - PROCESS | 14996 | 16:32:17 INFO - TEST-INFO | 14996: exit 0 16:32:17 INFO - TEST-OK | dromaeo_css | took 1116976ms 16:32:17 INFO - TEST-START | kraken 16:32:17 INFO - operating with platform_type : linux_ 16:32:17 INFO - Initialising browser for kraken test... 16:32:17 INFO - TEST-INFO | started process 15240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYedmZK/profile http://localhost:60859/getInfo.html) 16:32:20 INFO - PROCESS | 15240 | JavaScript error: , line 0: uncaught exception: undefined 16:32:22 INFO - PROCESS | 15240 | __metrics Screen width/height:1600/1200 16:32:22 INFO - PROCESS | 15240 | colorDepth:24 16:32:22 INFO - PROCESS | 15240 | Browser inner width/height: 1024/697 16:32:22 INFO - PROCESS | 15240 | __metrics 16:32:22 ERROR - PROCESS | 15240 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:32:23 INFO - TEST-INFO | 15240: exit 0 16:32:23 INFO - Browser initialized. 16:32:23 INFO - Running cycle 1/1 for kraken test... 16:32:23 INFO - TEST-INFO | started process 15356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYedmZK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:35 INFO - PROCESS | 15356 | RSS: Main: 165834752 16:32:35 INFO - PROCESS | 15356 | 16:32:38 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60859/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:39 INFO - PROCESS | 15356 | RSS: Main: 171356160 16:32:39 INFO - PROCESS | 15356 | 16:32:42 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60859/tests/kraken/driver.html?testName=audio-dft) 16:32:42 INFO - PROCESS | 15356 | RSS: Main: 170270720 16:32:42 INFO - PROCESS | 15356 | 16:32:45 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60859/tests/kraken/driver.html?testName=audio-fft) 16:32:46 INFO - PROCESS | 15356 | RSS: Main: 166584320 16:32:46 INFO - PROCESS | 15356 | 16:32:48 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60859/tests/kraken/driver.html?testName=audio-oscillator) 16:32:49 INFO - PROCESS | 15356 | RSS: Main: 167624704 16:32:49 INFO - PROCESS | 15356 | 16:32:51 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:52 INFO - PROCESS | 15356 | RSS: Main: 167845888 16:32:52 INFO - PROCESS | 15356 | 16:32:55 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60859/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:56 INFO - PROCESS | 15356 | RSS: Main: 168255488 16:32:56 INFO - PROCESS | 15356 | 16:32:59 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60859/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:00 INFO - PROCESS | 15356 | RSS: Main: 164397056 16:33:00 INFO - PROCESS | 15356 | 16:33:03 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60859/tests/kraken/driver.html?testName=json-parse-financial) 16:33:03 INFO - PROCESS | 15356 | RSS: Main: 167366656 16:33:03 INFO - PROCESS | 15356 | 16:33:05 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:06 INFO - PROCESS | 15356 | RSS: Main: 167522304 16:33:06 INFO - PROCESS | 15356 | 16:33:08 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:08 INFO - PROCESS | 15356 | RSS: Main: 167518208 16:33:08 INFO - PROCESS | 15356 | 16:33:11 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:11 INFO - PROCESS | 15356 | RSS: Main: 167866368 16:33:11 INFO - PROCESS | 15356 | 16:33:14 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:15 INFO - PROCESS | 15356 | RSS: Main: 168046592 16:33:15 INFO - PROCESS | 15356 | 16:33:18 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:18 INFO - PROCESS | 15356 | RSS: Main: 168157184 16:33:18 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | Cycle 1(1): loaded http://localhost:60859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60859/tests/kraken/driver.html?testName=ai-astar) 16:33:20 INFO - PROCESS | 15356 | RSS: Main: 168792064 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | __start_tp_report 16:33:20 INFO - PROCESS | 15356 | _x_x_mozilla_page_load 16:33:20 INFO - PROCESS | 15356 | _x_x_mozilla_page_load_details 16:33:20 INFO - PROCESS | 15356 | |i|pagename|runs| 16:33:20 INFO - PROCESS | 15356 | |0;ai-astar;104;119;108;113;115;115;115;114;114;113 16:33:20 INFO - PROCESS | 15356 | |1;audio-beat-detection;152;124;149;193;130;155;151;124;189;129 16:33:20 INFO - PROCESS | 15356 | |2;audio-dft;165;162;166;175;162;165;161;163;163;161 16:33:20 INFO - PROCESS | 15356 | |3;audio-fft;77;76;77;171;78;77;79;75;174;78 16:33:20 INFO - PROCESS | 15356 | |4;audio-oscillator;87;86;141;86;85;85;126;87;90;143 16:33:20 INFO - PROCESS | 15356 | |5;imaging-gaussian-blur;119;117;117;118;118;117;118;119;124;123 16:33:20 INFO - PROCESS | 15356 | |6;imaging-darkroom;147;149;150;149;151;150;151;149;149;147 16:33:20 INFO - PROCESS | 15356 | |7;imaging-desaturate;96;95;96;96;96;96;96;100;96;96 16:33:20 INFO - PROCESS | 15356 | |8;json-parse-financial;63;65;64;64;64;64;67;75;64;64 16:33:20 INFO - PROCESS | 15356 | |9;json-stringify-tinderbox;65;65;66;65;65;65;66;66;66;66 16:33:20 INFO - PROCESS | 15356 | |10;stanford-crypto-aes;90;84;80;82;80;81;86;83;85;86 16:33:20 INFO - PROCESS | 15356 | |11;stanford-crypto-ccm;134;129;130;147;134;131;143;133;172;130 16:33:20 INFO - PROCESS | 15356 | |12;stanford-crypto-pbkdf2;172;175;171;164;170;169;167;166;167;167 16:33:20 INFO - PROCESS | 15356 | |13;stanford-crypto-sha256-iterative;68;72;73;68;67;68;69;68;69;70 16:33:20 INFO - PROCESS | 15356 | __end_tp_report 16:33:20 INFO - PROCESS | 15356 | __start_cc_report 16:33:20 INFO - PROCESS | 15356 | _x_x_mozilla_cycle_collect,949 16:33:20 INFO - PROCESS | 15356 | __end_cc_report 16:33:20 INFO - PROCESS | 15356 | __startTimestamp1469748800699__endTimestamp 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | ------- Summary: start ------- 16:33:20 INFO - PROCESS | 15356 | Number of tests: 14 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:4.16 (3.6%) stddev-sans-first:2.87 16:33:20 INFO - PROCESS | 15356 | Values: 104.0 119.0 108.0 113.0 115.0 115.0 115.0 114.0 114.0 113.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:151.50 stddev:24.93 (16.5%) stddev-sans-first:26.42 16:33:20 INFO - PROCESS | 15356 | Values: 152.0 124.0 149.0 193.0 130.0 155.0 151.0 124.0 189.0 129.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:4.14 (2.5%) stddev-sans-first:4.38 16:33:20 INFO - PROCESS | 15356 | Values: 165.0 162.0 166.0 175.0 162.0 165.0 161.0 163.0 163.0 161.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#3] audio-fft Cycles:10 Average:96.20 Median:77.00 stddev:40.23 (52.3%) stddev-sans-first:42.07 16:33:20 INFO - PROCESS | 15356 | Values: 77.0 76.0 77.0 171.0 78.0 77.0 79.0 75.0 174.0 78.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:86.00 stddev:24.63 (28.6%) stddev-sans-first:25.55 16:33:20 INFO - PROCESS | 15356 | Values: 87.0 86.0 141.0 86.0 85.0 85.0 126.0 87.0 90.0 143.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:118.50 stddev:2.49 (2.1%) stddev-sans-first:2.65 16:33:20 INFO - PROCESS | 15356 | Values: 119.0 117.0 117.0 118.0 118.0 117.0 118.0 119.0 124.0 123.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.40 (0.9%) stddev-sans-first:1.24 16:33:20 INFO - PROCESS | 15356 | Values: 147.0 149.0 150.0 149.0 151.0 150.0 151.0 149.0 149.0 147.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.34 (1.4%) stddev-sans-first:1.41 16:33:20 INFO - PROCESS | 15356 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 100.0 96.0 96.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.00 stddev:3.53 (5.5%) stddev-sans-first:3.64 16:33:20 INFO - PROCESS | 15356 | Values: 63.0 65.0 64.0 64.0 64.0 64.0 67.0 75.0 64.0 64.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:33:20 INFO - PROCESS | 15356 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 66.0 66.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.50 stddev:3.16 (3.7%) stddev-sans-first:2.40 16:33:20 INFO - PROCESS | 15356 | Values: 90.0 84.0 80.0 82.0 80.0 81.0 86.0 83.0 85.0 86.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.00 stddev:13.23 (9.9%) stddev-sans-first:13.94 16:33:20 INFO - PROCESS | 15356 | Values: 134.0 129.0 130.0 147.0 134.0 131.0 143.0 133.0 172.0 130.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:3.26 (1.9%) stddev-sans-first:3.24 16:33:20 INFO - PROCESS | 15356 | Values: 172.0 175.0 171.0 164.0 170.0 169.0 167.0 166.0 167.0 167.0 16:33:20 INFO - PROCESS | 15356 | 16:33:20 INFO - PROCESS | 15356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:2.00 16:33:20 INFO - PROCESS | 15356 | Values: 68.0 72.0 73.0 68.0 67.0 68.0 69.0 68.0 69.0 70.0 16:33:20 INFO - PROCESS | 15356 | -------- Summary: end -------- 16:33:20 INFO - PROCESS | 15356 | 16:33:21 INFO - TEST-INFO | 15356: exit 0 16:33:21 INFO - TEST-OK | kraken | took 64393ms 16:33:21 INFO - SUITE-END | took 1181s 16:33:21 INFO - Completed test suite (00:19:41) 16:33:21 INFO - javascript benchmark 16:33:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6374.182031149987, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2508.260063281334, 2600.6879174499063, 2617.2148355493346, 2633.2495238856923, 2663.8135330526866, 4435.112977404524, 4699.2951057341415, 4809.062232864593, 4835.661503694742, 4841.104395686796, 4709.64677649176, 4710.481846996836, 4712.882177945553, 4751.928721069178, 4809.230523116302, 4321.070969741497, 4373.081652852905, 4440.644748420134, 4462.419885414892, 4511.436070491189, 4411.955880441186, 4472.597466228039, 4485.753283569403, 4512.9097418051615, 4534.569215924498, 4221.936670949938, 4315.5900189481945, 4383.715058521186, 4384.013596940663, 4417.690761646702, 4325.978370108161, 4333.4366532350905, 4335.674824388184, 4429.202743506167, 4459.152760975404, 4359.869203923888, 4361.934570981438, 4382.8904277393, 4386.298192289219, 4397.032652816375, 4687.95312046882, 4717.834875779331, 4734.124187025412, 4768.976155119237, 4808.038392321515, 5112.821051263225, 5124.128898087297, 5124.128898087334, 5143.974280128576, 5213.296205012312, 5186.299849520305, 5200.76596553156, 5202.4277329493725, 5208.192730126836, 5208.6093542984045, 4599.701019433726, 4793.13723529768, 4809.182438985381, 4839.903201936012, 4885.389326334208, 5313.043652142652, 5318.521333080042, 5321.095413779667, 5322.308099946982, 5331.360236771612, 5085.7711402986215, 5085.9745701271995, 5095.337606111256, 5098.490150984871, 5127.743612819344, 4956.975215123901, 4958.281049247839, 5075.289459475676, 5094.719790411489, 5109.693418394908, 5045.621578381636, 5071.822486213038, 5080.7205603692155, 5081.390233171969, 5123.641345105807, 5042.571381432546, 5108.029474399927, 5117.283580298761, 5119.6416250862085, 5164.638475306692, 4214.262504061777, 4298.763568003727, 4328.307470804656, 4359.411479450297, 4362.0, 3751.2122454284904, 3805.847766089381, 3813.828377723009, 3819.980900095482, 3820.9426858597144, 4375.518692943773, 4394.912101757947, 4422.358757980075, 4425.601695847389, 4461.754603496839, 4984.277279794482, 5032.874178145576, 5148.279240906276, 5169.81905633301, 5210.97394513025, 4317.222899878052, 4325.4593175853015, 4338.609525142752, 4367.432233809648, 4384.758838263926, 4554.453465584085, 4567.771611419482, 4569.794359253775, 4596.218642830727, 4608.861734147981, 4699.130660827758, 4786.8085276589245, 4798.0164066366315, 4800.039992001543, 4834.685745426536, 5150.0472412603785, 5163.328767260232, 5202.193659982709, 5232.136697445031, 5240.5807535397835, 4888.853334399973, 4904.435989861212, 4904.730239836843, 4905.5094490550655, 4926.3842019747535, 4845.781939812647, 4994.0, 5087.821926232564, 5105.846824595268, 5124.077666020003, 5074.974625126851, 5097.464766199496, 5113.284140220447, 5134.895997360585, 5182.792688292577, 4965.900681986413, 4979.751012449436, 4981.551660350586, 4987.600991920565, 5028.522290382408, 4811.831585894477, 4866.221404575251, 4965.751712414437, 4989.276554899592, 5042.890564075898, 4813.927791083207, 4835.95164048355, 4838.346823178826, 4891.706497610155, 4909.754512274443, 4928.556429921325, 4950.9257361140335, 4958.404991401055, 4986.526280003394, 5018.949810501995, 4747.026859493864, 4857.392825896763, 4860.243210537694, 4873.610111191168, 4914.36113305268], "value": 4687.524173019553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1248583424442, 574.5575906551956, 583.8948989181948, 587.4008511318456, 592.4460629311591, 33300.16749581262, 37989.24021519568, 38110.809445952735, 38115.61884381156, 38135.237295254075, 36315.81842090786, 36327.27345453089, 36759.0, 36864.26271474569, 36897.0, 7615.6192190390675, 7788.454808163431, 7793.103793063785, 7802.921970780277, 7816.452848300622, 7690.731029380146, 7698.461107722462, 7741.8838717419, 7786.1435242123325, 7822.0, 7810.0, 7824.5696486693205, 7825.608719563999, 7864.134945156028, 7914.881276780853, 7731.613419329011, 7779.144294127642, 7796.688132474751, 7813.570253636048, 7820.882686759646, 7714.228577142241, 7738.690452381898, 7742.993410856552, 7750.069991600988, 7756.6509507072315, 36720.63279367199, 36980.260394792225, 37172.81413592942, 37214.25571488555, 37291.0, 2549.987250063738, 2977.285451491626, 3000.8649610767566, 3067.2791893904914, 3078.4920488119433, 27084.729152708416, 27470.72529274722, 27596.310092247655, 28051.0, 28455.430891382264, 3227.951580726291, 3282.3107147499054, 3290.720288775457, 3292.1275861896615, 3317.369699757063, 229359.4128117445, 229790.0, 229986.0, 230475.0, 231442.0, 31702.682973169973, 31870.68129318677, 32007.0, 32094.679053209635, 32183.67816321807, 32900.34199316, 33184.668153318155, 33877.32245355079, 35259.82370088133, 35340.0, 14874.181919994504, 14997.850021499864, 15041.473548425753, 15047.322870470636, 15048.473303434546, 10610.522526486327, 10614.787704245871, 10620.946895265473, 10635.893641063645, 10636.0, 17969.910150449425, 18048.548786280448, 18066.728999065024, 18087.638247235245, 18108.00405977684, 6657.900131498031, 6691.1636045494315, 6710.530262881649, 6820.35206655367, 7035.226125126232, 807.7536351412758, 922.8246633139682, 964.8552717092352, 976.6581696406201, 977.0571398600242, 28327.433451330857, 28639.57040644392, 28816.423671526452, 28844.855775721408, 29172.416551668848, 970.6505657963128, 1026.712520494263, 1040.2770074797943, 1040.3913710479455, 1041.3907863899703, 14400.783988240184, 15324.310406031533, 15536.288978755258, 15546.611334716723, 15645.843541564438, 398123.0, 398788.0, 400466.0, 401094.0, 403395.0, 48604.27093593599, 49059.26411103836, 49237.753811230716, 49334.75332623314, 49449.75275123601, 1142.3374442823142, 1166.935818529972, 1189.8096304591397, 1197.3653963399413, 1198.4547031100828, 26771.33071673224, 27979.860100699367, 28452.288692782848, 28787.28031799222, 29013.56479652849, 42193.578064218964, 42395.7880210597, 42530.5746942539, 42651.3602295972, 42760.78619606882, 267425.0, 268211.0, 268661.0, 268887.0, 273466.0, 25128.0, 25328.873355633103, 25382.873085634452, 25964.610530841674, 26101.347466313495, 41296.1740765189, 41529.169416610894, 42193.36709949292, 42275.0, 42873.14253714971, 35680.464793027604, 35825.82567643458, 36523.269534608626, 37103.81448092742, 37516.43725344067, 36033.27933441264, 36626.0, 36638.81680591687, 36660.633393665725, 36676.0830979217, 35352.823235883654, 35668.46497302491, 36161.63838361688, 36263.63736362708, 36406.0, 30846.0, 33312.1671958203, 33342.16644583905, 33515.16212094717, 33671.663283366855, 25290.36774080663, 25413.87293063523, 25744.227673169837, 25894.35264118412, 25980.740192598587], "value": 16870.49366197468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.15719437198555, 354.37983528824554, 358.74170597170036, 362.6899001353844, 383.8196047857506, 16058.357665693373, 16809.0, 17644.382446614356, 17892.105394730275, 17939.91030044848, 16615.584610384718, 16763.497095087136, 17360.305587776504, 17492.912535437306, 17600.64798704025, 4930.556249937505, 5159.071367153911, 5160.0, 5163.81926632568, 5166.560842328407, 3734.8319325630277, 5146.202338637517, 5701.458361455655, 5952.047672372421, 5967.522598192156, 6015.458608725214, 6048.183495228154, 6049.546284028694, 6051.727672254737, 6051.969740151293, 5957.612755170921, 5964.284285885678, 6028.0, 6035.245594300713, 6037.969810150965, 5110.0, 5215.504527069922, 5222.4255331913455, 5225.190095535198, 5273.815416460444, 18665.0, 19464.513387165294, 20934.895325523426, 21167.788322116736, 21194.894025529775, 1775.9200835962413, 1820.6722789897813, 1998.2007197121122, 2036.5417780999305, 2415.973211385172, 9313.161815436642, 9357.39176953496, 9394.718158455258, 9404.106609872051, 9437.386569873004, 1727.853132483728, 1771.406578796105, 1780.830821071996, 1787.4101546489628, 1804.4586624012743, 65357.673211634115, 65506.3449365505, 66445.0, 66511.33488665099, 68616.0, 9690.56392462341, 9777.168940639984, 9785.434330507085, 9873.80252394948, 9949.950250248703, 13326.466941322238, 13327.0, 13334.066615337028, 13377.264250466123, 13391.598252052454, 7086.114235720535, 7087.362137407555, 7155.92844071563, 7215.927840721631, 7329.267073292628, 6727.529072964846, 6836.418904393083, 6861.2795656455355, 6919.8962015569805, 6940.618265995317, 4121.464209652726, 4271.295236286041, 4290.528041915387, 4349.934750978738, 4374.803133858984, 1465.377214683755, 1551.2941611566935, 1556.3930067273773, 1792.4891405949502, 1868.8037756035692, 789.9210078992055, 792.6433105102611, 818.7216346442119, 854.9957250213834, 918.7106061590712, 16689.415870444474, 17543.561410964827, 18313.3590324338, 18817.435476935712, 18999.715004274945, 830.8421399933993, 837.2883049407955, 842.9578521073922, 848.3298194426458, 858.1461445861283, 9284.0, 10045.0, 10077.344972576759, 10113.898861011296, 10284.023017813295, 415177.7098946563, 417066.0, 419645.0, 423927.0, 427105.0, 79719.0, 80159.0, 81849.18150818415, 82020.0, 87901.0, 884.5444596032919, 908.9136532029447, 943.0899182289124, 947.7062110745691, 949.7530642033121, 16011.279492422636, 16187.352505899633, 16367.91816040912, 16694.833051669328, 16866.24101915441, 38069.80965095267, 39248.80375598104, 39381.80309098551, 39447.408288875115, 40967.795161024005, 54905.0, 54995.17507237475, 56016.15975760285, 56211.0, 57407.42592574021, 7734.419918506247, 7868.84262314739, 7921.524708517507, 7971.960140199262, 8061.0, 9900.603975841173, 11815.704607384883, 12046.216995895238, 12110.0, 12169.148159628741, 10623.36259824413, 10788.136949044214, 10821.729456763644, 11006.724831879266, 11063.889361106609, 10559.208059395422, 10700.571977121139, 10794.244402891722, 10912.508937098008, 11047.502862371051, 10118.696439106838, 10333.173346132442, 10619.1504679627, 10637.361758294526, 10871.130309575374, 7551.811204719926, 7622.656980436004, 7635.618219089134, 7641.121271053677, 7709.151993280622, 9187.770305742142, 9637.614495420105, 10069.748256293651, 10178.541965611714, 10504.159667226451], "value": 8335.744129031538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.951701690441, 1416.4546649539927, 1491.1425930090202, 1633.199732131256, 1682.3943380383068, 6725.865482690343, 7241.0, 7399.963000184992, 7742.845143097142, 7755.650995705193, 7522.285382888631, 7817.648205830737, 7823.765287041384, 7830.216978302167, 7831.647575859086, 2143.2605751015913, 2179.487820362214, 2185.3007037747925, 2185.562887422514, 2186.223890518867, 2111.461577297787, 2118.3962570667363, 2201.0645475672854, 2202.746684131321, 2204.0853045985896, 2206.249875042485, 2209.558088382322, 2210.8452408331423, 2214.9557008859815, 2240.9887950560305, 2110.9788902110936, 2130.3928380411508, 2132.616129096762, 2140.785921407862, 2148.688440176166, 2091.2262462888675, 2116.7248257726396, 2126.6384714598557, 2134.1356750516065, 2144.571085782834, 7755.844883102306, 7757.5733334666575, 7781.844363112763, 7792.18182090878, 7824.765257042298, 4548.113117942003, 4626.352310676508, 4668.4631267404, 4682.672212945095, 4687.250039993584, 2836.163331817119, 2884.682684904659, 2909.0690978886764, 2951.7048295170525, 2975.6280464941883, 840.5209030852417, 840.8276303357858, 893.8391089603869, 900.2527901841456, 907.3648446087765, 10420.947895260551, 10460.37237765729, 10506.106980906632, 10518.421486818223, 10530.631427899987, 4010.418489319091, 4170.854020109282, 4309.633681137138, 4316.568343165658, 4317.762523061262, 9131.406458580172, 9143.54282285883, 9152.908470915205, 9154.26765858743, 9175.587098580447, 4665.766711664403, 4689.249720044776, 4726.172919739032, 4731.692439991459, 4732.266498692708, 3640.3629364861044, 4027.1744292419985, 4139.689523285766, 4322.783860806947, 4338.392625032498, 3630.056185391817, 3697.574778900461, 3716.349638813197, 3757.0231739747314, 3900.7659540427667, 1208.6736581123048, 1212.3512023647831, 1229.5327775445453, 1236.7402845402387, 1237.300924977385, 782.9608519574113, 792.0732742691065, 863.2964134230707, 864.7189663359434, 874.9956250218836, 5171.621054314982, 5225.843224703265, 5345.091334473149, 5406.216098665672, 5420.810271640553, 392.7427534964603, 396.6806720589953, 400.9278329900646, 401.4319737571304, 403.1815414708147, 3721.813909304578, 3863.7295389322476, 3901.180752042103, 3901.804909754501, 3984.42225877252, 9077.591508382138, 9615.182709469773, 9619.086186812241, 9630.518474076269, 9636.0, 8974.730758077269, 9216.861747073799, 9359.953200234091, 9565.713028609152, 9594.42433453981, 7071.080759501232, 7230.783076507713, 7277.2358902315555, 7286.599237042014, 7290.380317672951, 5206.687598744087, 5371.248025276386, 5396.9730151348995, 5397.433269506645, 5510.752016159202, 8470.745877623682, 8622.180892815173, 8709.433886797338, 8852.690155844515, 8891.688790892287, 8843.46939183651, 8912.73261802147, 9049.77375565616, 9102.635894564144, 9117.817643647222, 6105.786297479567, 6413.326600707045, 6561.278259391368, 6734.057231987624, 6929.480288978246, 7601.353884919844, 7601.885971710318, 7654.196309387434, 7667.539947603162, 7669.69321227167, 6762.4928130389435, 6806.659667016728, 6857.7256909723055, 6876.553024053421, 7023.543469674455, 6664.400203981471, 6686.598804071771, 6730.0, 6737.3599508046655, 6951.8609627806145, 5876.206712093813, 6055.515558755201, 6066.120412540069, 6093.725782339894, 6118.051701986199, 4395.7582332972, 4471.396361491157, 4482.148391805546, 4522.186006518858, 4565.201089809204, 4423.513413524574, 4450.618918878385, 4487.259602165736, 4561.771911404483, 4691.202495575692], "value": 4047.646730090296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.1412504860563, 292.6561290483681, 301.28895805898077, 301.98037127586707, 306.75153125967955, 4877.658563900528, 4980.0, 5062.734316420895, 5065.316182315386, 5079.822206222783, 4988.276699878525, 4990.326305948696, 5011.248312753089, 5015.22264049073, 5015.272785446108, 3945.1320709443876, 3957.881263562098, 3960.9899475633674, 3973.9006524836964, 3986.222686576119, 3897.922041559167, 3953.229120321524, 3984.2828290907623, 3988.0229343810806, 3997.8400863965408, 3930.233604447134, 3946.5264168299846, 3956.4263181838614, 3968.2063587282514, 3975.026118600947, 3952.288588054149, 3957.485526881516, 3964.980175099135, 3965.940510892339, 3983.6215559521797, 3502.579690437138, 3511.1397707561555, 3517.7009954153928, 3519.296140771856, 3533.593636731783, 4711.3639658646325, 4927.753612319406, 4939.777710003059, 4999.8250061248045, 5032.345795046621, 4422.712523685982, 4437.866863994085, 4459.175052615276, 4461.955380446219, 4471.932921006188, 5319.255304257407, 5321.866953326159, 5342.626016178869, 5356.143017117242, 5372.597055220874, 3633.636636336372, 3704.1665625234377, 3719.6652301292743, 3732.664060234592, 3750.79370634615, 5532.197831314437, 5533.6956467394275, 5539.612227144102, 5541.889162216773, 5556.027695153332, 3721.218544105714, 3740.0836794985403, 3752.0, 3757.962420375816, 3771.7171212159196, 3711.350513660099, 3796.6393192646656, 3802.239552089538, 3813.5995720448955, 3821.063839359375, 4291.570842915684, 4341.0, 4356.978215108904, 4360.324149756792, 4427.535108813592, 5306.8407947761625, 5315.415304316522, 5320.255164277004, 5320.733963301819, 5340.946590534123, 1270.84749830021, 1292.9741405172033, 1311.8622544632676, 1324.265032906746, 1331.407523651985, 864.3387808326635, 890.0921060518235, 911.8586619074055, 914.2092090341939, 917.2432742987062, 4526.985491456337, 4580.450345958507, 4590.908181836345, 4605.585497305258, 4614.653900957442, 5430.0, 5443.618946673774, 5463.235147079412, 5474.343078830486, 5482.753276102585, 4478.41780568524, 4606.792694328763, 4620.3762492063815, 4643.0, 4645.559876438315, 2550.7321731218326, 2552.3108760634896, 2558.411565339982, 2563.6410902473667, 2583.276682528895, 4515.683902126885, 4522.570355816192, 4530.29780384041, 4548.339855952553, 4553.704009239389, 4700.506446823103, 4776.044791041805, 4826.576160032799, 4830.130576496264, 4868.464468908417, 4574.313852922089, 4579.656525760582, 4589.0, 4594.632429405573, 4615.815367385267, 4779.498152694056, 4795.760211989456, 4802.255650374198, 4810.687305325143, 4815.662903596714, 4493.820247190076, 4662.790174442091, 4675.462321832897, 4741.454732705783, 4743.644226682944, 4542.818287268605, 4543.363929050001, 4560.954390456053, 4581.5647513486165, 4602.033572949718, 3480.7817263958427, 3505.0, 3508.561429821272, 3526.977176618752, 3537.4788840797673, 4864.27035944597, 4890.902181956412, 4891.1685013548495, 4897.338859254098, 5217.556507696889, 5120.846374608767, 5276.9472305278, 5294.470552944675, 5299.41706412302, 5300.17847233664, 5286.259923610774, 5297.417284098669, 5317.57459403239, 5318.441563635917, 5350.732463376893, 5129.563987060992, 5210.687358758487, 5215.817446389358, 5227.947720522746, 5263.894582137641, 5325.946740532545, 5326.920096198638, 5337.893242135213, 5353.491418315254, 5368.939704368472, 5218.817341393033, 5248.343957005374, 5253.395859476056, 5261.973690131525, 5271.077561426811], "value": 3858.7738790518138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.3683779382824, 662.2648859765659, 715.6171448275173, 732.7105793211681, 749.4079677055125, 12556.309402982832, 13107.148035377693, 13215.735685286289, 13220.867791322084, 13239.338033098342, 12563.434645440955, 12696.4921403144, 12720.936395318033, 12721.363931803397, 12731.61805145847, 618.6288227063749, 761.3072104385011, 767.263427109975, 780.5433821214597, 789.0688986995343, 785.7132146766418, 786.4455558831039, 787.5235482533071, 788.5229436191108, 789.2383849585149, 829.8091438969041, 838.4256784102909, 841.9579021048954, 843.5065486690294, 844.5945945945949, 826.5412695953743, 829.4691397505601, 831.8669012957928, 832.0847068224965, 834.0325222741621, 606.2270604978644, 607.8571535689109, 609.402785270433, 612.4182027074297, 612.6660969771485, 12441.253524788543, 12465.127441079128, 12488.375581220902, 12507.874921250763, 12509.186902851285, 13082.411291491906, 13239.801402978963, 13335.133216340906, 13503.324833758274, 13647.727045459034, 10346.482675866251, 10396.896031039669, 10412.0, 10511.369317840878, 10557.049865512065, 3288.786228895114, 3307.4542700454394, 3320.93358132836, 3334.1664583854035, 3360.680735330164, 60490.39509604892, 60801.08798368028, 61406.0789088164, 61536.69231653858, 61610.69194654043, 10257.794844103077, 10277.94861025705, 10343.586256549654, 10426.791464170674, 10623.628173013907, 17919.37282195117, 18024.459266222035, 18106.63786724258, 18171.818281817013, 18866.905665471586, 6176.166217560662, 6223.159873417121, 6463.15978922737, 6569.770058047945, 6670.39966403026, 3652.415613501827, 3742.326381251401, 3775.0751065989007, 3781.4516895050065, 3817.7136714746507, 2762.8204166729097, 2864.484392809314, 2867.3978464522265, 2878.280429892527, 2882.6396700412447, 492.5862275688367, 496.1763472635408, 498.62353922788066, 503.1120073071033, 515.5463192390747, 566.9971650141805, 612.2989177391861, 619.3001907844107, 632.2002666626721, 633.7243299164878, 7837.3338266246865, 8023.558704271204, 8275.255227029596, 8425.747227583182, 8428.448637735553, 455.59679683480357, 532.2016974538193, 578.2396149063967, 616.211249600512, 617.1267656266423, 3980.920381592352, 4097.508299004138, 4212.452381190487, 4240.300350442204, 4360.542143074995, 92039.0, 95003.52498237602, 97181.51409242909, 100190.0, 100597.49701251448, 82661.90719020902, 84484.57757711296, 84940.57529712311, 85485.0, 86676.13323866807, 43293.78353108277, 48419.75790121097, 75207.0, 78513.21486785059, 79704.0, 7828.647710852912, 8049.154838741848, 8123.75628731139, 8162.755117346489, 8196.197156360087, 43351.0, 43529.78235108804, 43624.345634816134, 43798.34302485529, 46034.76982615065, 34795.82602086973, 35050.82474587713, 60546.18361449164, 62810.37189628045, 63488.36511634824, 10207.183425325808, 10300.381977081399, 10343.482825858828, 11354.943225283821, 11686.766264674829, 12482.875171248172, 12626.684332891751, 13577.253251071286, 13620.250886201355, 14101.0, 11775.411229438323, 12064.577739779066, 12213.511459541518, 12301.200421972542, 12439.315837629018, 11628.709282268012, 12071.336076515525, 12377.876221237673, 12449.688757781129, 12450.319206907314, 11067.83398249043, 11606.419679015846, 11626.418679066182, 12234.571789987307, 12259.0, 9997.250206234707, 10241.539130738985, 10498.0, 10674.412907290174, 10801.729956751144, 8931.598078086372, 9361.485118318285, 10252.128569071414, 10410.219233557666, 10450.634227801991], "value": 6513.748090130782, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 108.0, 113.0, 115.0, 115.0, 115.0, 114.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 149.0, 193.0, 130.0, 155.0, 151.0, 124.0, 189.0, 129.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 166.0, 175.0, 162.0, 165.0, 161.0, 163.0, 163.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 171.0, 78.0, 77.0, 79.0, 75.0, 174.0, 78.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 141.0, 86.0, 85.0, 85.0, 126.0, 87.0, 90.0, 143.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 119.0, 124.0, 123.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 150.0, 149.0, 151.0, 150.0, 151.0, 149.0, 149.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 67.0, 75.0, 64.0, 64.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 80.0, 82.0, 80.0, 81.0, 86.0, 83.0, 85.0, 86.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 130.0, 147.0, 134.0, 131.0, 143.0, 133.0, 172.0, 130.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 164.0, 170.0, 169.0, 167.0, 166.0, 167.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 73.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 70.0], "value": 69.2, "unit": "score"}]}]} 16:33:21 INFO - Return code: 0 16:33:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:33:21 ERROR - # TBPL SUCCESS # 16:33:21 INFO - Running post-action listener: _resource_record_post_action 16:33:21 INFO - [mozharness: 2016-07-28 23:33:21.993328Z] Finished run-tests step (success) 16:33:21 INFO - Running post-run listener: _resource_record_post_run 16:33:22 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541028352; Read time: 12; Write time: 388724 16:33:22 INFO - TinderboxPrint: CPU usage
13.4% 16:33:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:33:22 INFO - TinderboxPrint: I/O write bytes / time
541,028,352 / 388,724 16:33:22 INFO - TinderboxPrint: CPU idle
8,279.7 (86.6%) 16:33:22 INFO - TinderboxPrint: CPU user
1,222.7 (12.8%) 16:33:22 INFO - TinderboxPrint: Swap in / out
0 / 0 16:33:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247234560; Read time: 0; Write time: 210840 16:33:22 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293793792; Read time: 12; Write time: 177884 16:33:22 INFO - Running post-run listener: _upload_blobber_files 16:33:22 INFO - Blob upload gear active. 16:33:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:22 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 16:33:22 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'] 16:33:22 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 16:33:23 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:33:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:33:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:23 INFO - (blobuploader) - INFO - Done attempting. 16:33:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:33:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:24 INFO - (blobuploader) - INFO - Done attempting. 16:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:28 INFO - (blobuploader) - INFO - Done attempting. 16:33:28 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:28 INFO - Return code: 0 16:33:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/613d0dc156de499b10eb7c008d6195a967766fbb0183bfdaca375788248eed3f61dcd8998a26635b89a5088bf6ba429391c5a9b118d9372178633fc45d4b634d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524d5c1396281e629d63b30e69e3100520410a79029b3dac0a4c15910e214cf0d624723cf056d954c7b093bf0192413269d36fa23e146b4d57b40f2101bdc20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4122347d08ca46841fd5456cf65c09d0d4bd5961238819ba45a40e677e5d834802616778f3878903c76e8b49017cb2a5d45df74c7721514d9b6f0bd00dbeda10"} 16:33:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:28 INFO - Contents: 16:33:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/613d0dc156de499b10eb7c008d6195a967766fbb0183bfdaca375788248eed3f61dcd8998a26635b89a5088bf6ba429391c5a9b118d9372178633fc45d4b634d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524d5c1396281e629d63b30e69e3100520410a79029b3dac0a4c15910e214cf0d624723cf056d954c7b093bf0192413269d36fa23e146b4d57b40f2101bdc20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4122347d08ca46841fd5456cf65c09d0d4bd5961238819ba45a40e677e5d834802616778f3878903c76e8b49017cb2a5d45df74c7721514d9b6f0bd00dbeda10"} 16:33:28 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:28 INFO - Copying logs to upload dir... 16:33:28 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.509448 ========= master_lag: 2.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-28 16:33:30.744235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:33:30.747772) ========= 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=7de08804244eb36560b44971000001c3-1469747320.576093-473822977 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/613d0dc156de499b10eb7c008d6195a967766fbb0183bfdaca375788248eed3f61dcd8998a26635b89a5088bf6ba429391c5a9b118d9372178633fc45d4b634d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524d5c1396281e629d63b30e69e3100520410a79029b3dac0a4c15910e214cf0d624723cf056d954c7b093bf0192413269d36fa23e146b4d57b40f2101bdc20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4122347d08ca46841fd5456cf65c09d0d4bd5961238819ba45a40e677e5d834802616778f3878903c76e8b49017cb2a5d45df74c7721514d9b6f0bd00dbeda10"} build_url:https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010236 build_url: 'https://queue.taskcluster.net/v1/task/N96MYv4zTAuOTfb4ppLvwA/artifacts/public/build/firefox-50.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/613d0dc156de499b10eb7c008d6195a967766fbb0183bfdaca375788248eed3f61dcd8998a26635b89a5088bf6ba429391c5a9b118d9372178633fc45d4b634d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524d5c1396281e629d63b30e69e3100520410a79029b3dac0a4c15910e214cf0d624723cf056d954c7b093bf0192413269d36fa23e146b4d57b40f2101bdc20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4122347d08ca46841fd5456cf65c09d0d4bd5961238819ba45a40e677e5d834802616778f3878903c76e8b49017cb2a5d45df74c7721514d9b6f0bd00dbeda10"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 16:33:30.771832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:33:30.772156) ========= 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=7de08804244eb36560b44971000001c3-1469747320.576093-473822977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 16:33:30.856115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:33:30.856489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 16:33:30.856915) ========= ========= Total master_lag: 5.57 =========