builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1469875874.88 results: success (0) buildid: 20160730005025 builduid: 3f3091f308c44c2d935d40d1084afe25 revision: c3565c8b1cdb575db1c80c7791984a6490598b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.880847) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.881688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.882333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.900923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.901540) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:51:15-- 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% 90.4M=0s 2016-07-30 03:51:15 (90.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.998612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:14.999264) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018800 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:15.051353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:15.051797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3565c8b1cdb575db1c80c7791984a6490598b84 --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 c3565c8b1cdb575db1c80c7791984a6490598b84 --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=e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:51:15,901 truncating revision to first 12 chars 2016-07-30 03:51:15,902 Setting DEBUG logging. 2016-07-30 03:51:15,902 attempt 1/10 2016-07-30 03:51:15,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3565c8b1cdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 03:51:16,525 unpacking tar archive at: fx-team-c3565c8b1cdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:16.043660) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:16.044411) ========= script_repo_revision: c3565c8b1cdb575db1c80c7791984a6490598b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:16.045384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:16.046029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:51:16.057928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-30 03:51:16.058257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:51:16 INFO - MultiFileLogger online at 20160730 03:51:16 in /builds/slave/test 03:51:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:51:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:16 INFO - {'append_to_log': False, 03:51:16 INFO - 'base_work_dir': '/builds/slave/test', 03:51:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:16 INFO - 'branch': 'Fx-Team-Non-PGO', 03:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:16 INFO - 'config_files': ('talos/linux_config.py',), 03:51:16 INFO - 'default_actions': ('clobber', 03:51:16 INFO - 'read-buildbot-config', 03:51:16 INFO - 'download-and-extract', 03:51:16 INFO - 'populate-webroot', 03:51:16 INFO - 'create-virtualenv', 03:51:16 INFO - 'install', 03:51:16 INFO - 'run-tests'), 03:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:16 INFO - 'download_minidump_stackwalk': True, 03:51:16 INFO - 'download_symbols': 'ondemand', 03:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:16 INFO - 'installer_path': 'installer.exe', 03:51:16 INFO - 'log_level': 'info', 03:51:16 INFO - 'log_name': 'talos', 03:51:17 INFO - 'log_to_console': True, 03:51:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:51:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:51:17 INFO - 'opt_config_files': (), 03:51:17 INFO - 'pip_index': False, 03:51:17 INFO - 'sps_profile': False, 03:51:17 INFO - 'sps_profile_interval': 0, 03:51:17 INFO - 'suite': 'dromaeojs', 03:51:17 INFO - 'system_bits': '32', 03:51:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:17 INFO - 'title': 'talos-linux64-ix-006', 03:51:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:17 INFO - 'use_talos_json': True, 03:51:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:17 INFO - 'work_dir': 'build'} 03:51:17 INFO - [mozharness: 2016-07-30 10:51:17.001171Z] Running clobber step. 03:51:17 INFO - Running pre-action listener: _resource_record_pre_action 03:51:17 INFO - Running main action method: clobber 03:51:17 INFO - rmtree: /builds/slave/test/build 03:51:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:17 INFO - Running post-action listener: _resource_record_post_action 03:51:17 INFO - [mozharness: 2016-07-30 10:51:17.970854Z] Finished clobber step (success) 03:51:17 INFO - [mozharness: 2016-07-30 10:51:17.970956Z] Running read-buildbot-config step. 03:51:17 INFO - Running pre-action listener: _resource_record_pre_action 03:51:17 INFO - Running main action method: read_buildbot_config 03:51:17 INFO - Using buildbot properties: 03:51:17 INFO - { 03:51:17 INFO - "project": "", 03:51:17 INFO - "product": "firefox", 03:51:17 INFO - "script_repo_revision": "production", 03:51:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:51:17 INFO - "repository": "", 03:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:51:17 INFO - "buildid": "20160730005025", 03:51:17 INFO - "pgo_build": "False", 03:51:17 INFO - "basedir": "/builds/slave/test", 03:51:17 INFO - "buildnumber": 2048, 03:51:17 INFO - "slavename": "talos-linux64-ix-006", 03:51:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:51:17 INFO - "platform": "ubuntu64_hw", 03:51:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:51:17 INFO - "branch": "fx-team", 03:51:17 INFO - "repo_path": "integration/fx-team", 03:51:17 INFO - "revision": "c3565c8b1cdb575db1c80c7791984a6490598b84", 03:51:17 INFO - "stage_platform": "linux64", 03:51:17 INFO - "builduid": "3f3091f308c44c2d935d40d1084afe25", 03:51:17 INFO - "slavebuilddir": "test" 03:51:17 INFO - } 03:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:51:17 INFO - Running post-action listener: _resource_record_post_action 03:51:17 INFO - [mozharness: 2016-07-30 10:51:17.973411Z] Finished read-buildbot-config step (success) 03:51:17 INFO - [mozharness: 2016-07-30 10:51:17.973501Z] Running download-and-extract step. 03:51:17 INFO - Running pre-action listener: _resource_record_pre_action 03:51:17 INFO - Running main action method: download_and_extract 03:51:17 INFO - mkdir: /builds/slave/test/build/tests 03:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:17 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:18 INFO - Downloaded 1361 bytes. 03:51:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:51:18 INFO - Using the following test package requirements: 03:51:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:51:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:51:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:51:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'jsshell-linux-x86_64.zip'], 03:51:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:51:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:51:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:51:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:51:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:51:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:51:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:51:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:51:18 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')]} 03:51:18 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:19 INFO - Downloaded 20231869 bytes. 03:51:19 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'] 03:51:19 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 03:51:20 INFO - Return code: 0 03:51:20 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 03:51:20 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')]} 03:51:20 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:21 INFO - Downloaded 20231869 bytes. 03:51:21 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'] 03:51:21 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 03:51:23 INFO - Return code: 0 03:51: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')]} 03:51:23 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:23 INFO - Downloaded 14413725 bytes. 03:51:23 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'] 03:51:23 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 03:51:24 INFO - Return code: 0 03:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:24 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/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 03:51:25 INFO - Downloaded 55584976 bytes. 03:51:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:25 INFO - mkdir: /builds/slave/test/properties 03:51:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:25 INFO - Contents: 03:51:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:51:26 INFO - Running post-action listener: _resource_record_post_action 03:51:26 INFO - Running post-action listener: set_extra_try_arguments 03:51:26 INFO - [mozharness: 2016-07-30 10:51:26.030608Z] Finished download-and-extract step (success) 03:51:26 INFO - [mozharness: 2016-07-30 10:51:26.030842Z] Running populate-webroot step. 03:51:26 INFO - Running pre-action listener: _resource_record_pre_action 03:51:26 INFO - Running main action method: populate_webroot 03:51:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:26 INFO - '--tppagecycles', 03:51:26 INFO - '7'], 03:51:26 INFO - 'tests': ['tsvgm']}}, 03:51:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:51:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['damp', 'tps']}, 03:51:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'tests': ['damp', 'tps']}, 03:51:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['dromaeo_dom']}, 03:51:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['basic_compositor_video']}, 03:51:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:51:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['a11yr', 03:51:26 INFO - 'ts_paint', 03:51:26 INFO - 'tpaint', 03:51:26 INFO - 'sessionrestore', 03:51:26 INFO - 'sessionrestore_no_auto_restore', 03:51:26 INFO - 'tabpaint']}, 03:51:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:26 INFO - 'ts_paint', 03:51:26 INFO - 'tpaint', 03:51:26 INFO - 'sessionrestore', 03:51:26 INFO - 'sessionrestore_no_auto_restore', 03:51:26 INFO - 'tabpaint']}, 03:51:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:26 INFO - 'ts_paint', 03:51:26 INFO - 'tpaint', 03:51:26 INFO - 'sessionrestore', 03:51:26 INFO - 'sessionrestore_no_auto_restore', 03:51:26 INFO - 'tabpaint']}, 03:51:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:26 INFO - 'ts_paint', 03:51:26 INFO - 'tpaint', 03:51:26 INFO - 'sessionrestore', 03:51:26 INFO - 'sessionrestore_no_auto_restore', 03:51:26 INFO - 'tabpaint']}, 03:51:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['a11yr', 03:51:26 INFO - 'ts_paint', 03:51:26 INFO - 'tpaint', 03:51:26 INFO - 'sessionrestore', 03:51:26 INFO - 'sessionrestore_no_auto_restore', 03:51:26 INFO - 'tabpaint']}, 03:51:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['a11yr', 03:51:26 INFO - 'ts_paint', 03:51:26 INFO - 'tpaint', 03:51:26 INFO - 'sessionrestore', 03:51:26 INFO - 'sessionrestore_no_auto_restore', 03:51:26 INFO - 'tabpaint']}, 03:51:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['tsvgx', 03:51:26 INFO - 'tsvgr_opacity', 03:51:26 INFO - 'tart', 03:51:26 INFO - 'tscrollx', 03:51:26 INFO - 'cart']}, 03:51:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:26 INFO - 'tsvgr_opacity', 03:51:26 INFO - 'tart', 03:51:26 INFO - 'tscrollx', 03:51:26 INFO - 'cart']}, 03:51:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'talos_options': ['--disable-e10s'], 03:51:26 INFO - 'tests': ['tp5o']}, 03:51:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'tests': ['tp5o']}, 03:51:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'talos_options': ['--disable-e10s', 03:51:26 INFO - '--xperf_path', 03:51:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:26 INFO - 'tests': ['tp5n']}, 03:51:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:51:26 INFO - 'talos_options': ['--xperf_path', 03:51:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:26 INFO - 'tests': ['tp5n']}}, 03:51:26 INFO - 'talos.zip': {'path': '', 03:51:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:26 INFO - Running post-action listener: _resource_record_post_action 03:51:26 INFO - [mozharness: 2016-07-30 10:51:26.050742Z] Finished populate-webroot step (success) 03:51:26 INFO - [mozharness: 2016-07-30 10:51:26.050831Z] Running create-virtualenv step. 03:51:26 INFO - Running pre-action listener: _resource_record_pre_action 03:51:26 INFO - Running main action method: create_virtualenv 03:51:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:26 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 03:51:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:51:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:51:26 INFO - Using real prefix '/usr' 03:51:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:51:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:51:28 INFO - Installing pip.................done. 03:51:28 INFO - Return code: 0 03:51:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:28 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:28 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 03:51:28 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 03:51:28 INFO - Using env: {'DISPLAY': ':0', 03:51:28 INFO - 'HOME': '/home/cltbld', 03:51:28 INFO - 'LANG': 'en_US.UTF-8', 03:51:28 INFO - 'LANGUAGE': 'en_US:en', 03:51:28 INFO - 'LOGNAME': 'cltbld', 03:51:28 INFO - 'MAIL': '/var/mail/cltbld', 03:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:28 INFO - 'MOZ_NO_REMOTE': '1', 03:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:28 INFO - 'NO_EM_RESTART': '1', 03:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:28 INFO - 'PWD': '/builds/slave/test', 03:51:28 INFO - 'SHELL': '/bin/bash', 03:51:28 INFO - 'SHLVL': '1', 03:51:28 INFO - 'TERM': 'linux', 03:51:28 INFO - 'TMOUT': '86400', 03:51:28 INFO - 'USER': 'cltbld', 03:51:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:28 INFO - '_': '/tools/buildbot/bin/python'} 03:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:28 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 03:51:28 INFO - Cleaning up... 03:51:28 INFO - Return code: 0 03:51:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:28 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:28 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 03:51:28 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 03:51:28 INFO - Using env: {'DISPLAY': ':0', 03:51:28 INFO - 'HOME': '/home/cltbld', 03:51:28 INFO - 'LANG': 'en_US.UTF-8', 03:51:28 INFO - 'LANGUAGE': 'en_US:en', 03:51:28 INFO - 'LOGNAME': 'cltbld', 03:51:28 INFO - 'MAIL': '/var/mail/cltbld', 03:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:28 INFO - 'MOZ_NO_REMOTE': '1', 03:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:28 INFO - 'NO_EM_RESTART': '1', 03:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:28 INFO - 'PWD': '/builds/slave/test', 03:51:28 INFO - 'SHELL': '/bin/bash', 03:51:28 INFO - 'SHLVL': '1', 03:51:28 INFO - 'TERM': 'linux', 03:51:28 INFO - 'TMOUT': '86400', 03:51:28 INFO - 'USER': 'cltbld', 03:51:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:28 INFO - '_': '/tools/buildbot/bin/python'} 03:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:29 INFO - Downloading/unpacking psutil>=3.1.1 03:51:29 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 03:51:29 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 03:51:29 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 03:51:29 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 03:51:29 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 03:51:29 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 03:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:31 INFO - Installing collected packages: psutil 03:51:31 INFO - Running setup.py install for psutil 03:51:31 INFO - building 'psutil._psutil_linux' extension 03:51:31 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 03:51:31 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 03:51:31 INFO - building 'psutil._psutil_posix' extension 03:51:31 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 03:51:31 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 03:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:31 INFO - Successfully installed psutil 03:51:31 INFO - Cleaning up... 03:51:31 INFO - Return code: 0 03:51:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:31 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:31 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 03:51:31 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 03:51:31 INFO - Using env: {'DISPLAY': ':0', 03:51:31 INFO - 'HOME': '/home/cltbld', 03:51:31 INFO - 'LANG': 'en_US.UTF-8', 03:51:31 INFO - 'LANGUAGE': 'en_US:en', 03:51:31 INFO - 'LOGNAME': 'cltbld', 03:51:31 INFO - 'MAIL': '/var/mail/cltbld', 03:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:31 INFO - 'MOZ_NO_REMOTE': '1', 03:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:31 INFO - 'NO_EM_RESTART': '1', 03:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:31 INFO - 'PWD': '/builds/slave/test', 03:51:31 INFO - 'SHELL': '/bin/bash', 03:51:31 INFO - 'SHLVL': '1', 03:51:31 INFO - 'TERM': 'linux', 03:51:31 INFO - 'TMOUT': '86400', 03:51:31 INFO - 'USER': 'cltbld', 03:51:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:31 INFO - '_': '/tools/buildbot/bin/python'} 03:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:31 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 03:51:31 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 03:51:31 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 03:51:31 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 03:51:31 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 03:51:31 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 03:51:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:33 INFO - Installing collected packages: mozsystemmonitor 03:51:33 INFO - Running setup.py install for mozsystemmonitor 03:51:33 INFO - Successfully installed mozsystemmonitor 03:51:33 INFO - Cleaning up... 03:51:34 INFO - Return code: 0 03:51:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:34 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:34 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 03:51:34 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 03:51:34 INFO - Using env: {'DISPLAY': ':0', 03:51:34 INFO - 'HOME': '/home/cltbld', 03:51:34 INFO - 'LANG': 'en_US.UTF-8', 03:51:34 INFO - 'LANGUAGE': 'en_US:en', 03:51:34 INFO - 'LOGNAME': 'cltbld', 03:51:34 INFO - 'MAIL': '/var/mail/cltbld', 03:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:34 INFO - 'MOZ_NO_REMOTE': '1', 03:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:34 INFO - 'NO_EM_RESTART': '1', 03:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:34 INFO - 'PWD': '/builds/slave/test', 03:51:34 INFO - 'SHELL': '/bin/bash', 03:51:34 INFO - 'SHLVL': '1', 03:51:34 INFO - 'TERM': 'linux', 03:51:34 INFO - 'TMOUT': '86400', 03:51:34 INFO - 'USER': 'cltbld', 03:51:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:34 INFO - '_': '/tools/buildbot/bin/python'} 03:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:34 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 03:51:34 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 03:51:34 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 03:51:34 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 03:51:34 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 03:51:34 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 03:51:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:36 INFO - warning: no files found matching '*.txt' 03:51:36 INFO - no previously-included directories found matching 'build' 03:51:36 INFO - no previously-included directories found matching 'dist' 03:51:36 INFO - no previously-included directories found matching '.git*' 03:51:36 INFO - Installing collected packages: jsonschema, functools32 03:51:36 INFO - Running setup.py install for functools32 03:51:36 INFO - warning: no files found matching '*.txt' 03:51:36 INFO - no previously-included directories found matching 'build' 03:51:36 INFO - no previously-included directories found matching 'dist' 03:51:36 INFO - no previously-included directories found matching '.git*' 03:51:36 INFO - Successfully installed jsonschema functools32 03:51:36 INFO - Cleaning up... 03:51:36 INFO - Return code: 0 03:51:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:36 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')]} 03:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:36 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')]} 03:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:36 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:36 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 03:51:36 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 03:51:36 INFO - Using env: {'DISPLAY': ':0', 03:51:36 INFO - 'HOME': '/home/cltbld', 03:51:36 INFO - 'LANG': 'en_US.UTF-8', 03:51:36 INFO - 'LANGUAGE': 'en_US:en', 03:51:36 INFO - 'LOGNAME': 'cltbld', 03:51:36 INFO - 'MAIL': '/var/mail/cltbld', 03:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:36 INFO - 'MOZ_NO_REMOTE': '1', 03:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:36 INFO - 'NO_EM_RESTART': '1', 03:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:36 INFO - 'PWD': '/builds/slave/test', 03:51:36 INFO - 'SHELL': '/bin/bash', 03:51:36 INFO - 'SHLVL': '1', 03:51:36 INFO - 'TERM': 'linux', 03:51:36 INFO - 'TMOUT': '86400', 03:51:36 INFO - 'USER': 'cltbld', 03:51:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:36 INFO - '_': '/tools/buildbot/bin/python'} 03:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:36 INFO - Cleaning up... 03:51:36 INFO - Return code: 0 03:51:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:36 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')]} 03:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:36 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')]} 03:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:36 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:36 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 03:51:36 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 03:51:36 INFO - Using env: {'DISPLAY': ':0', 03:51:36 INFO - 'HOME': '/home/cltbld', 03:51:36 INFO - 'LANG': 'en_US.UTF-8', 03:51:36 INFO - 'LANGUAGE': 'en_US:en', 03:51:36 INFO - 'LOGNAME': 'cltbld', 03:51:36 INFO - 'MAIL': '/var/mail/cltbld', 03:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:36 INFO - 'MOZ_NO_REMOTE': '1', 03:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:36 INFO - 'NO_EM_RESTART': '1', 03:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:36 INFO - 'PWD': '/builds/slave/test', 03:51:36 INFO - 'SHELL': '/bin/bash', 03:51:36 INFO - 'SHLVL': '1', 03:51:36 INFO - 'TERM': 'linux', 03:51:36 INFO - 'TMOUT': '86400', 03:51:36 INFO - 'USER': 'cltbld', 03:51:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:36 INFO - '_': '/tools/buildbot/bin/python'} 03:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 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 03:51:36 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 03:51:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:38 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 03:51:38 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 03:51:38 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 03:51:38 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 03:51:38 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 03:51:38 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 03:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:39 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 03:51:39 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 03:51:39 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 03:51:39 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 03:51:39 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 03:51:39 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 03:51:39 INFO - Downloading docopt-0.6.1.tar.gz 03:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:39 INFO - Running setup.py install for blobuploader 03:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:39 INFO - Running setup.py install for requests 03:51:40 INFO - Running setup.py install for docopt 03:51:40 INFO - Successfully installed blobuploader requests docopt 03:51:40 INFO - Cleaning up... 03:51:40 INFO - Return code: 0 03:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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')]} 03:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:40 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:40 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 03:51:40 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 03:51:40 INFO - Using env: {'DISPLAY': ':0', 03:51:40 INFO - 'HOME': '/home/cltbld', 03:51:40 INFO - 'LANG': 'en_US.UTF-8', 03:51:40 INFO - 'LANGUAGE': 'en_US:en', 03:51:40 INFO - 'LOGNAME': 'cltbld', 03:51:40 INFO - 'MAIL': '/var/mail/cltbld', 03:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:40 INFO - 'MOZ_NO_REMOTE': '1', 03:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:40 INFO - 'NO_EM_RESTART': '1', 03:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:40 INFO - 'PWD': '/builds/slave/test', 03:51:40 INFO - 'SHELL': '/bin/bash', 03:51:40 INFO - 'SHLVL': '1', 03:51:40 INFO - 'TERM': 'linux', 03:51:40 INFO - 'TMOUT': '86400', 03:51:40 INFO - 'USER': 'cltbld', 03:51:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:40 INFO - '_': '/tools/buildbot/bin/python'} 03:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:40 INFO - Running setup.py (path:/tmp/pip-NBO1L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:40 INFO - Running setup.py (path:/tmp/pip-RcVS9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:40 INFO - Running setup.py (path:/tmp/pip-Xj7VNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:40 INFO - Running setup.py (path:/tmp/pip-HxKgpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:40 INFO - Running setup.py (path:/tmp/pip-W1Vi4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:40 INFO - Running setup.py (path:/tmp/pip-lxQ1rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:40 INFO - Running setup.py (path:/tmp/pip-OmmoJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:40 INFO - Running setup.py (path:/tmp/pip-8Sfr1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:41 INFO - Running setup.py (path:/tmp/pip-Y5D8Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:41 INFO - Running setup.py (path:/tmp/pip-sfNBgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:41 INFO - Running setup.py (path:/tmp/pip-HMppxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:41 INFO - Running setup.py (path:/tmp/pip-4q8zqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:41 INFO - Running setup.py (path:/tmp/pip-WAAy_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:41 INFO - Running setup.py (path:/tmp/pip-H0Svls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:41 INFO - Running setup.py (path:/tmp/pip-wP4ivL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:41 INFO - Running setup.py (path:/tmp/pip-nXcDAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:41 INFO - Running setup.py (path:/tmp/pip-GGwwN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:41 INFO - Running setup.py install for manifestparser 03:51:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:41 INFO - Running setup.py install for mozcrash 03:51:41 INFO - Running setup.py install for mozdebug 03:51:41 INFO - Running setup.py install for mozdevice 03:51:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Running setup.py install for mozfile 03:51:42 INFO - Running setup.py install for mozhttpd 03:51:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Running setup.py install for mozinfo 03:51:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Running setup.py install for mozInstall 03:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Running setup.py install for mozleak 03:51:42 INFO - Running setup.py install for mozlog 03:51:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Running setup.py install for moznetwork 03:51:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:42 INFO - Running setup.py install for mozprocess 03:51:42 INFO - Running setup.py install for mozprofile 03:51:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:43 INFO - Running setup.py install for mozrunner 03:51:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:43 INFO - Running setup.py install for mozscreenshot 03:51:43 INFO - Running setup.py install for moztest 03:51:43 INFO - Running setup.py install for mozversion 03:51:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:43 INFO - Cleaning up... 03:51:43 INFO - Return code: 0 03:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:43 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')]} 03:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:43 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')]} 03:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:43 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:43 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 03:51:43 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 03:51:43 INFO - Using env: {'DISPLAY': ':0', 03:51:43 INFO - 'HOME': '/home/cltbld', 03:51:43 INFO - 'LANG': 'en_US.UTF-8', 03:51:43 INFO - 'LANGUAGE': 'en_US:en', 03:51:43 INFO - 'LOGNAME': 'cltbld', 03:51:43 INFO - 'MAIL': '/var/mail/cltbld', 03:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:43 INFO - 'MOZ_NO_REMOTE': '1', 03:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:43 INFO - 'NO_EM_RESTART': '1', 03:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:43 INFO - 'PWD': '/builds/slave/test', 03:51:43 INFO - 'SHELL': '/bin/bash', 03:51:43 INFO - 'SHLVL': '1', 03:51:43 INFO - 'TERM': 'linux', 03:51:43 INFO - 'TMOUT': '86400', 03:51:43 INFO - 'USER': 'cltbld', 03:51:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:43 INFO - '_': '/tools/buildbot/bin/python'} 03:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:43 INFO - Running setup.py (path:/tmp/pip-xELKno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:43 INFO - Running setup.py (path:/tmp/pip-4BjKhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:43 INFO - Running setup.py (path:/tmp/pip-oJ1FwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:43 INFO - Running setup.py (path:/tmp/pip-513YBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:43 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)) 03:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:44 INFO - Running setup.py (path:/tmp/pip-X11asx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:44 INFO - Running setup.py (path:/tmp/pip-cBr1qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:44 INFO - Running setup.py (path:/tmp/pip-lsIJtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:44 INFO - Running setup.py (path:/tmp/pip-M7l4Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:44 INFO - Running setup.py (path:/tmp/pip-MfPK03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:44 INFO - Running setup.py (path:/tmp/pip-wu1IM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:44 INFO - Running setup.py (path:/tmp/pip-bemsNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:44 INFO - Running setup.py (path:/tmp/pip-oWY38l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:44 INFO - Running setup.py (path:/tmp/pip-UAEx5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:44 INFO - Running setup.py (path:/tmp/pip-zxXEa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:44 INFO - Running setup.py (path:/tmp/pip-hg2eN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:44 INFO - Running setup.py (path:/tmp/pip-lG2Ah1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:44 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)) 03:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:44 INFO - Running setup.py (path:/tmp/pip-pM6zid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:44 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)) 03:51:44 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)) 03:51:44 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)) 03:51:44 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)) 03:51:44 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)) 03:51:44 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)) 03:51:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:46 INFO - Downloading blessings-1.6.tar.gz 03:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:46 INFO - Installing collected packages: blessings 03:51:46 INFO - Running setup.py install for blessings 03:51:47 INFO - Successfully installed blessings 03:51:47 INFO - Cleaning up... 03:51:47 INFO - Return code: 0 03:51:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:47 INFO - Reading from file tmpfile_stdout 03:51:47 INFO - Current package versions: 03:51:47 INFO - argparse == 1.2.1 03:51:47 INFO - blessings == 1.6 03:51:47 INFO - blobuploader == 1.2.4 03:51:47 INFO - docopt == 0.6.1 03:51:47 INFO - functools32 == 3.2.3-2 03:51:47 INFO - jsonschema == 2.5.1 03:51:47 INFO - manifestparser == 1.1 03:51:47 INFO - mozInstall == 1.12 03:51:47 INFO - mozcrash == 0.17 03:51:47 INFO - mozdebug == 0.1 03:51:47 INFO - mozdevice == 0.48 03:51:47 INFO - mozfile == 1.2 03:51:47 INFO - mozhttpd == 0.7 03:51:47 INFO - mozinfo == 0.9 03:51:47 INFO - mozleak == 0.1 03:51:47 INFO - mozlog == 3.3 03:51:47 INFO - moznetwork == 0.27 03:51:47 INFO - mozprocess == 0.23 03:51:47 INFO - mozprofile == 0.28 03:51:47 INFO - mozrunner == 6.12 03:51:47 INFO - mozscreenshot == 0.1 03:51:47 INFO - mozsystemmonitor == 0.3 03:51:47 INFO - moztest == 0.7 03:51:47 INFO - mozversion == 1.4 03:51:47 INFO - psutil == 3.1.1 03:51:47 INFO - requests == 1.2.3 03:51:47 INFO - wsgiref == 0.1.2 03:51:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:47 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 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:47 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 03:51:47 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 03:51:47 INFO - Using env: {'DISPLAY': ':0', 03:51:47 INFO - 'HOME': '/home/cltbld', 03:51:47 INFO - 'LANG': 'en_US.UTF-8', 03:51:47 INFO - 'LANGUAGE': 'en_US:en', 03:51:47 INFO - 'LOGNAME': 'cltbld', 03:51:47 INFO - 'MAIL': '/var/mail/cltbld', 03:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:47 INFO - 'MOZ_NO_REMOTE': '1', 03:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:47 INFO - 'NO_EM_RESTART': '1', 03:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:47 INFO - 'PWD': '/builds/slave/test', 03:51:47 INFO - 'SHELL': '/bin/bash', 03:51:47 INFO - 'SHLVL': '1', 03:51:47 INFO - 'TERM': 'linux', 03:51:47 INFO - 'TMOUT': '86400', 03:51:47 INFO - 'USER': 'cltbld', 03:51:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:47 INFO - '_': '/tools/buildbot/bin/python'} 03:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 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)) 03:51:47 INFO - Cleaning up... 03:51:47 INFO - Return code: 0 03:51:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', '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 03:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:51:47 INFO - Using env: {'DISPLAY': ':0', 03:51:47 INFO - 'HOME': '/home/cltbld', 03:51:47 INFO - 'LANG': 'en_US.UTF-8', 03:51:47 INFO - 'LANGUAGE': 'en_US:en', 03:51:47 INFO - 'LOGNAME': 'cltbld', 03:51:47 INFO - 'MAIL': '/var/mail/cltbld', 03:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:47 INFO - 'MOZ_NO_REMOTE': '1', 03:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:47 INFO - 'NO_EM_RESTART': '1', 03:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:47 INFO - 'PWD': '/builds/slave/test', 03:51:47 INFO - 'SHELL': '/bin/bash', 03:51:47 INFO - 'SHLVL': '1', 03:51:47 INFO - 'TERM': 'linux', 03:51:47 INFO - 'TMOUT': '86400', 03:51:47 INFO - 'USER': 'cltbld', 03:51:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:47 INFO - '_': '/tools/buildbot/bin/python'} 03:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:47 INFO - Cleaning up... 03:51:47 INFO - Return code: 0 03:51:47 INFO - Running post-action listener: _resource_record_post_action 03:51:47 INFO - Running post-action listener: _start_resource_monitoring 03:51:47 INFO - Starting resource monitoring. 03:51:47 INFO - [mozharness: 2016-07-30 10:51:47.775196Z] Finished create-virtualenv step (success) 03:51:47 INFO - [mozharness: 2016-07-30 10:51:47.775626Z] Running install step. 03:51:47 INFO - Running pre-action listener: _resource_record_pre_action 03:51:47 INFO - Running main action method: install 03:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:47 INFO - Reading from file tmpfile_stdout 03:51:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:48 INFO - Reading from file tmpfile_stdout 03:51:48 INFO - Output received: 03:51:48 INFO - Usage: mozinstall [options] installer 03:51:48 INFO - Options: 03:51:48 INFO - -h, --help show this help message and exit 03:51:48 INFO - -d DEST, --destination=DEST 03:51:48 INFO - Directory to install application into. [default: 03:51:48 INFO - "/builds/slave/test"] 03:51:48 INFO - --app=APP Application being installed. [default: firefox] 03:51:48 INFO - mkdir: /builds/slave/test/build/application 03:51:48 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'] 03:51:48 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 03:52:04 INFO - Reading from file tmpfile_stdout 03:52:04 INFO - Output received: 03:52:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:04 INFO - Running post-action listener: _resource_record_post_action 03:52:04 INFO - [mozharness: 2016-07-30 10:52:04.146404Z] Finished install step (success) 03:52:04 INFO - [mozharness: 2016-07-30 10:52:04.146680Z] Running run-tests step. 03:52:04 INFO - Running pre-action listener: _resource_record_pre_action 03:52:04 INFO - Running main action method: run_tests 03:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:04 INFO - Python 2.7.3 03:52:04 INFO - Return code: 0 03:52:04 INFO - grabbing minidump binary from tooltool 03:52: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')]} 03:52:04 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 0x1f993b0>, '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 0x1f9a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:04 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 03:52:04 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 03:52:04 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 03:52:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:04 INFO - Return code: 0 03:52:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:04 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:52:04 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:52:04 INFO - Using env: {'DISPLAY': ':0', 03:52:04 INFO - 'HOME': '/home/cltbld', 03:52:04 INFO - 'LANG': 'en_US.UTF-8', 03:52:04 INFO - 'LANGUAGE': 'en_US:en', 03:52:04 INFO - 'LOGNAME': 'cltbld', 03:52:04 INFO - 'MAIL': '/var/mail/cltbld', 03:52:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:04 INFO - 'MOZ_NO_REMOTE': '1', 03:52:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:04 INFO - 'NO_EM_RESTART': '1', 03:52:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:04 INFO - 'PWD': '/builds/slave/test', 03:52:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:04 INFO - 'SHELL': '/bin/bash', 03:52:04 INFO - 'SHLVL': '1', 03:52:04 INFO - 'TERM': 'linux', 03:52:04 INFO - 'TMOUT': '86400', 03:52:04 INFO - 'USER': 'cltbld', 03:52:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088', 03:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:04 INFO - '_': '/tools/buildbot/bin/python'} 03:52:04 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:52:04 INFO - mozversion application_buildid: 20160730005025 03:52:04 INFO - mozversion application_changeset: c3565c8b1cdb575db1c80c7791984a6490598b84 03:52:04 INFO - mozversion application_display_name: Nightly 03:52:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:04 INFO - mozversion application_name: Firefox 03:52:04 INFO - mozversion application_remotingname: firefox 03:52:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:52:04 INFO - mozversion application_vendor: Mozilla 03:52:04 INFO - mozversion application_version: 50.0a1 03:52:04 INFO - mozversion platform_buildid: 20160730005025 03:52:04 INFO - mozversion platform_changeset: c3565c8b1cdb575db1c80c7791984a6490598b84 03:52:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:52:04 INFO - mozversion platform_version: 50.0a1 03:52:04 INFO - using testdate: 1469875924 03:52:04 INFO - actual date: 1469875924 03:52:04 INFO - starting webserver on 'localhost:40176' 03:52:04 INFO - SUITE-START | Running 2 tests 03:52:04 INFO - TEST-START | dromaeo_css 03:52:04 INFO - operating with platform_type : linux_ 03:52:04 INFO - Initialising browser for dromaeo_css test... 03:52:04 INFO - TEST-INFO | started process 21917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrUt22/profile http://localhost:40176/getInfo.html) 03:52:08 INFO - PROCESS | 21917 | __metrics Screen width/height:1600/1200 03:52:08 INFO - PROCESS | 21917 | colorDepth:24 03:52:08 INFO - PROCESS | 21917 | Browser inner width/height: 1024/697 03:52:08 INFO - PROCESS | 21917 | __metrics 03:52:09 INFO - PROCESS | 21917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:52:09 INFO - PROCESS | 21917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:09 INFO - PROCESS | 21917 | console.error: PushService: 03:52:09 INFO - PROCESS | 21917 | stateChangeProcessEnqueue: Error transitioning state 03:52:09 INFO - PROCESS | 21917 | UnknownError 03:52:10 INFO - TEST-INFO | 21917: exit 0 03:52:10 INFO - Browser initialized. 03:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:10 INFO - TEST-INFO | started process 21996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrUt22/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:22 INFO - PROCESS | 21996 | RSS: Main: 157573120 03:52:22 INFO - PROCESS | 21996 | 03:53:14 INFO - PROCESS | 21996 | 1469875994380 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] 03:55:26 INFO - PROCESS | 21996 | Cycle 1(1): loaded http://localhost:40176/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40176/tests/dromaeo/cssquery-ext.html) 03:55:27 INFO - PROCESS | 21996 | RSS: Main: 251957248 03:55:27 INFO - PROCESS | 21996 | 03:58:29 INFO - PROCESS | 21996 | Cycle 1(1): loaded http://localhost:40176/tests/dromaeo/cssquery-ext.html (next: http://localhost:40176/tests/dromaeo/cssquery-jquery.html) 03:58:30 INFO - PROCESS | 21996 | RSS: Main: 241598464 03:58:30 INFO - PROCESS | 21996 | 04:01:32 INFO - PROCESS | 21996 | Cycle 1(1): loaded http://localhost:40176/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40176/tests/dromaeo/cssquery-mootools.html) 04:01:33 INFO - PROCESS | 21996 | RSS: Main: 218206208 04:01:33 INFO - PROCESS | 21996 | 04:04:35 INFO - PROCESS | 21996 | Cycle 1(1): loaded http://localhost:40176/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40176/tests/dromaeo/cssquery-prototype.html) 04:04:36 INFO - PROCESS | 21996 | RSS: Main: 183881728 04:04:36 INFO - PROCESS | 21996 | 04:07:38 INFO - PROCESS | 21996 | Cycle 1(1): loaded http://localhost:40176/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40176/tests/dromaeo/cssquery-yui.html) 04:07:39 INFO - PROCESS | 21996 | RSS: Main: 185241600 04:07:39 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | Cycle 1(1): loaded http://localhost:40176/tests/dromaeo/cssquery-yui.html (next: http://localhost:40176/tests/dromaeo/cssquery-dojo.html) 04:10:42 INFO - PROCESS | 21996 | RSS: Main: 261971968 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | __start_tp_report 04:10:42 INFO - PROCESS | 21996 | _x_x_mozilla_page_load 04:10:42 INFO - PROCESS | 21996 | _x_x_mozilla_page_load_details 04:10:42 INFO - PROCESS | 21996 | |i|pagename|runs| 04:10:42 INFO - PROCESS | 21996 | |0;dojo.html;2663.5205662980657;2664.4005098852763;2690.919272421827;2696.1911426572024;2702.1083042595947;4658.627309815215;4686.086213188421;4718.386609740734;4818.686785358954;4852.466228714843;4759.190937540618;4831.975840120795;4845.903081938368;4846.127697014536;4892.975535122319;4368.650507959355;4395.1649186654595;4462.286034234523;4482.686211965164;4550.044490656966;4469.039156581334;4499.032707967786;4520.141173177102;4527.977360113195;4538.478075021382;4303.031817840992;4316.438862947828;4359.324304732771;4387.100644367897;4469.64242860572;4340.370646256307;4355.542668019875;4361.476622805284;4401.6698747594055;4438.711483753578;4356.782160891975;4370.2570563004365;4371.4098596689355;4400.09797991411;4413;4682.1103990241745;4721.409823772028;4764.6426518011285;4817.036592681443;4817.397825271841;5143.614228932807;5147.897042059138;5153.484651534854;5204.1673332266655;5206.843794686166;5158.303629010074;5164.406093299281;5179.689218646856;5219.112750832368;5233.848553318264;4713.457952335457;4755.857324280277;4788.7366194859615;4829.106615276185;4880.243562247857;5227.503387178212;5254.369475662945;5286.682799032071;5296.179092240709;5305.575553955674;5032.622553308516;5040.747962601855;5077.162268225775;5087.135187018142;5094.108531007059;5029.119904016782;5117.462666420047;5127.974405118991;5168.01807656544;5175.094358487325;5131.948680513147;5133.076046311699;5143.434222235626;5173.974130129325;5204.245384419238;5108.080545501771;5119.257707632372;5125.359330083739;5127.717975511308;5174.508421699932;4251.957480425218;4319.870403887889;4389.4513185851765;4461.776911154429;4508.639308855284;3819.732618716663;3848.8845334640005;3875.748076375027;3880.3403421418425;3943.033956680574;4485.394471746273;4490.842820501267;4491.640668746492;4495.775211239425;4537.77311134442;4985.027919555724;5027.170516864677;5132.178851383761;5169.819056333085;5213.661112027706;4447.777611119431;4498.6626003049905;4502.57225563571;4505.031418245027;4516.480604730433;4697.10754956564;4707.646926480527;4711.1519926413575;4712.2170996438645;4759.190937540627;4745.786439610295;4865.878353041202;4897.094037603055;4917.9016419672125;4959.2561115832195;5175.404828444626;5216.765245564035;5235.554977826928;5237.292965449616;5269.9736501318785;4961.0325986433745;4969;4979.377577802775;4980.302757614009;5031.295618613324;4855.417349918032;5131.538161565477;5148.3564554430695;5152.0211159881;5153.149730294609;5098;5119.206522988943;5143.048536020848;5148.073346797612;5204.193350030751;4946.950530494793;4951.5791157750555;4953.7523123844385;4956.182229932021;4997.775100120431;4823;4960.925586116139;4995;4999.750012499433;5058.2918391425965;4938.259261110862;4971.8011279549855;4983.053219888209;4988.80044798204;5056.873578160428;5096.617753668415;5101.489851014869;5102.821401250939;5110.284560161506;5161.81933632321;4737.763111844463;4954.430240522386;4954.529319714621;4956.256561515802;4957.900841983213 04:10:42 INFO - PROCESS | 21996 | |1;ext.html;556.0382276281493;588.2088590845312;590.4036922708063;594.0791772752233;602.9517638588914;38182.42726359107;39328.80335598322;39445.211095778104;39513.20973580526;42352;40563.39154912678;40867.79566102173;41010.38484422736;41036;41040.58959410405;7439.256074392544;7770.883436748453;7903.525788452711;7906.723264685737;9816.558254878548;9714.028597140301;10060.346077504975;10066.396016239012;10068.546915388788;10074.899251007506;10047.698569042941;10094.343867648617;10102.74743131424;10103.040211179963;10155;10034.899651003507;10071.5467803949;10073.395596264247;10078.092971632588;10082.747931301703;9775.071368220008;9979;9997.90002099977;9998;9999.40003599779;38728.80635596832;39078;39145;39156.60843391558;39158.60841391578;3100.534919762031;3193.8403079845916;3202.4876019836715;3353.128186671483;3607.5310209672575;28753.424931501253;28791.56812647812;28890.422191556052;29028.419431611248;30350.089497315115;2810.4379124175043;2811.240964939455;2821.3369858083333;2831.8017738758294;2846.117703511897;259128;260536;260633;261128;261340;53205.73397133067;53808.73095634575;53842.46157538453;53893;53994.730026349614;32383.838080809444;33283.83358083194;33294.667053329154;35346;35421.46867796985;14051.086679365808;14074.648133796532;14102.576922692335;14147.363368648435;14159;9884.901150988542;11446.885531144748;11753.764924701458;11780.293182409083;12141.271523708605;18152.818471815375;18163.818361816477;18180.909095454703;18243.087845607668;18289.7256541152;6652.667366631649;6759.324067593201;6809.978503224556;6844.384005439534;6929;814.3159745813545;882.3646974178581;907.0974380491454;960.5869476125333;1005.6279176704666;27988.72011279861;27989.160325190278;27995.30011749682;28659;28698.282542936595;953.5184731710442;971.718201721507;1003.4029752297372;1011.838105903052;1012.9442880641635;13912.30438478072;14400.711985760227;14431.278436078364;14851.2574371281;14912.850871491362;388640;389764;390135;390306;392853;48475.515244847804;49182.262266066034;49189.508104918496;49190;49208;1101.6639924823005;1197.4312201704295;1210.5520957245876;1243.89426898711;1251.7621651886295;26933.461330773665;29092;29314;29562.55656165202;29600.851995739882;41687;42307.7884610575;42336.15327693367;42374.576254238294;42508.14983700247;313609;316815;316866;317192;317327;24855.378615534755;25087.24389292805;25343.36641583975;25687.100951466608;26620.87033037391;41457.79271103625;41541;41795.164096717286;41833.58166418419;41936.790316048224;35428.29143417066;35439.29121417609;35513.82243088768;35856.4621530672;36372;35711;35741.28517429585;35831.28337433185;36298.27403451969;36951.630483695895;34812.303753925284;34841;34912.30175396427;35192.47211291884;35627;30862.845685771426;32247;32547;32726;32742.67257327396;24844.130455433973;24893.62659560072;25017.624735629342;25046.499070018133;25261.74738252594 04:10:42 INFO - PROCESS | 21996 | |2;jquery.html;355.179535273518;370.8182990334737;373.88409593026165;382.89470395641195;395.88123562931133;12779.552715654954;16150.434734784285;16735.66528669426;18204.544886377847;18316.542086447844;16690.24893879775;16795.83204167958;16839.831601683978;16880.155992200373;17952.640947181048;5069.087564238435;5146.974265128679;5263.710495922723;5298.072837253484;5406.756695948692;3486.773359731622;5052.267421223939;5292.973535132319;5317.707526086064;5322.733863306838;5329.227262047001;5346.010987967238;5392.892142157155;5393.164059570773;5407.972960135194;5172.172452407634;5294.68231906083;5319.893602127974;5365.7853685852715;5382.0312343778105;5158.123119069767;5163.819266325698;5169.638125331228;5174.793008279665;5175.430702622709;11244.831327530093;11317.717057073556;11542.422878856107;11607.24552904067;11621.709457263552;1778.5553611597102;1820.062667726122;2006.809353111452;2058.4030631116957;2290.1640901071155;8348.833023339499;8529.74410767678;8551.615177317035;8851.026387097414;9060.501672408014;1688.8480036796625;1689.8225686302885;1714.7427885817103;1721.1996421663862;1766.3641089207874;63580.36419635791;71231.2876871235;71480.2851971484;73028.63485682537;73413.26586734118;9998;10230.897691023143;10351.948240258751;10365.844512332322;10518.474076296154;14274.500392486214;14297.78553321701;14298.642533936527;14306.570802875722;14348.85651143496;7412.777616671508;7564.4704870658525;7672.73145439907;7722.613869306512;7811.960940195263;7188.173360063555;7335.4131669466315;7436.628168591549;7517.323440890346;7522.811929701801;4391.473023237232;4427.645788336926;4450.710703804242;4472.217361961643;4547.522510136454;1693.652801175756;1720.7935047794344;1805.1876655505075;1876.0713446843627;1887.764029496313;761.9580923049175;841.5581819544666;891.1044400377579;901.2384535067857;938.2775263047415;17249;17336.739948900777;18005.189766460542;18034;18317.7252341215;815.7675062607128;858.1418581418582;878.2183856367838;879.098923603299;891.5586784541694;9688.70933871985;10059.144972677404;10100;10178.569654089595;10243.539040743184;384233;385446;392863;393005;394130;75238.62380688061;75820;76415.61792191003;77122.60141790021;77306;878.3982971664431;878.8549889268455;892.8749975003504;896.1665650944553;898.8067565473455;14595.85404145945;14687.55937321882;16014.839851601335;16096.436624718546;17441.56396090108;38408.231835362574;38838.80580597079;39142.80428597839;39529.209415812096;40574.797126015364;49861.50138498714;50183.49816501788;51373.74313128411;52234.390047756104;54114.72942635261;7444.73943411978;7618.771436856903;7630.656620451982;7720.53676779395;8049.27556519916;10059.597616095274;11471.713207169887;11851.762964740828;11914.880851191723;12806.935965320114;10332.535035923553;10403.687889363331;10482.947585262025;10918.399488028235;11255.66233013011;10220.642277520252;10271.486425678835;10406.375617462976;10419.635312764018;10812.729681758019;10051.547680354255;10056.14522765544;10767.6231331903;10786.298890572089;10827.187960903122;7139.393151582174;7355.8161045974275;7373.594452305175;7540.283673051052;8229.95885020571;8245.876311855447;9875.506224688594;9908.950455247677;10138.898611013796;10462.163026957673 04:10:42 INFO - PROCESS | 21996 | |3;mootools.html;1387.9444822207108;1424.6367176370024;1478.881689464843;1676.6311411489469;1713.657268546291;7649.464537482379;8128.512289262641;8132.26809587137;8139.226773456519;8143.633536490857;6920.065791118198;7671.424643151758;7812.531248125117;7892.6448309826055;7998.680052797881;2068.224415844055;2094.9685754713614;2099.6955441460977;2099.88450635215;2102.55846272283;2241.697370854938;2261.898214580348;2269.8184145268337;2275.670027845961;2276.226083131735;2230.230570453199;2248.3929339078522;2249.5613355395703;2253.752087270407;2261.3555136786017;2160.459885028743;2160.8163306119;2169.425102347879;2170.3271985684487;2171.0338899189865;2141.5716856628583;2178.172294528085;2181.0839447432118;2184.530325979906;2186.5080356919725;8122;8133.674653013932;8159.510429374256;8178.754637360888;8183.6726530938695;4694.671373003891;4766.118268120409;4810.951890481086;4816.229403295491;4825.420949486049;2845.331347133422;2947.896823611163;2998.8800447982053;3001.5347621118763;3006.8947586834574;871.773338931876;907.237920147073;921.9354645174841;923.0492592629603;924.5284904698585;10754.946225268903;10757.139428845674;10804.459777011118;10830.891691083147;10843.51204195813;4160.1471698301775;4391.5827996340295;4457.754823484739;4516.977415112903;4553.5218802025975;9437.90562094384;9445.905540944503;9448.385854919408;9448.763780905394;9454.290928180413;4729.881752956204;4760.381150450488;4775.116603428377;4777.235642297216;4782.019685964369;3724.5344331958504;4196.349565817303;4343.761093139908;4349.869503914888;4381.298992161239;3742.36379815432;3756.436534519844;3858.6141385861188;3867.477890484805;3877.806109694504;1191.9284842909453;1225.4240506961714;1247.819066235391;1250.3748125937032;1252.3300034481508;809.7287408718028;828.6685325869701;830.5349004557468;836.677879016583;838.6687258532967;5164.380274367025;5282.52457278839;5291.629585928948;5322.760475778599;5347.55082971489;865.0743704236532;879.5162660536679;885.357661537838;887.8224355128871;895.6686026170358;3423.4180189367867;3597.460380942827;3614.313280476754;3675.8679965619876;3689.428138638462;9628.374155679998;10073.848892266622;10146.644867429752;10147.797044059078;10151.746206344753;9809.803803924024;9834.21326293909;10062.24533160016;10093.24300677452;10098.848517272247;7539.283768042027;7681.500702454323;7686.461947663722;7687.807804804813;7692.153863075057;5107.7996670781595;5132.897342053064;5154.561862241751;5156.303898973591;5474.178873169057;9147.817043659223;9171.77070573241;9237.815243694955;9253.306002050007;9312.301577381859;9195.402298850553;9265.166135047879;9445.480498572644;9497.47763872966;9509.857352139585;5839.620424672383;6328.968355158195;6343.492520598249;6458.257300410513;6491.513136514686;7674.501157424973;7943.205679432011;7959.641816118405;7963.641636126504;7964.362850971793;7009.193942696451;7027.15674119109;7050.964745176241;7076.7523136692025;7194.532355396883;6701.296363881917;6702.83242918931;6709.36261055199;6737.191537015589;6795.218549866631;5915.378885217162;6248.281447633581;6293.653849038347;6300;6300.401461861115;4293.3559966004095;4385.473743150842;4464.9107017860115;4466.084452687256;4571.931421028754;4416.22716024688;4460.553944605514;4538.546145385567;4549.840755573539;4581.885452863705 04:10:42 INFO - PROCESS | 21996 | |4;prototype.html;301.1447489130868;308.5741676486449;309.4646261966797;313.8368048614719;315.18681800953516;4872.269159626057;4904.5095490450985;4923.212286034235;4928.87677808055;4932.5807306379;4831.951680483194;4863.659543831933;4867.68360056597;4870.610351171907;4871.419506662609;3697.1681371691425;3768.8492460301554;3796.8291426885717;3807.619238076198;3884.610964256976;3831.9042023949346;3839.212961342932;3843.1160833008425;3855.575886652466;3862.671672907806;3830.9042273943096;3835.0220693723063;3836.6738827199583;3839.34731095713;3855.1711382052854;3547.0777597824494;3627.220147668251;3752.2683076800035;3822.4266360045935;3844.6539811416965;3394.2023624448234;3397.9320413591836;3397.9490307645406;3410.9147271318166;3419.264858055505;4742.810287588492;4763.333133361332;4778.61420188145;4779.139754844126;4780.478547277899;4312.986448184705;4324.156789426063;4380.364847097185;4425.521707843618;4431.673371479967;5088.872778180576;5096.898062038738;5097.745112744385;5105.897882042338;5115.820946266863;3737.570179429373;3743.0455233915177;3749.2126653402547;3750.2312026034597;3760;5193.169092945149;5298.947010529922;5320.840374788762;5332.92000619991;5337.5196232338885;3811.1424929390664;3835.1562656215588;3836.2135762168687;3842.500474938296;3845.576986531479;3885.669718073939;3893.8637147699696;3898.8830335089992;3899.200663863901;3901.746386484926;4379.562043795595;4389.648828093745;4393.7363758174615;4397.340398940185;4400.889977750582;4930.260460930817;5088.6946783193125;5092.541671249532;5121.2574176744165;5143.665661731976;1329.9534516291883;1350.5408161225034;1353.6548180213983;1354.3499120422055;1357.4570171931307;840.399114633028;864.9524276164872;873.4366333714719;887.9112088791198;891.3671293381642;4070.715049946475;4382.298832186899;4415.359772832985;4564.968588977939;4597.44830620321;5247.842564723064;5258.212207849349;5260.316158899319;5261.579073674096;5279.208118782213;4564.748938808331;4568.954310456919;4572.839950601713;4580.96928191161;4583.404157459576;2665.7734092602345;2764.737349951751;2804.6914839367655;2817.8309301441977;2821.3087793490727;5027.421846487628;5051.545360917535;5052.090623687698;5056.519630635084;5058.797648094035;5282.418933917266;5432.972835135799;5434.91847622286;5446.863828404243;5452.890942181134;5009;5040.2691609716385;5043.646944713835;5045.520675535819;5055.418626857959;5273.7363131842485;5284.682919024717;5296.735163241746;5317.494837990384;5321.54766844807;4996.900061998813;5179.637425380187;5233.528982391603;5245.868853278546;5249.895002100013;5014.0974624567925;5035.320231768811;5051.6716413433005;5053.166227572409;5054.2671312660195;3714.5542534895985;3726.6459686329754;3739.2334571412252;3739.9252014960093;3740.551133863954;5086.168979167571;5108.439966381426;5242.554382877498;5254.527092561688;5270.288511050959;4972.9254061188385;4989.501049894981;5005.4744251853035;5012;5035.521625445577;5047.772850221675;5056.797728090835;5079.238114282887;5093.745312734422;5096.770645320896;4842.4189097308545;5014.674046186986;5019.222020586815;5033.949660503348;5041.823536176216;4880.755962201947;4952.984638149099;5050.646454748279;5108.79564817418;5118.283440318432;4963.503649635008;4994.450610432922;4999.425066117297;4999.700017998932;5009.0983622948215 04:10:42 INFO - PROCESS | 21996 | |5;yui.html;590.8507654203098;609.6860117039726;651.8891788395972;664.1854572090353;679.4983383446748;11562.826557601642;12002.639920802369;12280;12329;12469;12086.153969222158;12236.571719989803;12253.693657658541;12255.387230638476;12256;622.5610944284268;765.3341592814246;787.0555333599704;788.9053313602376;789.0491957191599;749.4978364495801;786.6774622404815;787.3307688464788;792.3740245206309;793.2266040610416;818.1491249100928;820.2084987986592;820.6430202861744;820.6635279535392;821.2526600793279;653.2781276689285;809.8420807942454;816.8162163513222;817.0195765081896;818.2799136759643;569.5301376364474;593.1399470767361;594.8423667728056;594.925634295713;595.4581330988823;11787.58743443984;11796.764064718744;11799.528018879235;11812.645620631394;11815.172937894351;10693.358398496115;10711;11031.503582338813;11118.777624447546;11196.10431165513;10830.025297723243;11136.498857551429;11155.107591392669;11356.48895799691;11405.885941140565;3929.2730844793805;3971.62269584389;3999.1601763629674;4068.7151899367054;4127.525334586501;60024.39975600232;60049;60052.39947600512;60302.39697603012;60366.396336036516;9113.270938324918;9225.815483690289;9261.305402094735;9459;9506.287028472892;16840.24218910152;16844.494665160066;17331.913340433217;18021.27914883416;18036.819631803777;6671.499637527205;6677.399034086859;6802.965985170043;6853.074834897325;7078.327558881898;3371.106656735967;3416.2313479467416;3445.9483107753404;3453.637368076366;3598.442241452579;2782.596523504081;2849.5868099125923;2855.2576330153893;2879.0930856780046;2881.7838662100007;487.6464563191658;490.4286506220285;490.977905994224;501.78924851561703;510.18879980830656;531.5442654934228;554.5591254952323;569.6012791046285;574.9712514374264;580.6603137164806;7491.775246742606;7583.544987300779;7698.807529811799;7716.30553250199;7725.49784264021;493.9506049395032;527.5436747213632;555.339146415772;574.5260160367714;600.2886579403421;3527.664871837171;3708.9814550927613;3762.285165818486;3832.7125465590193;3935.460438920772;90328.5483572591;91560.08439915515;92682;97072;97155;83396.58301708574;85629.57185214158;85815;85824.57087714522;86273;71535;71970.64014679893;72009.63995179991;72088;72422;7031.718731250898;7262.455315851226;7287.380572651172;7414.925850741639;7504.737334193277;31203.37593248168;38767.80616096901;43505.12989740124;44817.32774008458;45755.77122114368;63112.79105231295;63128;63582.68208658927;63952.36047639464;64258.357416425235;10829.458527073772;10845.728856778644;11058.557657693602;11345.489452974802;11397.658070257905;11408.771824563628;11606.187566870238;11698.122640801803;11741.368110728095;12158.574449894211;11305.830412543653;11341.943290283825;11607.361595112012;11610.303381797119;11853.762924741284;10908.61819836302;10922.672319830417;11160.944195278971;11706;12077.27536347822;10348.275620706478;10429.80856428193;10601.893981060091;10649.414282214553;10656.413897235727;8832.072632373509;8937.59780809878;9175.587098580714;9347.205487533636;9695;9006.909930900869;9276.397034192756;9377.718668439958;9583.185429238314;9919.752006199902 04:10:42 INFO - PROCESS | 21996 | __end_tp_report 04:10:42 INFO - PROCESS | 21996 | __start_cc_report 04:10:42 INFO - PROCESS | 21996 | _x_x_mozilla_cycle_collect,1008 04:10:42 INFO - PROCESS | 21996 | __end_cc_report 04:10:42 INFO - PROCESS | 21996 | __startTimestamp1469877042782__endTimestamp 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | ------- Summary: start ------- 04:10:42 INFO - PROCESS | 21996 | Number of tests: 6 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | [#0] dojo.html Cycles:165 Average:4768.64 Median:4938.26 stddev:498.46 (10.1%) stddev-sans-first:471.84 04:10:42 INFO - PROCESS | 21996 | Values: 2663.5 2664.4 2690.9 2696.2 2702.1 4658.6 4686.1 4718.4 4818.7 4852.5 4759.2 4832.0 4845.9 4846.1 4893.0 4368.7 4395.2 4462.3 4482.7 4550.0 4469.0 4499.0 4520.1 4528.0 4538.5 4303.0 4316.4 4359.3 4387.1 4469.6 4340.4 4355.5 4361.5 4401.7 4438.7 4356.8 4370.3 4371.4 4400.1 4413.0 4682.1 4721.4 4764.6 4817.0 4817.4 5143.6 5147.9 5153.5 5204.2 5206.8 5158.3 5164.4 5179.7 5219.1 5233.8 4713.5 4755.9 4788.7 4829.1 4880.2 5227.5 5254.4 5286.7 5296.2 5305.6 5032.6 5040.7 5077.2 5087.1 5094.1 5029.1 5117.5 5128.0 5168.0 5175.1 5131.9 5133.1 5143.4 5174.0 5204.2 5108.1 5119.3 5125.4 5127.7 5174.5 4252.0 4319.9 4389.5 4461.8 4508.6 3819.7 3848.9 3875.7 3880.3 3943.0 4485.4 4490.8 4491.6 4495.8 4537.8 4985.0 5027.2 5132.2 5169.8 5213.7 4447.8 4498.7 4502.6 4505.0 4516.5 4697.1 4707.6 4711.2 4712.2 4759.2 4745.8 4865.9 4897.1 4917.9 4959.3 5175.4 5216.8 5235.6 5237.3 5270.0 4961.0 4969.0 4979.4 4980.3 5031.3 4855.4 5131.5 5148.4 5152.0 5153.1 5098.0 5119.2 5143.0 5148.1 5204.2 4947.0 4951.6 4953.8 4956.2 4997.8 4823.0 4960.9 4995.0 4999.8 5058.3 4938.3 4971.8 4983.1 4988.8 5056.9 5096.6 5101.5 5102.8 5110.3 5161.8 4737.8 4954.4 4954.5 4956.3 4957.9 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | [#1] ext.html Cycles:180 Average:47410.36 Median:33013.25 stddev:85906.44 (260.2%) stddev-sans-first:86075.40 04:10:42 INFO - PROCESS | 21996 | Values: 556.0 588.2 590.4 594.1 603.0 38182.4 39328.8 39445.2 39513.2 42352.0 40563.4 40867.8 41010.4 41036.0 41040.6 7439.3 7770.9 7903.5 7906.7 9816.6 9714.0 10060.3 10066.4 10068.5 10074.9 10047.7 10094.3 10102.7 10103.0 10155.0 10034.9 10071.5 10073.4 10078.1 10082.7 9775.1 9979.0 9997.9 9998.0 9999.4 38728.8 39078.0 39145.0 39156.6 39158.6 3100.5 3193.8 3202.5 3353.1 3607.5 28753.4 28791.6 28890.4 29028.4 30350.1 2810.4 2811.2 2821.3 2831.8 2846.1 259128.0 260536.0 260633.0 261128.0 261340.0 53205.7 53808.7 53842.5 53893.0 53994.7 32383.8 33283.8 33294.7 35346.0 35421.5 14051.1 14074.6 14102.6 14147.4 14159.0 9884.9 11446.9 11753.8 11780.3 12141.3 18152.8 18163.8 18180.9 18243.1 18289.7 6652.7 6759.3 6810.0 6844.4 6929.0 814.3 882.4 907.1 960.6 1005.6 27988.7 27989.2 27995.3 28659.0 28698.3 953.5 971.7 1003.4 1011.8 1012.9 13912.3 14400.7 14431.3 14851.3 14912.9 388640.0 389764.0 390135.0 390306.0 392853.0 48475.5 49182.3 49189.5 49190.0 49208.0 1101.7 1197.4 1210.6 1243.9 1251.8 26933.5 29092.0 29314.0 29562.6 29600.9 41687.0 42307.8 42336.2 42374.6 42508.1 313609.0 316815.0 316866.0 317192.0 317327.0 24855.4 25087.2 25343.4 25687.1 26620.9 41457.8 41541.0 41795.2 41833.6 41936.8 35428.3 35439.3 35513.8 35856.5 36372.0 35711.0 35741.3 35831.3 36298.3 36951.6 34812.3 34841.0 34912.3 35192.5 35627.0 30862.8 32247.0 32547.0 32726.0 32742.7 24844.1 24893.6 25017.6 25046.5 25261.7 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | [#2] jquery.html Cycles:180 Average:24213.14 Median:22483.14 stddev:64449.01 (286.7%) stddev-sans-first:64604.91 04:10:42 INFO - PROCESS | 21996 | Values: 355.2 370.8 373.9 382.9 395.9 12779.6 16150.4 16735.7 18204.5 18316.5 16690.2 16795.8 16839.8 16880.2 17952.6 5069.1 5147.0 5263.7 5298.1 5406.8 3486.8 5052.3 5293.0 5317.7 5322.7 5329.2 5346.0 5392.9 5393.2 5408.0 5172.2 5294.7 5319.9 5365.8 5382.0 5158.1 5163.8 5169.6 5174.8 5175.4 11244.8 11317.7 11542.4 11607.2 11621.7 1778.6 1820.1 2006.8 2058.4 2290.2 8348.8 8529.7 8551.6 8851.0 9060.5 1688.8 1689.8 1714.7 1721.2 1766.4 63580.4 71231.3 71480.3 73028.6 73413.3 9998.0 10230.9 10351.9 10365.8 10518.5 14274.5 14297.8 14298.6 14306.6 14348.9 7412.8 7564.5 7672.7 7722.6 7812.0 7188.2 7335.4 7436.6 7517.3 7522.8 4391.5 4427.6 4450.7 4472.2 4547.5 1693.7 1720.8 1805.2 1876.1 1887.8 762.0 841.6 891.1 901.2 938.3 17249.0 17336.7 18005.2 18034.0 18317.7 815.8 858.1 878.2 879.1 891.6 9688.7 10059.1 10100.0 10178.6 10243.5 384233.0 385446.0 392863.0 393005.0 394130.0 75238.6 75820.0 76415.6 77122.6 77306.0 878.4 878.9 892.9 896.2 898.8 14595.9 14687.6 16014.8 16096.4 17441.6 38408.2 38838.8 39142.8 39529.2 40574.8 49861.5 50183.5 51373.7 52234.4 54114.7 7444.7 7618.8 7630.7 7720.5 8049.3 10059.6 11471.7 11851.8 11914.9 12806.9 10332.5 10403.7 10482.9 10918.4 11255.7 10220.6 10271.5 10406.4 10419.6 10812.7 10051.5 10056.1 10767.6 10786.3 10827.2 7139.4 7355.8 7373.6 7540.3 8230.0 8245.9 9875.5 9909.0 10138.9 10462.2 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | [#3] mootools.html Cycles:180 Average:5247.04 Median:4820.83 stddev:2976.07 (61.7%) stddev-sans-first:2970.29 04:10:42 INFO - PROCESS | 21996 | Values: 1387.9 1424.6 1478.9 1676.6 1713.7 7649.5 8128.5 8132.3 8139.2 8143.6 6920.1 7671.4 7812.5 7892.6 7998.7 2068.2 2095.0 2099.7 2099.9 2102.6 2241.7 2261.9 2269.8 2275.7 2276.2 2230.2 2248.4 2249.6 2253.8 2261.4 2160.5 2160.8 2169.4 2170.3 2171.0 2141.6 2178.2 2181.1 2184.5 2186.5 8122.0 8133.7 8159.5 8178.8 8183.7 4694.7 4766.1 4811.0 4816.2 4825.4 2845.3 2947.9 2998.9 3001.5 3006.9 871.8 907.2 921.9 923.0 924.5 10754.9 10757.1 10804.5 10830.9 10843.5 4160.1 4391.6 4457.8 4517.0 4553.5 9437.9 9445.9 9448.4 9448.8 9454.3 4729.9 4760.4 4775.1 4777.2 4782.0 3724.5 4196.3 4343.8 4349.9 4381.3 3742.4 3756.4 3858.6 3867.5 3877.8 1191.9 1225.4 1247.8 1250.4 1252.3 809.7 828.7 830.5 836.7 838.7 5164.4 5282.5 5291.6 5322.8 5347.6 865.1 879.5 885.4 887.8 895.7 3423.4 3597.5 3614.3 3675.9 3689.4 9628.4 10073.8 10146.6 10147.8 10151.7 9809.8 9834.2 10062.2 10093.2 10098.8 7539.3 7681.5 7686.5 7687.8 7692.2 5107.8 5132.9 5154.6 5156.3 5474.2 9147.8 9171.8 9237.8 9253.3 9312.3 9195.4 9265.2 9445.5 9497.5 9509.9 5839.6 6329.0 6343.5 6458.3 6491.5 7674.5 7943.2 7959.6 7963.6 7964.4 7009.2 7027.2 7051.0 7076.8 7194.5 6701.3 6702.8 6709.4 6737.2 6795.2 5915.4 6248.3 6293.7 6300.0 6300.4 4293.4 4385.5 4464.9 4466.1 4571.9 4416.2 4460.6 4538.5 4549.8 4581.9 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | [#4] prototype.html Cycles:180 Average:4262.10 Median:4871.84 stddev:1225.79 (25.2%) stddev-sans-first:1192.63 04:10:42 INFO - PROCESS | 21996 | Values: 301.1 308.6 309.5 313.8 315.2 4872.3 4904.5 4923.2 4928.9 4932.6 4832.0 4863.7 4867.7 4870.6 4871.4 3697.2 3768.8 3796.8 3807.6 3884.6 3831.9 3839.2 3843.1 3855.6 3862.7 3830.9 3835.0 3836.7 3839.3 3855.2 3547.1 3627.2 3752.3 3822.4 3844.7 3394.2 3397.9 3397.9 3410.9 3419.3 4742.8 4763.3 4778.6 4779.1 4780.5 4313.0 4324.2 4380.4 4425.5 4431.7 5088.9 5096.9 5097.7 5105.9 5115.8 3737.6 3743.0 3749.2 3750.2 3760.0 5193.2 5298.9 5320.8 5332.9 5337.5 3811.1 3835.2 3836.2 3842.5 3845.6 3885.7 3893.9 3898.9 3899.2 3901.7 4379.6 4389.6 4393.7 4397.3 4400.9 4930.3 5088.7 5092.5 5121.3 5143.7 1330.0 1350.5 1353.7 1354.3 1357.5 840.4 865.0 873.4 887.9 891.4 4070.7 4382.3 4415.4 4565.0 4597.4 5247.8 5258.2 5260.3 5261.6 5279.2 4564.7 4569.0 4572.8 4581.0 4583.4 2665.8 2764.7 2804.7 2817.8 2821.3 5027.4 5051.5 5052.1 5056.5 5058.8 5282.4 5433.0 5434.9 5446.9 5452.9 5009.0 5040.3 5043.6 5045.5 5055.4 5273.7 5284.7 5296.7 5317.5 5321.5 4996.9 5179.6 5233.5 5245.9 5249.9 5014.1 5035.3 5051.7 5053.2 5054.3 3714.6 3726.6 3739.2 3739.9 3740.6 5086.2 5108.4 5242.6 5254.5 5270.3 4972.9 4989.5 5005.5 5012.0 5035.5 5047.8 5056.8 5079.2 5093.7 5096.8 4842.4 5014.7 5019.2 5033.9 5041.8 4880.8 4953.0 5050.6 5108.8 5118.3 4963.5 4994.5 4999.4 4999.7 5009.1 04:10:42 INFO - PROCESS | 21996 | 04:10:42 INFO - PROCESS | 21996 | [#5] yui.html Cycles:180 Average:17150.80 Median:569.57 stddev:24866.94 (4365.9%) stddev-sans-first:24905.61 04:10:42 INFO - PROCESS | 21996 | Values: 590.9 609.7 651.9 664.2 679.5 11562.8 12002.6 12280.0 12329.0 12469.0 12086.2 12236.6 12253.7 12255.4 12256.0 622.6 765.3 787.1 788.9 789.0 749.5 786.7 787.3 792.4 793.2 818.1 820.2 820.6 820.7 821.3 653.3 809.8 816.8 817.0 818.3 569.5 593.1 594.8 594.9 595.5 11787.6 11796.8 11799.5 11812.6 11815.2 10693.4 10711.0 11031.5 11118.8 11196.1 10830.0 11136.5 11155.1 11356.5 11405.9 3929.3 3971.6 3999.2 4068.7 4127.5 60024.4 60049.0 60052.4 60302.4 60366.4 9113.3 9225.8 9261.3 9459.0 9506.3 16840.2 16844.5 17331.9 18021.3 18036.8 6671.5 6677.4 6803.0 6853.1 7078.3 3371.1 3416.2 3445.9 3453.6 3598.4 2782.6 2849.6 2855.3 2879.1 2881.8 487.6 490.4 491.0 501.8 510.2 531.5 554.6 569.6 575.0 580.7 7491.8 7583.5 7698.8 7716.3 7725.5 494.0 527.5 555.3 574.5 600.3 3527.7 3709.0 3762.3 3832.7 3935.5 90328.5 91560.1 92682.0 97072.0 97155.0 83396.6 85629.6 85815.0 85824.6 86273.0 71535.0 71970.6 72009.6 72088.0 72422.0 7031.7 7262.5 7287.4 7414.9 7504.7 31203.4 38767.8 43505.1 44817.3 45755.8 63112.8 63128.0 63582.7 63952.4 64258.4 10829.5 10845.7 11058.6 11345.5 11397.7 11408.8 11606.2 11698.1 11741.4 12158.6 11305.8 11341.9 11607.4 11610.3 11853.8 10908.6 10922.7 11160.9 11706.0 12077.3 10348.3 10429.8 10601.9 10649.4 10656.4 8832.1 8937.6 9175.6 9347.2 9695.0 9006.9 9276.4 9377.7 9583.2 9919.8 04:10:42 INFO - PROCESS | 21996 | -------- Summary: end -------- 04:10:42 INFO - PROCESS | 21996 | 04:10:43 INFO - TEST-INFO | 21996: exit 0 04:10:43 INFO - TEST-OK | dromaeo_css | took 1119052ms 04:10:43 INFO - TEST-START | kraken 04:10:43 INFO - operating with platform_type : linux_ 04:10:43 INFO - Initialising browser for kraken test... 04:10:43 INFO - TEST-INFO | started process 22187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE9CdfL/profile http://localhost:40176/getInfo.html) 04:10:47 INFO - PROCESS | 22187 | __metrics Screen width/height:1600/1200 04:10:47 INFO - PROCESS | 22187 | colorDepth:24 04:10:47 INFO - PROCESS | 22187 | Browser inner width/height: 1024/697 04:10:47 INFO - PROCESS | 22187 | __metrics 04:10:48 INFO - PROCESS | 22187 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:10:48 INFO - PROCESS | 22187 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:49 INFO - TEST-INFO | 22187: exit 0 04:10:49 INFO - Browser initialized. 04:10:49 INFO - Running cycle 1/1 for kraken test... 04:10:49 INFO - TEST-INFO | started process 22267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE9CdfL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:01 INFO - PROCESS | 22267 | RSS: Main: 157245440 04:11:01 INFO - PROCESS | 22267 | 04:11:04 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40176/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:04 INFO - PROCESS | 22267 | RSS: Main: 213639168 04:11:04 INFO - PROCESS | 22267 | 04:11:07 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40176/tests/kraken/driver.html?testName=audio-dft) 04:11:08 INFO - PROCESS | 22267 | RSS: Main: 190345216 04:11:08 INFO - PROCESS | 22267 | 04:11:11 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40176/tests/kraken/driver.html?testName=audio-fft) 04:11:12 INFO - PROCESS | 22267 | RSS: Main: 270237696 04:11:12 INFO - PROCESS | 22267 | 04:11:14 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40176/tests/kraken/driver.html?testName=audio-oscillator) 04:11:14 INFO - PROCESS | 22267 | RSS: Main: 180125696 04:11:14 INFO - PROCESS | 22267 | 04:11:17 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40176/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:11:17 INFO - PROCESS | 22267 | RSS: Main: 185282560 04:11:17 INFO - PROCESS | 22267 | 04:11:20 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40176/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:21 INFO - PROCESS | 22267 | RSS: Main: 221253632 04:11:21 INFO - PROCESS | 22267 | 04:11:25 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40176/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:25 INFO - PROCESS | 22267 | RSS: Main: 220925952 04:11:25 INFO - PROCESS | 22267 | 04:11:28 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40176/tests/kraken/driver.html?testName=json-parse-financial) 04:11:29 INFO - PROCESS | 22267 | RSS: Main: 220258304 04:11:29 INFO - PROCESS | 22267 | 04:11:30 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40176/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:31 INFO - PROCESS | 22267 | RSS: Main: 184131584 04:11:31 INFO - PROCESS | 22267 | 04:11:33 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:33 INFO - PROCESS | 22267 | RSS: Main: 190038016 04:11:33 INFO - PROCESS | 22267 | 04:11:36 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:36 INFO - PROCESS | 22267 | RSS: Main: 195018752 04:11:36 INFO - PROCESS | 22267 | 04:11:39 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:40 INFO - PROCESS | 22267 | RSS: Main: 188215296 04:11:40 INFO - PROCESS | 22267 | 04:11:43 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:43 INFO - PROCESS | 22267 | RSS: Main: 193445888 04:11:43 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | Cycle 1(1): loaded http://localhost:40176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40176/tests/kraken/driver.html?testName=ai-astar) 04:11:45 INFO - PROCESS | 22267 | RSS: Main: 245088256 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | __start_tp_report 04:11:45 INFO - PROCESS | 22267 | _x_x_mozilla_page_load 04:11:45 INFO - PROCESS | 22267 | _x_x_mozilla_page_load_details 04:11:45 INFO - PROCESS | 22267 | |i|pagename|runs| 04:11:45 INFO - PROCESS | 22267 | |0;ai-astar;106;114;115;113;113;113;114;114;113;113 04:11:45 INFO - PROCESS | 22267 | |1;audio-beat-detection;152;123;121;194;119;126;144;122;185;124 04:11:45 INFO - PROCESS | 22267 | |2;audio-dft;161;161;161;162;163;161;162;163;161;163 04:11:45 INFO - PROCESS | 22267 | |3;audio-fft;77;76;75;135;75;76;74;74;110;75 04:11:45 INFO - PROCESS | 22267 | |4;audio-oscillator;84;85;112;84;86;85;125;86;86;130 04:11:45 INFO - PROCESS | 22267 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;117;117 04:11:45 INFO - PROCESS | 22267 | |6;imaging-darkroom;147;147;146;146;147;147;146;146;146;146 04:11:45 INFO - PROCESS | 22267 | |7;imaging-desaturate;95;95;95;95;95;94;95;96;94;95 04:11:45 INFO - PROCESS | 22267 | |8;json-parse-financial;62;62;62;61;63;61;63;61;62;63 04:11:45 INFO - PROCESS | 22267 | |9;json-stringify-tinderbox;64;65;64;65;65;65;65;66;66;66 04:11:45 INFO - PROCESS | 22267 | |10;stanford-crypto-aes;80;78;78;80;79;79;79;79;80;82 04:11:45 INFO - PROCESS | 22267 | |11;stanford-crypto-ccm;131;129;128;129;125;127;127;136;212;140 04:11:45 INFO - PROCESS | 22267 | |12;stanford-crypto-pbkdf2;169;165;168;170;172;163;165;164;162;164 04:11:45 INFO - PROCESS | 22267 | |13;stanford-crypto-sha256-iterative;67;66;65;66;66;66;66;74;66;65 04:11:45 INFO - PROCESS | 22267 | __end_tp_report 04:11:45 INFO - PROCESS | 22267 | __start_cc_report 04:11:45 INFO - PROCESS | 22267 | _x_x_mozilla_cycle_collect,1926 04:11:45 INFO - PROCESS | 22267 | __end_cc_report 04:11:45 INFO - PROCESS | 22267 | __startTimestamp1469877105674__endTimestamp 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | ------- Summary: start ------- 04:11:45 INFO - PROCESS | 22267 | Number of tests: 14 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.50 stddev:2.49 (2.2%) stddev-sans-first:0.73 04:11:45 INFO - PROCESS | 22267 | Values: 106.0 114.0 115.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:135.00 stddev:27.80 (20.6%) stddev-sans-first:29.21 04:11:45 INFO - PROCESS | 22267 | Values: 152.0 123.0 121.0 194.0 119.0 126.0 144.0 122.0 185.0 124.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 04:11:45 INFO - PROCESS | 22267 | Values: 161.0 161.0 161.0 162.0 163.0 161.0 162.0 163.0 161.0 163.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#3] audio-fft Cycles:10 Average:84.70 Median:75.00 stddev:20.80 (27.7%) stddev-sans-first:21.87 04:11:45 INFO - PROCESS | 22267 | Values: 77.0 76.0 75.0 135.0 75.0 76.0 74.0 74.0 110.0 75.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.51 (21.8%) stddev-sans-first:19.09 04:11:45 INFO - PROCESS | 22267 | Values: 84.0 85.0 112.0 84.0 86.0 85.0 125.0 86.0 86.0 130.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:11:45 INFO - PROCESS | 22267 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:11:45 INFO - PROCESS | 22267 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:11:45 INFO - PROCESS | 22267 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 94.0 95.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 04:11:45 INFO - PROCESS | 22267 | Values: 62.0 62.0 62.0 61.0 63.0 61.0 63.0 61.0 62.0 63.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 04:11:45 INFO - PROCESS | 22267 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 65.0 66.0 66.0 66.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:1.17 (1.5%) stddev-sans-first:1.22 04:11:45 INFO - PROCESS | 22267 | Values: 80.0 78.0 78.0 80.0 79.0 79.0 79.0 79.0 80.0 82.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:130.00 stddev:26.26 (20.2%) stddev-sans-first:27.71 04:11:45 INFO - PROCESS | 22267 | Values: 131.0 129.0 128.0 129.0 125.0 127.0 127.0 136.0 212.0 140.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:3.33 (2.0%) stddev-sans-first:3.37 04:11:45 INFO - PROCESS | 22267 | Values: 169.0 165.0 168.0 170.0 172.0 163.0 165.0 164.0 162.0 164.0 04:11:45 INFO - PROCESS | 22267 | 04:11:45 INFO - PROCESS | 22267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:2.63 (4.0%) stddev-sans-first:2.78 04:11:45 INFO - PROCESS | 22267 | Values: 67.0 66.0 65.0 66.0 66.0 66.0 66.0 74.0 66.0 65.0 04:11:45 INFO - PROCESS | 22267 | -------- Summary: end -------- 04:11:45 INFO - PROCESS | 22267 | 04:11:46 INFO - TEST-INFO | 22267: exit 0 04:11:46 INFO - TEST-OK | kraken | took 63311ms 04:11:46 INFO - SUITE-END | took 1182s 04:11:46 INFO - Completed test suite (00:19:42) 04:11:46 INFO - javascript benchmark 04:11:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.5205662980657, 2664.4005098852763, 2690.919272421827, 2696.1911426572024, 2702.1083042595947, 4658.627309815215, 4686.086213188421, 4718.386609740734, 4818.686785358954, 4852.466228714843, 4759.190937540618, 4831.975840120795, 4845.903081938368, 4846.127697014536, 4892.975535122319, 4368.650507959355, 4395.1649186654595, 4462.286034234523, 4482.686211965164, 4550.044490656966, 4469.039156581334, 4499.032707967786, 4520.141173177102, 4527.977360113195, 4538.478075021382, 4303.031817840992, 4316.438862947828, 4359.324304732771, 4387.100644367897, 4469.64242860572, 4340.370646256307, 4355.542668019875, 4361.476622805284, 4401.6698747594055, 4438.711483753578, 4356.782160891975, 4370.2570563004365, 4371.4098596689355, 4400.09797991411, 4413.0, 4682.1103990241745, 4721.409823772028, 4764.6426518011285, 4817.036592681443, 4817.397825271841, 5143.614228932807, 5147.897042059138, 5153.484651534854, 5204.1673332266655, 5206.843794686166, 5158.303629010074, 5164.406093299281, 5179.689218646856, 5219.112750832368, 5233.848553318264, 4713.457952335457, 4755.857324280277, 4788.7366194859615, 4829.106615276185, 4880.243562247857, 5227.503387178212, 5254.369475662945, 5286.682799032071, 5296.179092240709, 5305.575553955674, 5032.622553308516, 5040.747962601855, 5077.162268225775, 5087.135187018142, 5094.108531007059, 5029.119904016782, 5117.462666420047, 5127.974405118991, 5168.01807656544, 5175.094358487325, 5131.948680513147, 5133.076046311699, 5143.434222235626, 5173.974130129325, 5204.245384419238, 5108.080545501771, 5119.257707632372, 5125.359330083739, 5127.717975511308, 5174.508421699932, 4251.957480425218, 4319.870403887889, 4389.4513185851765, 4461.776911154429, 4508.639308855284, 3819.732618716663, 3848.8845334640005, 3875.748076375027, 3880.3403421418425, 3943.033956680574, 4485.394471746273, 4490.842820501267, 4491.640668746492, 4495.775211239425, 4537.77311134442, 4985.027919555724, 5027.170516864677, 5132.178851383761, 5169.819056333085, 5213.661112027706, 4447.777611119431, 4498.6626003049905, 4502.57225563571, 4505.031418245027, 4516.480604730433, 4697.10754956564, 4707.646926480527, 4711.1519926413575, 4712.2170996438645, 4759.190937540627, 4745.786439610295, 4865.878353041202, 4897.094037603055, 4917.9016419672125, 4959.2561115832195, 5175.404828444626, 5216.765245564035, 5235.554977826928, 5237.292965449616, 5269.9736501318785, 4961.0325986433745, 4969.0, 4979.377577802775, 4980.302757614009, 5031.295618613324, 4855.417349918032, 5131.538161565477, 5148.3564554430695, 5152.0211159881, 5153.149730294609, 5098.0, 5119.206522988943, 5143.048536020848, 5148.073346797612, 5204.193350030751, 4946.950530494793, 4951.5791157750555, 4953.7523123844385, 4956.182229932021, 4997.775100120431, 4823.0, 4960.925586116139, 4995.0, 4999.750012499433, 5058.2918391425965, 4938.259261110862, 4971.8011279549855, 4983.053219888209, 4988.80044798204, 5056.873578160428, 5096.617753668415, 5101.489851014869, 5102.821401250939, 5110.284560161506, 5161.81933632321, 4737.763111844463, 4954.430240522386, 4954.529319714621, 4956.256561515802, 4957.900841983213], "value": 4736.850874548192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.0382276281493, 588.2088590845312, 590.4036922708063, 594.0791772752233, 602.9517638588914, 38182.42726359107, 39328.80335598322, 39445.211095778104, 39513.20973580526, 42352.0, 40563.39154912678, 40867.79566102173, 41010.38484422736, 41036.0, 41040.58959410405, 7439.256074392544, 7770.883436748453, 7903.525788452711, 7906.723264685737, 9816.558254878548, 9714.028597140301, 10060.346077504975, 10066.396016239012, 10068.546915388788, 10074.899251007506, 10047.698569042941, 10094.343867648617, 10102.74743131424, 10103.040211179963, 10155.0, 10034.899651003507, 10071.5467803949, 10073.395596264247, 10078.092971632588, 10082.747931301703, 9775.071368220008, 9979.0, 9997.90002099977, 9998.0, 9999.40003599779, 38728.80635596832, 39078.0, 39145.0, 39156.60843391558, 39158.60841391578, 3100.534919762031, 3193.8403079845916, 3202.4876019836715, 3353.128186671483, 3607.5310209672575, 28753.424931501253, 28791.56812647812, 28890.422191556052, 29028.419431611248, 30350.089497315115, 2810.4379124175043, 2811.240964939455, 2821.3369858083333, 2831.8017738758294, 2846.117703511897, 259128.0, 260536.0, 260633.0, 261128.0, 261340.0, 53205.73397133067, 53808.73095634575, 53842.46157538453, 53893.0, 53994.730026349614, 32383.838080809444, 33283.83358083194, 33294.667053329154, 35346.0, 35421.46867796985, 14051.086679365808, 14074.648133796532, 14102.576922692335, 14147.363368648435, 14159.0, 9884.901150988542, 11446.885531144748, 11753.764924701458, 11780.293182409083, 12141.271523708605, 18152.818471815375, 18163.818361816477, 18180.909095454703, 18243.087845607668, 18289.7256541152, 6652.667366631649, 6759.324067593201, 6809.978503224556, 6844.384005439534, 6929.0, 814.3159745813545, 882.3646974178581, 907.0974380491454, 960.5869476125333, 1005.6279176704666, 27988.72011279861, 27989.160325190278, 27995.30011749682, 28659.0, 28698.282542936595, 953.5184731710442, 971.718201721507, 1003.4029752297372, 1011.838105903052, 1012.9442880641635, 13912.30438478072, 14400.711985760227, 14431.278436078364, 14851.2574371281, 14912.850871491362, 388640.0, 389764.0, 390135.0, 390306.0, 392853.0, 48475.515244847804, 49182.262266066034, 49189.508104918496, 49190.0, 49208.0, 1101.6639924823005, 1197.4312201704295, 1210.5520957245876, 1243.89426898711, 1251.7621651886295, 26933.461330773665, 29092.0, 29314.0, 29562.55656165202, 29600.851995739882, 41687.0, 42307.7884610575, 42336.15327693367, 42374.576254238294, 42508.14983700247, 313609.0, 316815.0, 316866.0, 317192.0, 317327.0, 24855.378615534755, 25087.24389292805, 25343.36641583975, 25687.100951466608, 26620.87033037391, 41457.79271103625, 41541.0, 41795.164096717286, 41833.58166418419, 41936.790316048224, 35428.29143417066, 35439.29121417609, 35513.82243088768, 35856.4621530672, 36372.0, 35711.0, 35741.28517429585, 35831.28337433185, 36298.27403451969, 36951.630483695895, 34812.303753925284, 34841.0, 34912.30175396427, 35192.47211291884, 35627.0, 30862.845685771426, 32247.0, 32547.0, 32726.0, 32742.67257327396, 24844.130455433973, 24893.62659560072, 25017.624735629342, 25046.499070018133, 25261.74738252594], "value": 17790.162127762425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.179535273518, 370.8182990334737, 373.88409593026165, 382.89470395641195, 395.88123562931133, 12779.552715654954, 16150.434734784285, 16735.66528669426, 18204.544886377847, 18316.542086447844, 16690.24893879775, 16795.83204167958, 16839.831601683978, 16880.155992200373, 17952.640947181048, 5069.087564238435, 5146.974265128679, 5263.710495922723, 5298.072837253484, 5406.756695948692, 3486.773359731622, 5052.267421223939, 5292.973535132319, 5317.707526086064, 5322.733863306838, 5329.227262047001, 5346.010987967238, 5392.892142157155, 5393.164059570773, 5407.972960135194, 5172.172452407634, 5294.68231906083, 5319.893602127974, 5365.7853685852715, 5382.0312343778105, 5158.123119069767, 5163.819266325698, 5169.638125331228, 5174.793008279665, 5175.430702622709, 11244.831327530093, 11317.717057073556, 11542.422878856107, 11607.24552904067, 11621.709457263552, 1778.5553611597102, 1820.062667726122, 2006.809353111452, 2058.4030631116957, 2290.1640901071155, 8348.833023339499, 8529.74410767678, 8551.615177317035, 8851.026387097414, 9060.501672408014, 1688.8480036796625, 1689.8225686302885, 1714.7427885817103, 1721.1996421663862, 1766.3641089207874, 63580.36419635791, 71231.2876871235, 71480.2851971484, 73028.63485682537, 73413.26586734118, 9998.0, 10230.897691023143, 10351.948240258751, 10365.844512332322, 10518.474076296154, 14274.500392486214, 14297.78553321701, 14298.642533936527, 14306.570802875722, 14348.85651143496, 7412.777616671508, 7564.4704870658525, 7672.73145439907, 7722.613869306512, 7811.960940195263, 7188.173360063555, 7335.4131669466315, 7436.628168591549, 7517.323440890346, 7522.811929701801, 4391.473023237232, 4427.645788336926, 4450.710703804242, 4472.217361961643, 4547.522510136454, 1693.652801175756, 1720.7935047794344, 1805.1876655505075, 1876.0713446843627, 1887.764029496313, 761.9580923049175, 841.5581819544666, 891.1044400377579, 901.2384535067857, 938.2775263047415, 17249.0, 17336.739948900777, 18005.189766460542, 18034.0, 18317.7252341215, 815.7675062607128, 858.1418581418582, 878.2183856367838, 879.098923603299, 891.5586784541694, 9688.70933871985, 10059.144972677404, 10100.0, 10178.569654089595, 10243.539040743184, 384233.0, 385446.0, 392863.0, 393005.0, 394130.0, 75238.62380688061, 75820.0, 76415.61792191003, 77122.60141790021, 77306.0, 878.3982971664431, 878.8549889268455, 892.8749975003504, 896.1665650944553, 898.8067565473455, 14595.85404145945, 14687.55937321882, 16014.839851601335, 16096.436624718546, 17441.56396090108, 38408.231835362574, 38838.80580597079, 39142.80428597839, 39529.209415812096, 40574.797126015364, 49861.50138498714, 50183.49816501788, 51373.74313128411, 52234.390047756104, 54114.72942635261, 7444.73943411978, 7618.771436856903, 7630.656620451982, 7720.53676779395, 8049.27556519916, 10059.597616095274, 11471.713207169887, 11851.762964740828, 11914.880851191723, 12806.935965320114, 10332.535035923553, 10403.687889363331, 10482.947585262025, 10918.399488028235, 11255.66233013011, 10220.642277520252, 10271.486425678835, 10406.375617462976, 10419.635312764018, 10812.729681758019, 10051.547680354255, 10056.14522765544, 10767.6231331903, 10786.298890572089, 10827.187960903122, 7139.393151582174, 7355.8161045974275, 7373.594452305175, 7540.283673051052, 8229.95885020571, 8245.876311855447, 9875.506224688594, 9908.950455247677, 10138.898611013796, 10462.163026957673], "value": 8119.664040727869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.9444822207108, 1424.6367176370024, 1478.881689464843, 1676.6311411489469, 1713.657268546291, 7649.464537482379, 8128.512289262641, 8132.26809587137, 8139.226773456519, 8143.633536490857, 6920.065791118198, 7671.424643151758, 7812.531248125117, 7892.6448309826055, 7998.680052797881, 2068.224415844055, 2094.9685754713614, 2099.6955441460977, 2099.88450635215, 2102.55846272283, 2241.697370854938, 2261.898214580348, 2269.8184145268337, 2275.670027845961, 2276.226083131735, 2230.230570453199, 2248.3929339078522, 2249.5613355395703, 2253.752087270407, 2261.3555136786017, 2160.459885028743, 2160.8163306119, 2169.425102347879, 2170.3271985684487, 2171.0338899189865, 2141.5716856628583, 2178.172294528085, 2181.0839447432118, 2184.530325979906, 2186.5080356919725, 8122.0, 8133.674653013932, 8159.510429374256, 8178.754637360888, 8183.6726530938695, 4694.671373003891, 4766.118268120409, 4810.951890481086, 4816.229403295491, 4825.420949486049, 2845.331347133422, 2947.896823611163, 2998.8800447982053, 3001.5347621118763, 3006.8947586834574, 871.773338931876, 907.237920147073, 921.9354645174841, 923.0492592629603, 924.5284904698585, 10754.946225268903, 10757.139428845674, 10804.459777011118, 10830.891691083147, 10843.51204195813, 4160.1471698301775, 4391.5827996340295, 4457.754823484739, 4516.977415112903, 4553.5218802025975, 9437.90562094384, 9445.905540944503, 9448.385854919408, 9448.763780905394, 9454.290928180413, 4729.881752956204, 4760.381150450488, 4775.116603428377, 4777.235642297216, 4782.019685964369, 3724.5344331958504, 4196.349565817303, 4343.761093139908, 4349.869503914888, 4381.298992161239, 3742.36379815432, 3756.436534519844, 3858.6141385861188, 3867.477890484805, 3877.806109694504, 1191.9284842909453, 1225.4240506961714, 1247.819066235391, 1250.3748125937032, 1252.3300034481508, 809.7287408718028, 828.6685325869701, 830.5349004557468, 836.677879016583, 838.6687258532967, 5164.380274367025, 5282.52457278839, 5291.629585928948, 5322.760475778599, 5347.55082971489, 865.0743704236532, 879.5162660536679, 885.357661537838, 887.8224355128871, 895.6686026170358, 3423.4180189367867, 3597.460380942827, 3614.313280476754, 3675.8679965619876, 3689.428138638462, 9628.374155679998, 10073.848892266622, 10146.644867429752, 10147.797044059078, 10151.746206344753, 9809.803803924024, 9834.21326293909, 10062.24533160016, 10093.24300677452, 10098.848517272247, 7539.283768042027, 7681.500702454323, 7686.461947663722, 7687.807804804813, 7692.153863075057, 5107.7996670781595, 5132.897342053064, 5154.561862241751, 5156.303898973591, 5474.178873169057, 9147.817043659223, 9171.77070573241, 9237.815243694955, 9253.306002050007, 9312.301577381859, 9195.402298850553, 9265.166135047879, 9445.480498572644, 9497.47763872966, 9509.857352139585, 5839.620424672383, 6328.968355158195, 6343.492520598249, 6458.257300410513, 6491.513136514686, 7674.501157424973, 7943.205679432011, 7959.641816118405, 7963.641636126504, 7964.362850971793, 7009.193942696451, 7027.15674119109, 7050.964745176241, 7076.7523136692025, 7194.532355396883, 6701.296363881917, 6702.83242918931, 6709.36261055199, 6737.191537015589, 6795.218549866631, 5915.378885217162, 6248.281447633581, 6293.653849038347, 6300.0, 6300.401461861115, 4293.3559966004095, 4385.473743150842, 4464.9107017860115, 4466.084452687256, 4571.931421028754, 4416.22716024688, 4460.553944605514, 4538.546145385567, 4549.840755573539, 4581.885452863705], "value": 4210.892941681261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1447489130868, 308.5741676486449, 309.4646261966797, 313.8368048614719, 315.18681800953516, 4872.269159626057, 4904.5095490450985, 4923.212286034235, 4928.87677808055, 4932.5807306379, 4831.951680483194, 4863.659543831933, 4867.68360056597, 4870.610351171907, 4871.419506662609, 3697.1681371691425, 3768.8492460301554, 3796.8291426885717, 3807.619238076198, 3884.610964256976, 3831.9042023949346, 3839.212961342932, 3843.1160833008425, 3855.575886652466, 3862.671672907806, 3830.9042273943096, 3835.0220693723063, 3836.6738827199583, 3839.34731095713, 3855.1711382052854, 3547.0777597824494, 3627.220147668251, 3752.2683076800035, 3822.4266360045935, 3844.6539811416965, 3394.2023624448234, 3397.9320413591836, 3397.9490307645406, 3410.9147271318166, 3419.264858055505, 4742.810287588492, 4763.333133361332, 4778.61420188145, 4779.139754844126, 4780.478547277899, 4312.986448184705, 4324.156789426063, 4380.364847097185, 4425.521707843618, 4431.673371479967, 5088.872778180576, 5096.898062038738, 5097.745112744385, 5105.897882042338, 5115.820946266863, 3737.570179429373, 3743.0455233915177, 3749.2126653402547, 3750.2312026034597, 3760.0, 5193.169092945149, 5298.947010529922, 5320.840374788762, 5332.92000619991, 5337.5196232338885, 3811.1424929390664, 3835.1562656215588, 3836.2135762168687, 3842.500474938296, 3845.576986531479, 3885.669718073939, 3893.8637147699696, 3898.8830335089992, 3899.200663863901, 3901.746386484926, 4379.562043795595, 4389.648828093745, 4393.7363758174615, 4397.340398940185, 4400.889977750582, 4930.260460930817, 5088.6946783193125, 5092.541671249532, 5121.2574176744165, 5143.665661731976, 1329.9534516291883, 1350.5408161225034, 1353.6548180213983, 1354.3499120422055, 1357.4570171931307, 840.399114633028, 864.9524276164872, 873.4366333714719, 887.9112088791198, 891.3671293381642, 4070.715049946475, 4382.298832186899, 4415.359772832985, 4564.968588977939, 4597.44830620321, 5247.842564723064, 5258.212207849349, 5260.316158899319, 5261.579073674096, 5279.208118782213, 4564.748938808331, 4568.954310456919, 4572.839950601713, 4580.96928191161, 4583.404157459576, 2665.7734092602345, 2764.737349951751, 2804.6914839367655, 2817.8309301441977, 2821.3087793490727, 5027.421846487628, 5051.545360917535, 5052.090623687698, 5056.519630635084, 5058.797648094035, 5282.418933917266, 5432.972835135799, 5434.91847622286, 5446.863828404243, 5452.890942181134, 5009.0, 5040.2691609716385, 5043.646944713835, 5045.520675535819, 5055.418626857959, 5273.7363131842485, 5284.682919024717, 5296.735163241746, 5317.494837990384, 5321.54766844807, 4996.900061998813, 5179.637425380187, 5233.528982391603, 5245.868853278546, 5249.895002100013, 5014.0974624567925, 5035.320231768811, 5051.6716413433005, 5053.166227572409, 5054.2671312660195, 3714.5542534895985, 3726.6459686329754, 3739.2334571412252, 3739.9252014960093, 3740.551133863954, 5086.168979167571, 5108.439966381426, 5242.554382877498, 5254.527092561688, 5270.288511050959, 4972.9254061188385, 4989.501049894981, 5005.4744251853035, 5012.0, 5035.521625445577, 5047.772850221675, 5056.797728090835, 5079.238114282887, 5093.745312734422, 5096.770645320896, 4842.4189097308545, 5014.674046186986, 5019.222020586815, 5033.949660503348, 5041.823536176216, 4880.755962201947, 4952.984638149099, 5050.646454748279, 5108.79564817418, 5118.283440318432, 4963.503649635008, 4994.450610432922, 4999.425066117297, 4999.700017998932, 5009.0983622948215], "value": 3874.6798185708753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8507654203098, 609.6860117039726, 651.8891788395972, 664.1854572090353, 679.4983383446748, 11562.826557601642, 12002.639920802369, 12280.0, 12329.0, 12469.0, 12086.153969222158, 12236.571719989803, 12253.693657658541, 12255.387230638476, 12256.0, 622.5610944284268, 765.3341592814246, 787.0555333599704, 788.9053313602376, 789.0491957191599, 749.4978364495801, 786.6774622404815, 787.3307688464788, 792.3740245206309, 793.2266040610416, 818.1491249100928, 820.2084987986592, 820.6430202861744, 820.6635279535392, 821.2526600793279, 653.2781276689285, 809.8420807942454, 816.8162163513222, 817.0195765081896, 818.2799136759643, 569.5301376364474, 593.1399470767361, 594.8423667728056, 594.925634295713, 595.4581330988823, 11787.58743443984, 11796.764064718744, 11799.528018879235, 11812.645620631394, 11815.172937894351, 10693.358398496115, 10711.0, 11031.503582338813, 11118.777624447546, 11196.10431165513, 10830.025297723243, 11136.498857551429, 11155.107591392669, 11356.48895799691, 11405.885941140565, 3929.2730844793805, 3971.62269584389, 3999.1601763629674, 4068.7151899367054, 4127.525334586501, 60024.39975600232, 60049.0, 60052.39947600512, 60302.39697603012, 60366.396336036516, 9113.270938324918, 9225.815483690289, 9261.305402094735, 9459.0, 9506.287028472892, 16840.24218910152, 16844.494665160066, 17331.913340433217, 18021.27914883416, 18036.819631803777, 6671.499637527205, 6677.399034086859, 6802.965985170043, 6853.074834897325, 7078.327558881898, 3371.106656735967, 3416.2313479467416, 3445.9483107753404, 3453.637368076366, 3598.442241452579, 2782.596523504081, 2849.5868099125923, 2855.2576330153893, 2879.0930856780046, 2881.7838662100007, 487.6464563191658, 490.4286506220285, 490.977905994224, 501.78924851561703, 510.18879980830656, 531.5442654934228, 554.5591254952323, 569.6012791046285, 574.9712514374264, 580.6603137164806, 7491.775246742606, 7583.544987300779, 7698.807529811799, 7716.30553250199, 7725.49784264021, 493.9506049395032, 527.5436747213632, 555.339146415772, 574.5260160367714, 600.2886579403421, 3527.664871837171, 3708.9814550927613, 3762.285165818486, 3832.7125465590193, 3935.460438920772, 90328.5483572591, 91560.08439915515, 92682.0, 97072.0, 97155.0, 83396.58301708574, 85629.57185214158, 85815.0, 85824.57087714522, 86273.0, 71535.0, 71970.64014679893, 72009.63995179991, 72088.0, 72422.0, 7031.718731250898, 7262.455315851226, 7287.380572651172, 7414.925850741639, 7504.737334193277, 31203.37593248168, 38767.80616096901, 43505.12989740124, 44817.32774008458, 45755.77122114368, 63112.79105231295, 63128.0, 63582.68208658927, 63952.36047639464, 64258.357416425235, 10829.458527073772, 10845.728856778644, 11058.557657693602, 11345.489452974802, 11397.658070257905, 11408.771824563628, 11606.187566870238, 11698.122640801803, 11741.368110728095, 12158.574449894211, 11305.830412543653, 11341.943290283825, 11607.361595112012, 11610.303381797119, 11853.762924741284, 10908.61819836302, 10922.672319830417, 11160.944195278971, 11706.0, 12077.27536347822, 10348.275620706478, 10429.80856428193, 10601.893981060091, 10649.414282214553, 10656.413897235727, 8832.072632373509, 8937.59780809878, 9175.587098580714, 9347.205487533636, 9695.0, 9006.909930900869, 9276.397034192756, 9377.718668439958, 9583.185429238314, 9919.752006199902], "value": 6302.8550011528, "unit": "score"}], "name": "dromaeo_css", "value": 6425.405313952356, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 115.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 121.0, 194.0, 119.0, 126.0, 144.0, 122.0, 185.0, 124.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 163.0, 161.0, 162.0, 163.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 135.0, 75.0, 76.0, 74.0, 74.0, 110.0, 75.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 84.0, 86.0, 85.0, 125.0, 86.0, 86.0, 130.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 61.0, 63.0, 61.0, 62.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 80.0, 79.0, 79.0, 79.0, 79.0, 80.0, 82.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 128.0, 129.0, 125.0, 127.0, 127.0, 136.0, 212.0, 140.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 168.0, 170.0, 172.0, 163.0, 165.0, 164.0, 162.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 74.0, 66.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1532.4000000000003, "alertThreshold": 2.0}]} 04:11:46 INFO - Return code: 0 04:11:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:46 INFO - # TBPL SUCCESS # 04:11:46 INFO - Running post-action listener: _resource_record_post_action 04:11:46 INFO - [mozharness: 2016-07-30 11:11:46.981598Z] Finished run-tests step (success) 04:11:46 INFO - Running post-run listener: _resource_record_post_run 04:11:47 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 529903616; Read time: 428; Write time: 496120 04:11:47 INFO - TinderboxPrint: CPU usage
13.0% 04:11:47 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 428 04:11:47 INFO - TinderboxPrint: I/O write bytes / time
529,903,616 / 496,120 04:11:47 INFO - TinderboxPrint: CPU idle
8,325.6 (87.0%) 04:11:47 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 04:11:47 INFO - TinderboxPrint: Swap in / out
0 / 0 04:11:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 249769984; Read time: 188; Write time: 258556 04:11:47 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279592960; Read time: 220; Write time: 237516 04:11:47 INFO - Running post-run listener: _upload_blobber_files 04:11:47 INFO - Blob upload gear active. 04:11:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:47 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 04:11:47 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'] 04:11:47 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 04:11:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:51 INFO - (blobuploader) - INFO - Done attempting. 04:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:52 INFO - (blobuploader) - INFO - Done attempting. 04:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:53 INFO - (blobuploader) - INFO - Done attempting. 04:11:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:53 INFO - Return code: 0 04:11:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86656350a8aff5ff04228b48a11dfa65989d53ca405ded25feee7a7f7aeda714f316f9c4548a0206360a6afaacd9941ed47ccc7e2562d180e1cad67426291264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/260cf50246a647b0d455be1d7d667043f88f605feec4c00d3f2e0feb3fad8cddbd9239f19ee46580d280eb50ef9e39c4ca208588c0dbe122951749f04b00e013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b099111d7c80cda57a7f031530844af34eabf596a056b969ea3c7778cea4a166f7bf48290c33174501d4f2ac6edebc8cdda673348a0fce2b6f8ecc628efae993"} 04:11:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:53 INFO - Contents: 04:11:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86656350a8aff5ff04228b48a11dfa65989d53ca405ded25feee7a7f7aeda714f316f9c4548a0206360a6afaacd9941ed47ccc7e2562d180e1cad67426291264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/260cf50246a647b0d455be1d7d667043f88f605feec4c00d3f2e0feb3fad8cddbd9239f19ee46580d280eb50ef9e39c4ca208588c0dbe122951749f04b00e013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b099111d7c80cda57a7f031530844af34eabf596a056b969ea3c7778cea4a166f7bf48290c33174501d4f2ac6edebc8cdda673348a0fce2b6f8ecc628efae993"} 04:11:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:53 INFO - Copying logs to upload dir... 04:11:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.208250 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-30 04:11:52.316969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:52.325651) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86656350a8aff5ff04228b48a11dfa65989d53ca405ded25feee7a7f7aeda714f316f9c4548a0206360a6afaacd9941ed47ccc7e2562d180e1cad67426291264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/260cf50246a647b0d455be1d7d667043f88f605feec4c00d3f2e0feb3fad8cddbd9239f19ee46580d280eb50ef9e39c4ca208588c0dbe122951749f04b00e013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b099111d7c80cda57a7f031530844af34eabf596a056b969ea3c7778cea4a166f7bf48290c33174501d4f2ac6edebc8cdda673348a0fce2b6f8ecc628efae993"} build_url:https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/86656350a8aff5ff04228b48a11dfa65989d53ca405ded25feee7a7f7aeda714f316f9c4548a0206360a6afaacd9941ed47ccc7e2562d180e1cad67426291264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/260cf50246a647b0d455be1d7d667043f88f605feec4c00d3f2e0feb3fad8cddbd9239f19ee46580d280eb50ef9e39c4ca208588c0dbe122951749f04b00e013", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b099111d7c80cda57a7f031530844af34eabf596a056b969ea3c7778cea4a166f7bf48290c33174501d4f2ac6edebc8cdda673348a0fce2b6f8ecc628efae993"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:52.359079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:52.359417) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1469875874.928589-1593786088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.48 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 04:11:52.841019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 04:11:52.847395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 04:11:52.847771) ========= ========= Total master_lag: 0.62 =========