builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1464283158.19 results: success (0) buildid: 20160526082448 builduid: 163abf2ca9d847deaa352c2e281ae048 revision: 5fdfce654062b471415a82f1a2c07200fc463dcf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.187311) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.187744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.188044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.202919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.203249) ========= 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=33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 10:19:18-- 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% 224M=0s 2016-05-26 10:19:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.284538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.284847) ========= 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=33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017792 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.335020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:18.335398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fdfce654062b471415a82f1a2c07200fc463dcf --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 5fdfce654062b471415a82f1a2c07200fc463dcf --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=33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 10:19:18,627 truncating revision to first 12 chars 2016-05-26 10:19:18,627 Setting DEBUG logging. 2016-05-26 10:19:18,627 attempt 1/10 2016-05-26 10:19:18,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fdfce654062?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 10:19:18,932 unpacking tar archive at: fx-team-5fdfce654062/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668429 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:19.126344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:19.126655) ========= script_repo_revision: 5fdfce654062b471415a82f1a2c07200fc463dcf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:19.127225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:19.127507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 10:19:19.137689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-26 10:19:19.137958) ========= /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=33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:19:19 INFO - MultiFileLogger online at 20160526 10:19:19 in /builds/slave/test 10:19:19 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 10:19:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:19:19 INFO - {'append_to_log': False, 10:19:19 INFO - 'base_work_dir': '/builds/slave/test', 10:19:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:19:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:19:19 INFO - 'branch': 'Fx-Team-Non-PGO', 10:19:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:19 INFO - 'config_files': ('talos/linux_config.py',), 10:19:19 INFO - 'default_actions': ('clobber', 10:19:19 INFO - 'read-buildbot-config', 10:19:19 INFO - 'download-and-extract', 10:19:19 INFO - 'populate-webroot', 10:19:19 INFO - 'create-virtualenv', 10:19:19 INFO - 'install', 10:19:19 INFO - 'run-tests'), 10:19:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:19 INFO - 'download_minidump_stackwalk': True, 10:19:19 INFO - 'download_symbols': 'ondemand', 10:19:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:19 INFO - 'installer_path': 'installer.exe', 10:19:19 INFO - 'log_level': 'info', 10:19:19 INFO - 'log_name': 'talos', 10:19:19 INFO - 'log_to_console': True, 10:19:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:19:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:19:19 INFO - 'opt_config_files': (), 10:19:19 INFO - 'pip_index': False, 10:19:19 INFO - 'sps_profile': False, 10:19:19 INFO - 'sps_profile_interval': 0, 10:19:19 INFO - 'suite': 'dromaeojs', 10:19:19 INFO - 'system_bits': '32', 10:19:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:19 INFO - 'title': 'talos-linux64-ix-063', 10:19:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:19 INFO - 'use_talos_json': True, 10:19:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:19:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:19 INFO - 'work_dir': 'build'} 10:19:19 INFO - ##### 10:19:19 INFO - ##### Running clobber step. 10:19:19 INFO - ##### 10:19:19 INFO - Running pre-action listener: _resource_record_pre_action 10:19:19 INFO - Running main action method: clobber 10:19:19 INFO - rmtree: /builds/slave/test/build 10:19:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:19:20 INFO - Running post-action listener: _resource_record_post_action 10:19:20 INFO - ##### 10:19:20 INFO - ##### Finished clobber step (success) 10:19:20 INFO - ##### 10:19:20 INFO - ##### 10:19:20 INFO - ##### Running read-buildbot-config step. 10:19:20 INFO - ##### 10:19:20 INFO - Running pre-action listener: _resource_record_pre_action 10:19:20 INFO - Running main action method: read_buildbot_config 10:19:20 INFO - Using buildbot properties: 10:19:20 INFO - { 10:19:20 INFO - "project": "", 10:19:20 INFO - "product": "firefox", 10:19:20 INFO - "script_repo_revision": "production", 10:19:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:19:20 INFO - "repository": "", 10:19:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:19:20 INFO - "buildid": "20160526082448", 10:19:20 INFO - "pgo_build": "False", 10:19:20 INFO - "basedir": "/builds/slave/test", 10:19:20 INFO - "buildnumber": 1787, 10:19:20 INFO - "slavename": "talos-linux64-ix-063", 10:19:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:19:20 INFO - "platform": "ubuntu64_hw", 10:19:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:19:20 INFO - "branch": "fx-team", 10:19:20 INFO - "repo_path": "integration/fx-team", 10:19:20 INFO - "revision": "5fdfce654062b471415a82f1a2c07200fc463dcf", 10:19:20 INFO - "stage_platform": "linux64", 10:19:20 INFO - "builduid": "163abf2ca9d847deaa352c2e281ae048", 10:19:20 INFO - "slavebuilddir": "test" 10:19:20 INFO - } 10:19:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:19:20 INFO - Running post-action listener: _resource_record_post_action 10:19:20 INFO - ##### 10:19:20 INFO - ##### Finished read-buildbot-config step (success) 10:19:20 INFO - ##### 10:19:20 INFO - ##### 10:19:20 INFO - ##### Running download-and-extract step. 10:19:20 INFO - ##### 10:19:20 INFO - Running pre-action listener: _resource_record_pre_action 10:19:20 INFO - Running main action method: download_and_extract 10:19:20 INFO - mkdir: /builds/slave/test/build/tests 10:19: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')]} 10:19:20 INFO - https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:19:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:19:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:19:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:19:24 INFO - Downloaded 1361 bytes. 10:19:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:19:24 INFO - Using the following test package requirements: 10:19:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:19:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:19:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'jsshell-linux-x86_64.zip'], 10:19:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:19:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:19:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:19:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:19:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:19:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:19: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')]} 10:19:24 INFO - https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:19:26 INFO - Downloaded 22835570 bytes. 10:19:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:19:27 INFO - Return code: 0 10:19:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:19:27 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')]} 10:19:27 INFO - https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:19:29 INFO - Downloaded 22835570 bytes. 10:19:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:19:32 INFO - Return code: 0 10:19:32 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')]} 10:19:32 INFO - https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:19:33 INFO - Downloaded 10834034 bytes. 10:19:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:19:34 INFO - Return code: 0 10:19: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')]} 10:19:34 INFO - https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:19:36 INFO - Downloaded 54827660 bytes. 10:19:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:36 INFO - mkdir: /builds/slave/test/properties 10:19:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:36 INFO - Contents: 10:19:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:40 INFO - Running post-action listener: _resource_record_post_action 10:19:40 INFO - Running post-action listener: set_extra_try_arguments 10:19:40 INFO - ##### 10:19:40 INFO - ##### Finished download-and-extract step (success) 10:19:40 INFO - ##### 10:19:40 INFO - ##### 10:19:40 INFO - ##### Running populate-webroot step. 10:19:40 INFO - ##### 10:19:40 INFO - Running pre-action listener: _resource_record_pre_action 10:19:40 INFO - Running main action method: populate_webroot 10:19:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:40 INFO - '--tppagecycles', 10:19:40 INFO - '7'], 10:19:40 INFO - 'tests': ['tsvgm']}}, 10:19:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['damp', 'tps']}, 10:19:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'tests': ['damp', 'tps']}, 10:19:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['dromaeo_dom']}, 10:19:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['a11yr', 10:19:40 INFO - 'ts_paint', 10:19:40 INFO - 'tpaint', 10:19:40 INFO - 'sessionrestore', 10:19:40 INFO - 'sessionrestore_no_auto_restore', 10:19:40 INFO - 'tabpaint']}, 10:19:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tsvgx', 10:19:40 INFO - 'tsvgr_opacity', 10:19:40 INFO - 'tart', 10:19:40 INFO - 'tscrollx', 10:19:40 INFO - 'cart']}, 10:19:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:40 INFO - 'tsvgr_opacity', 10:19:40 INFO - 'tart', 10:19:40 INFO - 'tscrollx', 10:19:40 INFO - 'cart']}, 10:19:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s'], 10:19:40 INFO - 'tests': ['tp5o']}, 10:19:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'tests': ['tp5o']}, 10:19:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--disable-e10s', 10:19:40 INFO - '--xperf_path', 10:19:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:40 INFO - 'tests': ['tp5n']}, 10:19:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:40 INFO - 'talos_options': ['--xperf_path', 10:19:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:40 INFO - 'tests': ['tp5n']}}, 10:19:40 INFO - 'talos.zip': {'path': '', 10:19:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:40 INFO - Running post-action listener: _resource_record_post_action 10:19:40 INFO - ##### 10:19:40 INFO - ##### Finished populate-webroot step (success) 10:19:40 INFO - ##### 10:19:40 INFO - ##### 10:19:40 INFO - ##### Running create-virtualenv step. 10:19:40 INFO - ##### 10:19:40 INFO - Running pre-action listener: _resource_record_pre_action 10:19:40 INFO - Running main action method: create_virtualenv 10:19:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:40 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 10:19:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:40 INFO - Using real prefix '/usr' 10:19:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:42 INFO - Installing pip.................done. 10:19:42 INFO - Return code: 0 10:19:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:19:42 INFO - Using env: {'DISPLAY': ':0', 10:19:42 INFO - 'HOME': '/home/cltbld', 10:19:42 INFO - 'LANG': 'en_US.UTF-8', 10:19:42 INFO - 'LANGUAGE': 'en_US:en', 10:19:42 INFO - 'LOGNAME': 'cltbld', 10:19:42 INFO - 'MAIL': '/var/mail/cltbld', 10:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:42 INFO - 'MOZ_NO_REMOTE': '1', 10:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:42 INFO - 'NO_EM_RESTART': '1', 10:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:42 INFO - 'PWD': '/builds/slave/test', 10:19:42 INFO - 'SHELL': '/bin/bash', 10:19:42 INFO - 'SHLVL': '1', 10:19:42 INFO - 'TERM': 'linux', 10:19:42 INFO - 'TMOUT': '86400', 10:19:42 INFO - 'USER': 'cltbld', 10:19:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:42 INFO - '_': '/tools/buildbot/bin/python'} 10:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:42 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 10:19:42 INFO - Cleaning up... 10:19:42 INFO - Return code: 0 10:19:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:19:42 INFO - Using env: {'DISPLAY': ':0', 10:19:42 INFO - 'HOME': '/home/cltbld', 10:19:42 INFO - 'LANG': 'en_US.UTF-8', 10:19:42 INFO - 'LANGUAGE': 'en_US:en', 10:19:42 INFO - 'LOGNAME': 'cltbld', 10:19:42 INFO - 'MAIL': '/var/mail/cltbld', 10:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:42 INFO - 'MOZ_NO_REMOTE': '1', 10:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:42 INFO - 'NO_EM_RESTART': '1', 10:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:42 INFO - 'PWD': '/builds/slave/test', 10:19:42 INFO - 'SHELL': '/bin/bash', 10:19:42 INFO - 'SHLVL': '1', 10:19:42 INFO - 'TERM': 'linux', 10:19:42 INFO - 'TMOUT': '86400', 10:19:42 INFO - 'USER': 'cltbld', 10:19:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:42 INFO - '_': '/tools/buildbot/bin/python'} 10:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:43 INFO - Downloading/unpacking psutil>=3.1.1 10:19:43 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 10:19:43 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 10:19:43 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 10:19:43 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 10:19:43 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 10:19:43 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 10:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:45 INFO - Installing collected packages: psutil 10:19:45 INFO - Running setup.py install for psutil 10:19:45 INFO - building 'psutil._psutil_linux' extension 10:19:45 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 10:19:45 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 10:19:45 INFO - building 'psutil._psutil_posix' extension 10:19:45 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 10:19:45 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 10:19:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:45 INFO - Successfully installed psutil 10:19:45 INFO - Cleaning up... 10:19:45 INFO - Return code: 0 10:19:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:45 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')]} 10:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:45 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')]} 10:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:45 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 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:45 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 10:19:45 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 10:19:45 INFO - Using env: {'DISPLAY': ':0', 10:19:45 INFO - 'HOME': '/home/cltbld', 10:19:45 INFO - 'LANG': 'en_US.UTF-8', 10:19:45 INFO - 'LANGUAGE': 'en_US:en', 10:19:45 INFO - 'LOGNAME': 'cltbld', 10:19:45 INFO - 'MAIL': '/var/mail/cltbld', 10:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:45 INFO - 'MOZ_NO_REMOTE': '1', 10:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:45 INFO - 'NO_EM_RESTART': '1', 10:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:45 INFO - 'PWD': '/builds/slave/test', 10:19:45 INFO - 'SHELL': '/bin/bash', 10:19:45 INFO - 'SHLVL': '1', 10:19:45 INFO - 'TERM': 'linux', 10:19:45 INFO - 'TMOUT': '86400', 10:19:45 INFO - 'USER': 'cltbld', 10:19:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:45 INFO - '_': '/tools/buildbot/bin/python'} 10:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:45 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 10:19:45 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 10:19:45 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 10:19:45 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 10:19:45 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 10:19:45 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 10:19:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:47 INFO - Installing collected packages: mozsystemmonitor 10:19:47 INFO - Running setup.py install for mozsystemmonitor 10:19:47 INFO - Successfully installed mozsystemmonitor 10:19:47 INFO - Cleaning up... 10:19:47 INFO - Return code: 0 10:19:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', '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 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:19: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 blobuploader==1.2.4 10:19:47 INFO - Using env: {'DISPLAY': ':0', 10:19:47 INFO - 'HOME': '/home/cltbld', 10:19:47 INFO - 'LANG': 'en_US.UTF-8', 10:19:47 INFO - 'LANGUAGE': 'en_US:en', 10:19:47 INFO - 'LOGNAME': 'cltbld', 10:19:47 INFO - 'MAIL': '/var/mail/cltbld', 10:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:47 INFO - 'MOZ_NO_REMOTE': '1', 10:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:47 INFO - 'NO_EM_RESTART': '1', 10:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:47 INFO - 'PWD': '/builds/slave/test', 10:19:47 INFO - 'SHELL': '/bin/bash', 10:19:47 INFO - 'SHLVL': '1', 10:19:47 INFO - 'TERM': 'linux', 10:19:47 INFO - 'TMOUT': '86400', 10:19:47 INFO - 'USER': 'cltbld', 10:19:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:47 INFO - '_': '/tools/buildbot/bin/python'} 10:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:48 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 10:19:48 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 10:19:48 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 10:19:48 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 10:19:48 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 10:19:48 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 10:19:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:50 INFO - Downloading docopt-0.6.1.tar.gz 10:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:50 INFO - Running setup.py install for blobuploader 10:19:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:50 INFO - Running setup.py install for requests 10:19:51 INFO - Running setup.py install for docopt 10:19:51 INFO - Successfully installed blobuploader requests docopt 10:19:51 INFO - Cleaning up... 10:19:51 INFO - Return code: 0 10:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:51 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')]} 10:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:51 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')]} 10:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:51 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 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:51 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 10:19:51 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 10:19:51 INFO - Using env: {'DISPLAY': ':0', 10:19:51 INFO - 'HOME': '/home/cltbld', 10:19:51 INFO - 'LANG': 'en_US.UTF-8', 10:19:51 INFO - 'LANGUAGE': 'en_US:en', 10:19:51 INFO - 'LOGNAME': 'cltbld', 10:19:51 INFO - 'MAIL': '/var/mail/cltbld', 10:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:51 INFO - 'MOZ_NO_REMOTE': '1', 10:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:51 INFO - 'NO_EM_RESTART': '1', 10:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:51 INFO - 'PWD': '/builds/slave/test', 10:19:51 INFO - 'SHELL': '/bin/bash', 10:19:51 INFO - 'SHLVL': '1', 10:19:51 INFO - 'TERM': 'linux', 10:19:51 INFO - 'TMOUT': '86400', 10:19:51 INFO - 'USER': 'cltbld', 10:19:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:51 INFO - '_': '/tools/buildbot/bin/python'} 10:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:51 INFO - Running setup.py (path:/tmp/pip-hGm6pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:51 INFO - Running setup.py (path:/tmp/pip-pdyQK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:51 INFO - Running setup.py (path:/tmp/pip-TI_auZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:51 INFO - Running setup.py (path:/tmp/pip-kPLhZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:51 INFO - Running setup.py (path:/tmp/pip-1cbgWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:51 INFO - Running setup.py (path:/tmp/pip-WI8Oyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:51 INFO - Running setup.py (path:/tmp/pip-WOoodM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:52 INFO - Running setup.py (path:/tmp/pip-BdUTkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:52 INFO - Running setup.py (path:/tmp/pip-w7hnQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:52 INFO - Running setup.py (path:/tmp/pip-g6X5kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:52 INFO - Running setup.py (path:/tmp/pip-F4ejAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:52 INFO - Running setup.py (path:/tmp/pip-SAKtGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:52 INFO - Running setup.py (path:/tmp/pip-Grj5SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:52 INFO - Running setup.py (path:/tmp/pip-hT4t37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:52 INFO - Running setup.py (path:/tmp/pip-17slda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:52 INFO - Running setup.py (path:/tmp/pip-Ge1vMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:52 INFO - Running setup.py (path:/tmp/pip-LXYsCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:52 INFO - Running setup.py install for manifestparser 10:19:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:52 INFO - Running setup.py install for mozcrash 10:19:52 INFO - Running setup.py install for mozdebug 10:19:53 INFO - Running setup.py install for mozdevice 10:19:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for mozfile 10:19:53 INFO - Running setup.py install for mozhttpd 10:19:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for mozinfo 10:19:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for mozInstall 10:19:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for mozleak 10:19:53 INFO - Running setup.py install for mozlog 10:19:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for moznetwork 10:19:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for mozprocess 10:19:54 INFO - Running setup.py install for mozprofile 10:19:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozrunner 10:19:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozscreenshot 10:19:54 INFO - Running setup.py install for moztest 10:19:54 INFO - Running setup.py install for mozversion 10:19:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:54 INFO - Cleaning up... 10:19:54 INFO - Return code: 0 10:19:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:54 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 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:54 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 10:19:54 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 10:19:54 INFO - Using env: {'DISPLAY': ':0', 10:19:54 INFO - 'HOME': '/home/cltbld', 10:19:54 INFO - 'LANG': 'en_US.UTF-8', 10:19:54 INFO - 'LANGUAGE': 'en_US:en', 10:19:54 INFO - 'LOGNAME': 'cltbld', 10:19:54 INFO - 'MAIL': '/var/mail/cltbld', 10:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:54 INFO - 'MOZ_NO_REMOTE': '1', 10:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:54 INFO - 'NO_EM_RESTART': '1', 10:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:54 INFO - 'PWD': '/builds/slave/test', 10:19:54 INFO - 'SHELL': '/bin/bash', 10:19:54 INFO - 'SHLVL': '1', 10:19:54 INFO - 'TERM': 'linux', 10:19:54 INFO - 'TMOUT': '86400', 10:19:54 INFO - 'USER': 'cltbld', 10:19:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:54 INFO - '_': '/tools/buildbot/bin/python'} 10:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:54 INFO - Running setup.py (path:/tmp/pip-NK90Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:54 INFO - Running setup.py (path:/tmp/pip-IkX7J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:54 INFO - Running setup.py (path:/tmp/pip-uVrVzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:54 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)) 10:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:55 INFO - Running setup.py (path:/tmp/pip-mBhsiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:55 INFO - Running setup.py (path:/tmp/pip-Zhqsp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:55 INFO - Running setup.py (path:/tmp/pip-Y13aSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:55 INFO - Running setup.py (path:/tmp/pip-ZoNtlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:55 INFO - Running setup.py (path:/tmp/pip-Da0c1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:55 INFO - Running setup.py (path:/tmp/pip-hceNVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:55 INFO - Running setup.py (path:/tmp/pip-BK09S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:55 INFO - Running setup.py (path:/tmp/pip-8Ttgld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:55 INFO - Running setup.py (path:/tmp/pip-_p92CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:55 INFO - Running setup.py (path:/tmp/pip-no75gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:55 INFO - Running setup.py (path:/tmp/pip-4VvI8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:55 INFO - Running setup.py (path:/tmp/pip-jZY0u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:55 INFO - Running setup.py (path:/tmp/pip-_1WAFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:55 INFO - Running setup.py (path:/tmp/pip-WrjvKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:56 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)) 10:19:56 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)) 10:19:56 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)) 10:19:56 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)) 10:19:56 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)) 10:19:56 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)) 10:19:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:56 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 10:19:56 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 10:19:56 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 10:19:56 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 10:19:56 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 10:19:56 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 10:19:57 INFO - Downloading blessings-1.6.tar.gz 10:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:57 INFO - Installing collected packages: blessings 10:19:57 INFO - Running setup.py install for blessings 10:19:58 INFO - Successfully installed blessings 10:19:58 INFO - Cleaning up... 10:19:58 INFO - Return code: 0 10:19:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:58 INFO - Reading from file tmpfile_stdout 10:19:58 INFO - Current package versions: 10:19:58 INFO - argparse == 1.2.1 10:19:58 INFO - blessings == 1.6 10:19:58 INFO - blobuploader == 1.2.4 10:19:58 INFO - docopt == 0.6.1 10:19:58 INFO - manifestparser == 1.1 10:19:58 INFO - mozInstall == 1.12 10:19:58 INFO - mozcrash == 0.17 10:19:58 INFO - mozdebug == 0.1 10:19:58 INFO - mozdevice == 0.48 10:19:58 INFO - mozfile == 1.2 10:19:58 INFO - mozhttpd == 0.7 10:19:58 INFO - mozinfo == 0.9 10:19:58 INFO - mozleak == 0.1 10:19:58 INFO - mozlog == 3.2 10:19:58 INFO - moznetwork == 0.27 10:19:58 INFO - mozprocess == 0.22 10:19:58 INFO - mozprofile == 0.28 10:19:58 INFO - mozrunner == 6.11 10:19:58 INFO - mozscreenshot == 0.1 10:19:58 INFO - mozsystemmonitor == 0.3 10:19:58 INFO - moztest == 0.7 10:19:58 INFO - mozversion == 1.4 10:19:58 INFO - psutil == 3.1.1 10:19:58 INFO - requests == 1.2.3 10:19:58 INFO - wsgiref == 0.1.2 10:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:58 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 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:58 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 10:19:58 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 10:19:58 INFO - Using env: {'DISPLAY': ':0', 10:19:58 INFO - 'HOME': '/home/cltbld', 10:19:58 INFO - 'LANG': 'en_US.UTF-8', 10:19:58 INFO - 'LANGUAGE': 'en_US:en', 10:19:58 INFO - 'LOGNAME': 'cltbld', 10:19:58 INFO - 'MAIL': '/var/mail/cltbld', 10:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:58 INFO - 'MOZ_NO_REMOTE': '1', 10:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:58 INFO - 'NO_EM_RESTART': '1', 10:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:58 INFO - 'PWD': '/builds/slave/test', 10:19:58 INFO - 'SHELL': '/bin/bash', 10:19:58 INFO - 'SHLVL': '1', 10:19:58 INFO - 'TERM': 'linux', 10:19:58 INFO - 'TMOUT': '86400', 10:19:58 INFO - 'USER': 'cltbld', 10:19:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:58 INFO - '_': '/tools/buildbot/bin/python'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 INFO - Cleaning up... 10:19:59 INFO - Return code: 0 10:19:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:19:59 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 10:19:59 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 10:19:59 INFO - Using env: {'DISPLAY': ':0', 10:19:59 INFO - 'HOME': '/home/cltbld', 10:19:59 INFO - 'LANG': 'en_US.UTF-8', 10:19:59 INFO - 'LANGUAGE': 'en_US:en', 10:19:59 INFO - 'LOGNAME': 'cltbld', 10:19:59 INFO - 'MAIL': '/var/mail/cltbld', 10:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:59 INFO - 'MOZ_NO_REMOTE': '1', 10:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:59 INFO - 'NO_EM_RESTART': '1', 10:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:59 INFO - 'PWD': '/builds/slave/test', 10:19:59 INFO - 'SHELL': '/bin/bash', 10:19:59 INFO - 'SHLVL': '1', 10:19:59 INFO - 'TERM': 'linux', 10:19:59 INFO - 'TMOUT': '86400', 10:19:59 INFO - 'USER': 'cltbld', 10:19:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:59 INFO - '_': '/tools/buildbot/bin/python'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 INFO - Downloading/unpacking jsonschema 10:19:59 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 10:19:59 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 10:19:59 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 10:19:59 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 10:19:59 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 10:19:59 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 10:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:01 INFO - Downloading/unpacking functools32 (from jsonschema) 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:20:01 INFO - warning: no files found matching '*.txt' 10:20:01 INFO - no previously-included directories found matching 'build' 10:20:01 INFO - no previously-included directories found matching 'dist' 10:20:01 INFO - no previously-included directories found matching '.git*' 10:20:01 INFO - Installing collected packages: jsonschema, functools32 10:20:01 INFO - Running setup.py install for functools32 10:20:01 INFO - warning: no files found matching '*.txt' 10:20:01 INFO - no previously-included directories found matching 'build' 10:20:01 INFO - no previously-included directories found matching 'dist' 10:20:01 INFO - no previously-included directories found matching '.git*' 10:20:01 INFO - Successfully installed jsonschema functools32 10:20:01 INFO - Cleaning up... 10:20:01 INFO - Return code: 0 10:20:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:01 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f217bb67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', '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 10:20:01 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', 'flake8'] in /builds/slave/test/build 10:20:01 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 flake8 10:20:01 INFO - Using env: {'DISPLAY': ':0', 10:20:01 INFO - 'HOME': '/home/cltbld', 10:20:01 INFO - 'LANG': 'en_US.UTF-8', 10:20:01 INFO - 'LANGUAGE': 'en_US:en', 10:20:01 INFO - 'LOGNAME': 'cltbld', 10:20:01 INFO - 'MAIL': '/var/mail/cltbld', 10:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:01 INFO - 'MOZ_NO_REMOTE': '1', 10:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:01 INFO - 'NO_EM_RESTART': '1', 10:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:01 INFO - 'PWD': '/builds/slave/test', 10:20:01 INFO - 'SHELL': '/bin/bash', 10:20:01 INFO - 'SHLVL': '1', 10:20:01 INFO - 'TERM': 'linux', 10:20:01 INFO - 'TMOUT': '86400', 10:20:01 INFO - 'USER': 'cltbld', 10:20:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:01 INFO - '_': '/tools/buildbot/bin/python'} 10:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:01 INFO - Downloading/unpacking flake8 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:20:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:20:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:20:04 INFO - no previously-included directories found matching 'docs/_build' 10:20:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:20:05 INFO - Running setup.py install for pep8 10:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:20:05 INFO - no previously-included directories found matching 'docs/_build' 10:20:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:20:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:20:05 INFO - Cleaning up... 10:20:11 INFO - Return code: 0 10:20:11 INFO - Running post-action listener: _resource_record_post_action 10:20:11 INFO - Running post-action listener: _start_resource_monitoring 10:20:11 INFO - Starting resource monitoring. 10:20:11 INFO - ##### 10:20:11 INFO - ##### Finished create-virtualenv step (success) 10:20:11 INFO - ##### 10:20:11 INFO - ##### 10:20:11 INFO - ##### Running install step. 10:20:11 INFO - ##### 10:20:11 INFO - Running pre-action listener: _resource_record_pre_action 10:20:11 INFO - Running main action method: install 10:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:11 INFO - Reading from file tmpfile_stdout 10:20:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:11 INFO - Reading from file tmpfile_stdout 10:20:11 INFO - Output received: 10:20:11 INFO - Usage: mozinstall [options] installer 10:20:11 INFO - Options: 10:20:11 INFO - -h, --help show this help message and exit 10:20:11 INFO - -d DEST, --destination=DEST 10:20:11 INFO - Directory to install application into. [default: 10:20:11 INFO - "/builds/slave/test"] 10:20:11 INFO - --app=APP Application being installed. [default: firefox] 10:20:11 INFO - mkdir: /builds/slave/test/build/application 10:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:20:30 INFO - Reading from file tmpfile_stdout 10:20:30 INFO - Output received: 10:20:30 INFO - /builds/slave/test/build/application/firefox/firefox 10:20:30 INFO - Running post-action listener: _resource_record_post_action 10:20:30 INFO - ##### 10:20:30 INFO - ##### Finished install step (success) 10:20:30 INFO - ##### 10:20:30 INFO - ##### 10:20:30 INFO - ##### Running run-tests step. 10:20:30 INFO - ##### 10:20:30 INFO - Running pre-action listener: _resource_record_pre_action 10:20:30 INFO - Running main action method: run_tests 10:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:30 INFO - Python 2.7.3 10:20:30 INFO - Return code: 0 10:20:30 INFO - grabbing minidump binary from tooltool 10:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:20:30 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 0x1d199c0>, '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 0x1d1a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20:30 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 10:20:30 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 10:20:30 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 10:20:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:30 INFO - Return code: 0 10:20:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:20:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:20:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:20:31 INFO - Return code: 0 10:20:31 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/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 10:20:31 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/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 10:20:31 INFO - Using env: {'DISPLAY': ':0', 10:20:31 INFO - 'HOME': '/home/cltbld', 10:20:31 INFO - 'LANG': 'en_US.UTF-8', 10:20:31 INFO - 'LANGUAGE': 'en_US:en', 10:20:31 INFO - 'LOGNAME': 'cltbld', 10:20:31 INFO - 'MAIL': '/var/mail/cltbld', 10:20:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:31 INFO - 'MOZ_NO_REMOTE': '1', 10:20:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:31 INFO - 'NO_EM_RESTART': '1', 10:20:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:31 INFO - 'PWD': '/builds/slave/test', 10:20:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:31 INFO - 'SHELL': '/bin/bash', 10:20:31 INFO - 'SHLVL': '1', 10:20:31 INFO - 'TERM': 'linux', 10:20:31 INFO - 'TMOUT': '86400', 10:20:31 INFO - 'USER': 'cltbld', 10:20:31 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366', 10:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:31 INFO - '_': '/tools/buildbot/bin/python'} 10:20:31 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/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 10:20:31 INFO - mozversion application_buildid: 20160526082448 10:20:31 INFO - mozversion application_changeset: 5fdfce654062b471415a82f1a2c07200fc463dcf 10:20:31 INFO - mozversion application_display_name: Nightly 10:20:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:31 INFO - mozversion application_name: Firefox 10:20:31 INFO - mozversion application_remotingname: firefox 10:20:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:20:31 INFO - mozversion application_vendor: Mozilla 10:20:31 INFO - mozversion application_version: 49.0a1 10:20:31 INFO - mozversion platform_buildid: 20160526082448 10:20:31 INFO - mozversion platform_changeset: 5fdfce654062b471415a82f1a2c07200fc463dcf 10:20:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:20:31 INFO - mozversion platform_version: 49.0a1 10:20:31 INFO - using testdate: 1464283231 10:20:31 INFO - actual date: 1464283231 10:20:31 INFO - starting webserver on 'localhost:34630' 10:20:31 INFO - SUITE-START | Running 2 tests 10:20:31 INFO - TEST-START | dromaeo_css 10:20:31 INFO - operating with platform_type : linux_ 10:20:31 INFO - Initialising browser for dromaeo_css test... 10:20:31 INFO - TEST-INFO | started process 22132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbso_lR/profile http://localhost:34630/getInfo.html) 10:20:39 INFO - PROCESS | 22132 | __metrics Screen width/height:1600/1200 10:20:39 INFO - PROCESS | 22132 | colorDepth:24 10:20:39 INFO - PROCESS | 22132 | Browser inner width/height: 1024/697 10:20:39 INFO - PROCESS | 22132 | __metrics 10:20:41 ERROR - PROCESS | 22132 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:20:42 INFO - TEST-INFO | 22132: exit 0 10:20:42 INFO - Browser initialized. 10:20:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:42 INFO - TEST-INFO | started process 22212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbso_lR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:54 INFO - PROCESS | 22212 | RSS: Main: 156073984 10:20:54 INFO - PROCESS | 22212 | 10:21:45 INFO - PROCESS | 22212 | 1464283305402 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] 10:23:58 INFO - PROCESS | 22212 | Cycle 1(1): loaded http://localhost:34630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34630/tests/dromaeo/cssquery-ext.html) 10:23:59 INFO - PROCESS | 22212 | RSS: Main: 234655744 10:23:59 INFO - PROCESS | 22212 | 10:27:02 INFO - PROCESS | 22212 | Cycle 1(1): loaded http://localhost:34630/tests/dromaeo/cssquery-ext.html (next: http://localhost:34630/tests/dromaeo/cssquery-jquery.html) 10:27:02 INFO - PROCESS | 22212 | RSS: Main: 241336320 10:27:02 INFO - PROCESS | 22212 | 10:30:05 INFO - PROCESS | 22212 | Cycle 1(1): loaded http://localhost:34630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34630/tests/dromaeo/cssquery-mootools.html) 10:30:05 INFO - PROCESS | 22212 | RSS: Main: 239624192 10:30:05 INFO - PROCESS | 22212 | 10:33:07 INFO - PROCESS | 22212 | Cycle 1(1): loaded http://localhost:34630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34630/tests/dromaeo/cssquery-prototype.html) 10:33:08 INFO - PROCESS | 22212 | RSS: Main: 235003904 10:33:08 INFO - PROCESS | 22212 | 10:36:11 INFO - PROCESS | 22212 | Cycle 1(1): loaded http://localhost:34630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34630/tests/dromaeo/cssquery-yui.html) 10:36:11 INFO - PROCESS | 22212 | RSS: Main: 215179264 10:36:11 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | Cycle 1(1): loaded http://localhost:34630/tests/dromaeo/cssquery-yui.html (next: http://localhost:34630/tests/dromaeo/cssquery-dojo.html) 10:39:14 INFO - PROCESS | 22212 | RSS: Main: 287584256 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | __start_tp_report 10:39:14 INFO - PROCESS | 22212 | _x_x_mozilla_page_load 10:39:14 INFO - PROCESS | 22212 | _x_x_mozilla_page_load_details 10:39:14 INFO - PROCESS | 22212 | |i|pagename|runs| 10:39:14 INFO - PROCESS | 22212 | |0;dojo.html;2674.277944954862;2689.3411114277005;2723.9863800681005;2727.5363188257993;2743.300458383112;4671.159191345557;4673.462551806543;4729.1251118543005;4731.148393289211;4795.280707893818;4748.881277968053;4763.333133361323;4782.83260085897;4787.114383838993;4860.1494738420815;4312.547182545834;4331.43691320128;4342.913141737164;4449.26587113126;4479.507254202035;4429.822807087713;4474.0380818124095;4529.297958816389;4547.7953492092765;4565.703229290102;4312.159128969852;4342.457192850894;4476.641868650533;4517.954820451786;4523.7285762854335;4396.934045989313;4399.824007039714;4404;4408.162449134654;4416.138852923681;4382.956170438287;4384.758838263894;4385.1229754049;4388.253996820548;4395.7142785718825;4653.6509761768;4678.508756580544;4688.226442636961;4707.529247075299;4760.714357138583;5064.645474816764;5081.085404627165;5129.769160387791;5152.433232344477;5197.064528384889;5023.045621331935;5174.404943431516;5238.68567885928;5252.3171987641745;5262.947370526284;4796.136695394827;4826.1795494765975;4832.106060378841;4907.33750943618;4914.164592019365;5359.812406565751;5384.515393614593;5399;5407.540359069444;5421.945780542223;4877.902441951142;4993.825216117419;5169.767360468788;5172.379314482211;5173.120569503193;5137.922931156036;5152.92270615941;5169.508896654812;5186.247994040843;5188.429272779991;5010.674306170087;5016.648834581617;5028.044671512401;5030.471800460972;5096.184610462308;4928.654994150446;4999.250112483084;5024.447310795809;5036.722980236049;5038.672486288453;4327.307630779061;4354.107407981356;4354.172707185625;4362.847300344472;4392.494863090722;3773.7924414156937;3781.5273090863643;3785.488958990556;3826.330392181357;3830.157365379612;4336.111097225062;4384.188925048876;4404.6035856772405;4442.955570444255;4448.377227188196;5062.7468626568525;5097.057044446789;5111.284420181178;5147.562457191106;5199.194124910645;4394.714343567658;4417.8232870684815;4430.712003719748;4437.134758722083;4461.933071003938;4554.089182163514;4647.37260469839;4658.67389282747;4669.976650116796;4719.056188762262;4797.688150270221;4837.032593481388;4850.854474365775;4873.147199240189;4907.631927605516;5206.739663016759;5212.166053431432;5212.50481204285;5223.2948551945;5271.868203294948;4690.6247500199215;4764.618830493621;4874.317595536699;4883.731394773322;4886.53577910098;5032.345795046621;5061.898762024665;5076.593872490266;5086.61850361217;5123.410807757155;5139.100657384868;5155.767990440514;5161.22581612746;5162.6386152970435;5177.042247184283;4805.399325084364;4938.851834444972;4962.602991760723;4992.176290911959;5007.899842003212;5004.174311238605;5007.24891266313;5023.723695196799;5030;5060.1903695408555;4947.752612369295;4949.133901567283;4995.875103122451;4997.3253610762085;5011.699298042129;4932.679375840559;5000.974995125001;5014.874628134326;5028.622853285945;5108.9233661495855;4955.479674634112;4966.155753521838;4974.303597496281;4979.452260251297;5039.622028347815 10:39:14 INFO - PROCESS | 22212 | |1;ext.html;554.2406902543519;562.2072877243088;565.9094544872821;586.1939832729996;607.283405581414;40516.392254116174;41456.58543414565;41633.375499367496;41662.37506437402;46167.769161154145;42222.788886055605;42782.14435711284;42813.571864281344;42834.14331713364;42887.57112428875;7803.258690424401;7942.602869856513;7945;7965.163657815933;7966.44234903557;7828;7912.960435197845;7923.049234091917;7924.167962363956;7924.762257132266;7929.524228546276;7949.880751788728;7969.681212751483;7971.601419929009;7976.322012628904;7862.410319226053;7906.051273847175;7907.644156012964;7911.762647120596;7912.802179945518;7849.097353804328;7906.723264685708;7920.881186782203;7923.72266970659;7925.484843485155;39018;39383.21233575341;39401.80299098486;39417.40873886894;39424.40863387052;2956.49739544278;3059.832973333474;3221.882073731358;3663.1757854482794;3720.5907350191455;30072.248193795112;30204.84897575498;30435.543466848016;30511.23721906948;30990.690093099005;3278.852451639682;3367.966320336814;3455.36075825973;3461.7749846259912;3462.4460086386057;246958;247821;249222;249423.9999999982;249662;32695.50956735651;57210.713946430835;57428.71285643545;57460.425395746344;57496;32616.347673046406;34471.4829277561;34481.482777758356;34503.4824477633;34575.827120864735;12648.747025059447;12864.807027894589;12867;12870.549530766566;12891.35543222835;9763.121319081316;9866.358686685342;9866.556004979793;9877.753056173653;9900.059494348025;7948.682052717826;7958.562279074591;7966.402519811038;8014.078380986145;8037.357011439188;3125.6249250090136;3139.309351942569;3143.512755522898;3156.447621666199;3200.423923693711;904.8009437923646;951.5860600638745;967.3145316344749;1007.4559737741538;1037.0821822686826;28433.147005589864;28459.71540284612;28754.856225719155;28910.132696019155;28952.42095158085;684.3772167327708;951.1629765806047;987.5704068730125;1089.199438412766;1098.96153634624;14786.92606536982;14976.925115374353;14978.925105374403;15158.772618410512;15219.412699840832;390568;393499;394382;395043;395350;51396.74301628468;51911.74044129755;52012.21981670278;52051.47948520542;52058.21912671313;963;1162.6686394377562;1210.667066556704;1219.8048312269993;1232.9075319351084;28449;29465.410691785615;29625;29650.555241671824;30124.54813177848;42584.14831703411;42652.78673606612;43213.78393108014;43238;43258.78370608127;281566;281882;282776;283267;284354;20566.177352905717;25038.874805625856;25757.484850303263;25767.484650306513;27235.455290894468;42981.785091074344;43203.567964319955;43256.567434325254;43681;44357.778211108736;36701.44947825838;37330.44004339883;37682.62317376791;37858.62141378661;37859.81070094632;36445.45331820078;37116.25767484581;37389;37564.62435375721;37579.436308455945;36141.63858361488;36423;39388;40140.59859401369;40257.19485610213;32047.679523204468;33800.66199337975;33944.66055339415;34608.48087278642;34661.13347166341;25132.246032619052;25714.8714256435;25852;25895.61156582615;26031.21906342813 10:39:14 INFO - PROCESS | 22212 | |2;jquery.html;355.8025295960742;356.07775860521247;361.409096127831;366.84225782913336;375.31130375760495;15614.453494127707;16981.490555283344;17177.656446871057;17496.82503174968;17518.38685646001;15929.52211433656;16805.747913781302;17487.300507979697;17544.385946491875;17551.82448175518;4909.950900490994;4936.35827342445;4940.209566469365;5086.872828179288;5092.337996060507;3590.533230680021;3763.0592351912023;4967.627427942901;5438.755256013489;5746.138079288098;5784.392638772932;5786.768529258846;5800.883982320351;5803.622764520293;5804;5609.747561359708;5726.770929162829;5730.512906402961;5826.766929322822;5835.562332825034;3220.5491231227647;4721.433427988629;4945.357103576548;5023.974880125613;5032.6477146599755;19013.239470421166;19663.1151598177;19667.803321966883;19874.80125198744;19884.900575497173;1964.1848632817364;2294.5066810635626;2367.135995361698;2482.329770961848;2519.0301733832607;12126.090543209206;12868.678283042998;12956.222626642431;13162.60512184636;13447.193168409829;1703.9180120623369;1755.2540170427517;1826.8447181989548;1830.7803063632316;1846.1046392499627;61615.38384616186;61954.380456195315;62251;62839.371606284265;63611.68194159046;8763.693270735494;9331.253499720005;9642.903570964341;10100.646477373257;10605.310654807567;12493.562725304571;12494.625161245178;12629.11596188258;12685.365731713377;12740.872591274154;6994.68523916425;7063.223045464994;7104.573725576379;7162.7493037743425;7217.494775365779;6527.510436717265;6651.334866513407;6679.599224046573;6761.22245941723;6782.118324617867;5731.226284451629;5983.132445795335;5984.401559843981;6081.878362432726;6152;1465.355243692793;1576.1646327446472;1733.699402737575;1739.5998920248414;1746.9912650436665;749.2769477454283;812.3582369927691;847.6778824046946;922.5710044829052;942.0908822985851;16033.518994430186;16598.917005414896;16786.832131678526;17139.485815425556;17225.1387430628;835.3985130705883;854.9016863060828;875.5097145598485;880.7974165941869;921.9858156028449;9556.283278754121;9693.466859322805;9782.608695652236;9824.115829575372;9859.802803944025;358904;361938;367095;367225;367356;63469.36530634727;65012;65830.34169658241;65867.34132658708;66025.33974660288;888.8977767556685;911.7629416351797;926.972190834276;928.1414691410419;942.1002942190192;15511.84488155104;15518.534443966699;15597.064176149468;15802.525924222291;15872.60318492047;34022.31955360928;34145.65854341425;34651.30697386088;34723.82638086793;35055.82472087623;46460;49088.5091149084;49457.752711236215;49532;49670;7140.5358651687475;7244.963775181091;7328.706851725871;7338.889916651147;7421.2949769771785;10135;10903.727406814893;10945.45272736376;10949.671509854717;11210;8698.26064784475;8808;9151.450912945245;9174.495402752913;9366.906330936876;9526;9769;9823.361481503965;9836.852447213154;10046.447445390573;9084.727458176265;9146.58840352199;9540.618375264912;9706.320557560903;9916.752081198028;6945.75689850873;7089.397401220954;7116.3951064158055;7129.180144283474;7234.385077268491;7783.416243781852;8713.215810576825;8815.911840881508;8874.156955089256;9159.313051521029 10:39:14 INFO - PROCESS | 22212 | |3;mootools.html;1067.412922892409;1420.602231375215;1443.0908527627594;1501.3994402239102;1725.5599822045385;6901.344372284631;7572.129205141404;7815.960920195391;7825.804354891131;8072.959635201831;7784.649690763915;7928.326092282163;7933.960330198355;7939.880901786478;7942.523448593089;1874.8500119990435;2139.5399989002362;2207.1612787140866;2234.8267159741104;2281.4752606900424;2281.4752606900424;2303.585354636165;2305.3775480620225;2305.7924786769186;2309.5265470578493;2223.3441134865175;2228.2312602152233;2265.63749800032;2267.6598510223434;2269.602819506588;1748.615304632985;2059.2792522617115;2109.198504568262;2117.2801247575744;2121.066730638514;2154.709114269569;2166.1876796201423;2168.7072245247005;2173.2936795541514;2174.239016344283;7811.257930496594;7859;7865.6067196640515;7866.213378662145;7868.803279917991;4578.771061446914;4722.787474563653;4730.408698912636;4732.077244937239;4735.313379559944;2794.1058861164433;2822;2932.4868148074;2957.275467510474;2959.4525012872473;914.9725508234764;922.294444749767;937.5827756648295;949.2548349545642;969.8787651543557;10857.51141198648;10898.673039808738;10899.073578745816;10924.617638382699;10927.508262128224;4173.8956526087095;4233.322668373107;4291.2275790358035;4325.632321252729;4333.306670932636;9268.443893366419;9287.303452241109;9294.163525282756;9296.39573427725;9304.627814887328;4547.3406356078185;4548.658850586219;4551.2717965126085;4556.066006468666;4557.293619488984;3543.273628906068;4167.562405947392;4299.742015479019;4310.073334233155;4362.411074504965;3560.537130173061;3656.43325284576;3668.4313931340685;3701.056230661164;3833.50164478616;1174.230878774387;1209.38925842449;1211.8242854786006;1219.1283232488813;1234.1916044990546;653.9607623542507;747.8130467383154;779.2052106851094;808.2564041082219;810.793247721839;4772.785224664898;4837.008413275341;4883.072216278895;4981.825636102719;4990.326305948723;386.97837708449714;395.81001119462246;398.61732736573214;402.1614932864951;410.4991909869954;3269.084656296241;3444.156181735441;3527.4532447470683;3590.4075827488173;3606.6032736398975;9876.617273581704;10100.191984641211;10110.191184705205;10122.089011988955;10156.593736250616;9831.213502919749;10054.095131438205;10059.346142500714;10061.144802691706;10066.295359324924;7236.276372362827;7420.703171873065;7433.962830185815;7437.85124297511;7438.7024519019715;4924.63065270099;5006.749662516932;5159.122949098737;5179.404368497671;5187.403448603459;8771.517566533901;8872.911270887467;8916.598753055998;8957.10428957099;9002.279817614706;8990.955045224731;9066.093390661144;9105;9125.269978401579;9134.451932884049;6509.088727578048;6685.465162786868;6758.053872457762;6759.864802704017;6793.286704895915;7616.771496855104;7630.7329243476215;7662.8084297893;7669.6548655309525;7706.499077559941;6541.836454088686;6687.063811066552;6714.664266786739;6789.2192397872905;6856.314368563104;6592;6625.503087268377;6717.664116794043;6789.762358317633;6794.660266986532;6080.087986801838;6080.087986801838;6085.300190477975;6100.816975490742;6117.816465506042;4444.799984000663;4472.195004899149;4492.663050271308;4540.977295113504;4553.931691024571;4219.282721937339;4321.157374312104;4369.279068953587;4378.584034516716;4406.052698669801 10:39:14 INFO - PROCESS | 22212 | |4;prototype.html;303.3689924956092;306.4789857242687;309.1421305876193;312.3846023334034;315.16952829294803;4784.40194975628;4913.82801601944;4917;4919.4749627615465;4925.138100832358;4833.371661683985;4843.346148269982;4845.854624361275;4847.563719265266;4875.146849301375;3567.375709250877;3691.8154092295413;3718.6467285607823;3798.4492248623933;3822.7706337619693;3775.660190582847;3788.9431658525145;3802.3345914464994;3804.6766024887916;3807.2956503046885;3555.768875023115;3744.9438258426144;3780.3537523733357;3781.394976803712;3798.9810050949845;3645.908852278688;3778.9622103778884;3783.243351329745;3785.9810700946596;3793.2603142387247;3337.7496687748517;3347.828260108967;3349.765516413852;3355.2115252915546;3363.478660807554;4589.724616523019;4600.654950878664;4602.378678878342;4608.1705293047235;4608.838690645811;4210.894727631803;4304.182205380967;4306.224879521685;4329.588689074533;4349;4982.725950072744;4998.700077995332;5026.29631851541;5030.974845125787;5050.747462626854;3677.6506231907924;3681.2269423420844;3691.667749902522;3695.9630403696156;3704.2221133561984;4972.975135124301;5252.1596544552685;5260.1583746600745;5352.7348317526275;5355.6251062425645;3543.574771027442;3556.794787231881;3568.429051351823;3570.1788588624763;3585.71314294861;3592.832329492925;3607.0441333046765;3631.455281707765;3634.109643137448;3647.635236476331;4169.603887630731;4189.895252618648;4225.598568136023;4227.534971153171;4236.406903033578;4818.494058123917;5000.299958005882;5036.169032109734;5036.84889453317;5054.191329387354;1233.2970206982113;1235.4749231576543;1235.6601934468092;1236.9690757731128;1242.6458459339044;786.8937693411431;814.470594113819;898.2364989758653;919.8318135967284;921.1249313152398;4329.523752387235;4439.267520859086;4455.9554404456185;4467.865964021084;4510.278355463176;5107.7446127693465;5115.693058416507;5132.358455193101;5145.228215767665;5180.912008478262;4204.3693445982735;4387.517373088957;4416.867493975186;4417.271150260235;4429.623482004002;2705.770009549171;2744.3687951771203;2748.2167582239367;2751.4222013377016;2758.7655049320633;4850.223964165716;4858.368412106474;4866.148424025781;4871.756412179377;4872.926906096412;5064.898702025939;5208.192730126836;5209.166533354721;5236.869078272997;5285.524302812765;4796;4801.135795556764;4815.951840481691;4817.9518204818205;4826.7827947742435;5070.923936140887;5080;5084.745762711924;5110.029094472038;5114.79540818378;4792.976035119802;4969.304297398295;5033.39599248078;5033.6476446648385;5034.899302013866;4766.356541866942;4767.687671479399;4783.756223381876;4795.904081918272;4797.361451201895;3762.6989840813217;3773.2830762155104;3781.489498917721;3786.9621303786607;3794.79128647927;4836.637252206028;5034.546890779848;5149.639525233348;5154.226865970135;5170.27616133734;4902.2156454967035;4903.436104847988;4903.730294833818;4910.74775932135;4919.311296418433;4904.871879467671;4909.4845041270155;4914.434839993303;4933.161362568444;4947.678400903929;4580.954190458053;4827.541383568555;4867.975660121677;4880.194767863263;4883.560479556857;4792.185328494234;4912.92630610534;5032.18197809228;5032.974835125948;5034.043531728959;4863.781129849094;4934.938988117572;4957.504249575014;4957.876053098701;4960.809405742523 10:39:14 INFO - PROCESS | 22212 | |5;yui.html;714.8641758065967;739.6338812287918;748.6743266678999;772.1776308231733;780.102881686061;11626.941865290672;12445.68885777856;12907.741845163102;13115.606531804062;13150.539731109413;11833.290002599828;11888.405579721022;11905.226160299575;11913.821292680617;11928.403579821017;473.8957429365534;479.161467431994;781.1758594682622;801.0227522422664;802.4302745050992;773.7949443397476;797.5613412623034;797.696875187428;797.9865570725176;798.0941631248517;834.4117397234966;835.2733122183678;841.4026041510505;841.8190089130836;842.0232530264894;499.116563682284;805.2269820971874;831.0152469323871;837.5728378526965;837.5979529825718;603.9909401358983;604.0395770724525;604.4620287943734;604.7550741949517;604.8487878030493;12547.686307842378;12551.184173028723;12552.937235313764;12555.183913045714;12566;11285.492152853141;11459.541618335257;11714.414279286002;12150;12307;10959.178061645409;11168.720781980515;11311.547538098466;11376.976072153546;11447.542098316057;3991.7405368650943;4060.147369052473;4074.653654439376;4108.958910410917;4177.26897792885;45847.541524584994;46206;46269.76865115687;46272;46414.07171856578;8828.911710882809;9168.358214925025;9218;9254.537273136317;9404.576794044284;15616.063036217864;15643.843561564467;15719.449819256271;15727.562227854702;15744;6516.771912983023;6558.213014438298;6602.1747281589805;6644.833879152963;6678.799636010927;3798.8290526926353;3807.7144214183495;3855.20968201518;3866.7486613370043;3924.980375098163;2797.482465743844;2871.124307086359;2880.8847646093923;2881.0492537462587;2882.3514709190686;517.3998162131984;519.6336582709181;533.2135100726475;533.5145018033571;535.3067777228498;407.66978747214256;432.8290325321543;543.2259030881057;562.7383266780967;572.5534083414859;6852.143482064742;7043.823904402431;7122.501424900207;7124.109486314211;7325.2308507607;466.4402716739926;490.7546226886557;490.79631952739925;524.0096218147704;548.7759413446005;3264.9836750816094;3362.4115779738936;3374.6962773350024;3381.1716129547926;3439.398105331557;46709.29936050962;48175.27737083947;51293.48706512887;51565.48434515607;51784.74107629438;46787.76606117016;48302.75848620734;48345.5165448341;48780.75609622;48788;43901.56098438975;44245.778771105935;44293.33559996603;44735;44963.77518112454;7627.580483073484;7902.288794008567;7921.32668723142;7930.722424715107;7989.161138080651;29695;30111.54832677468;31137.53293700551;31469.685303146674;31640;38722.2255554893;39650.2069958605;39931;40576.391354130305;40731.796341018104;9759.60961561558;10397;10466.319689220176;10660.786784264426;10773.461326933466;11449;11927.642170734893;12098.213616114925;12259.816102758645;12533.122681412578;10146.391216527032;10158.644447444303;10230.539625716712;10382.42896640692;10754.085902698045;10920.890791091988;11004.724881878017;11049.17131215146;11087.279326843729;11213.887861121284;10017.5492102857;10028.799424011624;10044.899551004397;11031.944840275748;11215.49530271156;8995.640174392951;9197.396098134663;9407.4825884577;9596.712098637052;9810.901890980998;9014.774630634025;9021.954890225506;9139.405938613969;9240.584173712065;9350.392224505385 10:39:14 INFO - PROCESS | 22212 | __end_tp_report 10:39:14 INFO - PROCESS | 22212 | __start_cc_report 10:39:14 INFO - PROCESS | 22212 | _x_x_mozilla_cycle_collect,1098 10:39:14 INFO - PROCESS | 22212 | __end_cc_report 10:39:14 INFO - PROCESS | 22212 | __startTimestamp1464284354919__endTimestamp 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | ------- Summary: start ------- 10:39:14 INFO - PROCESS | 22212 | Number of tests: 6 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | [#0] dojo.html Cycles:165 Average:4749.47 Median:4883.73 stddev:500.23 (10.2%) stddev-sans-first:474.53 10:39:14 INFO - PROCESS | 22212 | Values: 2674.3 2689.3 2724.0 2727.5 2743.3 4671.2 4673.5 4729.1 4731.1 4795.3 4748.9 4763.3 4782.8 4787.1 4860.1 4312.5 4331.4 4342.9 4449.3 4479.5 4429.8 4474.0 4529.3 4547.8 4565.7 4312.2 4342.5 4476.6 4518.0 4523.7 4396.9 4399.8 4404.0 4408.2 4416.1 4383.0 4384.8 4385.1 4388.3 4395.7 4653.7 4678.5 4688.2 4707.5 4760.7 5064.6 5081.1 5129.8 5152.4 5197.1 5023.0 5174.4 5238.7 5252.3 5262.9 4796.1 4826.2 4832.1 4907.3 4914.2 5359.8 5384.5 5399.0 5407.5 5421.9 4877.9 4993.8 5169.8 5172.4 5173.1 5137.9 5152.9 5169.5 5186.2 5188.4 5010.7 5016.6 5028.0 5030.5 5096.2 4928.7 4999.3 5024.4 5036.7 5038.7 4327.3 4354.1 4354.2 4362.8 4392.5 3773.8 3781.5 3785.5 3826.3 3830.2 4336.1 4384.2 4404.6 4443.0 4448.4 5062.7 5097.1 5111.3 5147.6 5199.2 4394.7 4417.8 4430.7 4437.1 4461.9 4554.1 4647.4 4658.7 4670.0 4719.1 4797.7 4837.0 4850.9 4873.1 4907.6 5206.7 5212.2 5212.5 5223.3 5271.9 4690.6 4764.6 4874.3 4883.7 4886.5 5032.3 5061.9 5076.6 5086.6 5123.4 5139.1 5155.8 5161.2 5162.6 5177.0 4805.4 4938.9 4962.6 4992.2 5007.9 5004.2 5007.2 5023.7 5030.0 5060.2 4947.8 4949.1 4995.9 4997.3 5011.7 4932.7 5001.0 5014.9 5028.6 5108.9 4955.5 4966.2 4974.3 4979.5 5039.6 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | [#1] ext.html Cycles:180 Average:46096.36 Median:38438.91 stddev:82922.63 (215.7%) stddev-sans-first:83084.75 10:39:14 INFO - PROCESS | 22212 | Values: 554.2 562.2 565.9 586.2 607.3 40516.4 41456.6 41633.4 41662.4 46167.8 42222.8 42782.1 42813.6 42834.1 42887.6 7803.3 7942.6 7945.0 7965.2 7966.4 7828.0 7913.0 7923.0 7924.2 7924.8 7929.5 7949.9 7969.7 7971.6 7976.3 7862.4 7906.1 7907.6 7911.8 7912.8 7849.1 7906.7 7920.9 7923.7 7925.5 39018.0 39383.2 39401.8 39417.4 39424.4 2956.5 3059.8 3221.9 3663.2 3720.6 30072.2 30204.8 30435.5 30511.2 30990.7 3278.9 3368.0 3455.4 3461.8 3462.4 246958.0 247821.0 249222.0 249424.0 249662.0 32695.5 57210.7 57428.7 57460.4 57496.0 32616.3 34471.5 34481.5 34503.5 34575.8 12648.7 12864.8 12867.0 12870.5 12891.4 9763.1 9866.4 9866.6 9877.8 9900.1 7948.7 7958.6 7966.4 8014.1 8037.4 3125.6 3139.3 3143.5 3156.4 3200.4 904.8 951.6 967.3 1007.5 1037.1 28433.1 28459.7 28754.9 28910.1 28952.4 684.4 951.2 987.6 1089.2 1099.0 14786.9 14976.9 14978.9 15158.8 15219.4 390568.0 393499.0 394382.0 395043.0 395350.0 51396.7 51911.7 52012.2 52051.5 52058.2 963.0 1162.7 1210.7 1219.8 1232.9 28449.0 29465.4 29625.0 29650.6 30124.5 42584.1 42652.8 43213.8 43238.0 43258.8 281566.0 281882.0 282776.0 283267.0 284354.0 20566.2 25038.9 25757.5 25767.5 27235.5 42981.8 43203.6 43256.6 43681.0 44357.8 36701.4 37330.4 37682.6 37858.6 37859.8 36445.5 37116.3 37389.0 37564.6 37579.4 36141.6 36423.0 39388.0 40140.6 40257.2 32047.7 33800.7 33944.7 34608.5 34661.1 25132.2 25714.9 25852.0 25895.6 26031.2 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | [#2] jquery.html Cycles:180 Average:22865.83 Median:5265.55 stddev:59944.27 (1138.4%) stddev-sans-first:60088.61 10:39:14 INFO - PROCESS | 22212 | Values: 355.8 356.1 361.4 366.8 375.3 15614.5 16981.5 17177.7 17496.8 17518.4 15929.5 16805.7 17487.3 17544.4 17551.8 4910.0 4936.4 4940.2 5086.9 5092.3 3590.5 3763.1 4967.6 5438.8 5746.1 5784.4 5786.8 5800.9 5803.6 5804.0 5609.7 5726.8 5730.5 5826.8 5835.6 3220.5 4721.4 4945.4 5024.0 5032.6 19013.2 19663.1 19667.8 19874.8 19884.9 1964.2 2294.5 2367.1 2482.3 2519.0 12126.1 12868.7 12956.2 13162.6 13447.2 1703.9 1755.3 1826.8 1830.8 1846.1 61615.4 61954.4 62251.0 62839.4 63611.7 8763.7 9331.3 9642.9 10100.6 10605.3 12493.6 12494.6 12629.1 12685.4 12740.9 6994.7 7063.2 7104.6 7162.7 7217.5 6527.5 6651.3 6679.6 6761.2 6782.1 5731.2 5983.1 5984.4 6081.9 6152.0 1465.4 1576.2 1733.7 1739.6 1747.0 749.3 812.4 847.7 922.6 942.1 16033.5 16598.9 16786.8 17139.5 17225.1 835.4 854.9 875.5 880.8 922.0 9556.3 9693.5 9782.6 9824.1 9859.8 358904.0 361938.0 367095.0 367225.0 367356.0 63469.4 65012.0 65830.3 65867.3 66025.3 888.9 911.8 927.0 928.1 942.1 15511.8 15518.5 15597.1 15802.5 15872.6 34022.3 34145.7 34651.3 34723.8 35055.8 46460.0 49088.5 49457.8 49532.0 49670.0 7140.5 7245.0 7328.7 7338.9 7421.3 10135.0 10903.7 10945.5 10949.7 11210.0 8698.3 8808.0 9151.5 9174.5 9366.9 9526.0 9769.0 9823.4 9836.9 10046.4 9084.7 9146.6 9540.6 9706.3 9916.8 6945.8 7089.4 7116.4 7129.2 7234.4 7783.4 8713.2 8815.9 8874.2 9159.3 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | [#3] mootools.html Cycles:180 Average:5142.16 Median:4555.00 stddev:2967.94 (65.2%) stddev-sans-first:2960.46 10:39:14 INFO - PROCESS | 22212 | Values: 1067.4 1420.6 1443.1 1501.4 1725.6 6901.3 7572.1 7816.0 7825.8 8073.0 7784.6 7928.3 7934.0 7939.9 7942.5 1874.9 2139.5 2207.2 2234.8 2281.5 2281.5 2303.6 2305.4 2305.8 2309.5 2223.3 2228.2 2265.6 2267.7 2269.6 1748.6 2059.3 2109.2 2117.3 2121.1 2154.7 2166.2 2168.7 2173.3 2174.2 7811.3 7859.0 7865.6 7866.2 7868.8 4578.8 4722.8 4730.4 4732.1 4735.3 2794.1 2822.0 2932.5 2957.3 2959.5 915.0 922.3 937.6 949.3 969.9 10857.5 10898.7 10899.1 10924.6 10927.5 4173.9 4233.3 4291.2 4325.6 4333.3 9268.4 9287.3 9294.2 9296.4 9304.6 4547.3 4548.7 4551.3 4556.1 4557.3 3543.3 4167.6 4299.7 4310.1 4362.4 3560.5 3656.4 3668.4 3701.1 3833.5 1174.2 1209.4 1211.8 1219.1 1234.2 654.0 747.8 779.2 808.3 810.8 4772.8 4837.0 4883.1 4981.8 4990.3 387.0 395.8 398.6 402.2 410.5 3269.1 3444.2 3527.5 3590.4 3606.6 9876.6 10100.2 10110.2 10122.1 10156.6 9831.2 10054.1 10059.3 10061.1 10066.3 7236.3 7420.7 7434.0 7437.9 7438.7 4924.6 5006.7 5159.1 5179.4 5187.4 8771.5 8872.9 8916.6 8957.1 9002.3 8991.0 9066.1 9105.0 9125.3 9134.5 6509.1 6685.5 6758.1 6759.9 6793.3 7616.8 7630.7 7662.8 7669.7 7706.5 6541.8 6687.1 6714.7 6789.2 6856.3 6592.0 6625.5 6717.7 6789.8 6794.7 6080.1 6080.1 6085.3 6100.8 6117.8 4444.8 4472.2 4492.7 4541.0 4553.9 4219.3 4321.2 4369.3 4378.6 4406.1 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | [#4] prototype.html Cycles:180 Average:4153.96 Median:4792.58 stddev:1194.94 (24.9%) stddev-sans-first:1162.82 10:39:14 INFO - PROCESS | 22212 | Values: 303.4 306.5 309.1 312.4 315.2 4784.4 4913.8 4917.0 4919.5 4925.1 4833.4 4843.3 4845.9 4847.6 4875.1 3567.4 3691.8 3718.6 3798.4 3822.8 3775.7 3788.9 3802.3 3804.7 3807.3 3555.8 3744.9 3780.4 3781.4 3799.0 3645.9 3779.0 3783.2 3786.0 3793.3 3337.7 3347.8 3349.8 3355.2 3363.5 4589.7 4600.7 4602.4 4608.2 4608.8 4210.9 4304.2 4306.2 4329.6 4349.0 4982.7 4998.7 5026.3 5031.0 5050.7 3677.7 3681.2 3691.7 3696.0 3704.2 4973.0 5252.2 5260.2 5352.7 5355.6 3543.6 3556.8 3568.4 3570.2 3585.7 3592.8 3607.0 3631.5 3634.1 3647.6 4169.6 4189.9 4225.6 4227.5 4236.4 4818.5 5000.3 5036.2 5036.8 5054.2 1233.3 1235.5 1235.7 1237.0 1242.6 786.9 814.5 898.2 919.8 921.1 4329.5 4439.3 4456.0 4467.9 4510.3 5107.7 5115.7 5132.4 5145.2 5180.9 4204.4 4387.5 4416.9 4417.3 4429.6 2705.8 2744.4 2748.2 2751.4 2758.8 4850.2 4858.4 4866.1 4871.8 4872.9 5064.9 5208.2 5209.2 5236.9 5285.5 4796.0 4801.1 4816.0 4818.0 4826.8 5070.9 5080.0 5084.7 5110.0 5114.8 4793.0 4969.3 5033.4 5033.6 5034.9 4766.4 4767.7 4783.8 4795.9 4797.4 3762.7 3773.3 3781.5 3787.0 3794.8 4836.6 5034.5 5149.6 5154.2 5170.3 4902.2 4903.4 4903.7 4910.7 4919.3 4904.9 4909.5 4914.4 4933.2 4947.7 4581.0 4827.5 4868.0 4880.2 4883.6 4792.2 4912.9 5032.2 5033.0 5034.0 4863.8 4934.9 4957.5 4957.9 4960.8 10:39:14 INFO - PROCESS | 22212 | 10:39:14 INFO - PROCESS | 22212 | [#5] yui.html Cycles:180 Average:12750.75 Median:45405.66 stddev:14618.35 (32.2%) stddev-sans-first:14631.42 10:39:14 INFO - PROCESS | 22212 | Values: 714.9 739.6 748.7 772.2 780.1 11626.9 12445.7 12907.7 13115.6 13150.5 11833.3 11888.4 11905.2 11913.8 11928.4 473.9 479.2 781.2 801.0 802.4 773.8 797.6 797.7 798.0 798.1 834.4 835.3 841.4 841.8 842.0 499.1 805.2 831.0 837.6 837.6 604.0 604.0 604.5 604.8 604.8 12547.7 12551.2 12552.9 12555.2 12566.0 11285.5 11459.5 11714.4 12150.0 12307.0 10959.2 11168.7 11311.5 11377.0 11447.5 3991.7 4060.1 4074.7 4109.0 4177.3 45847.5 46206.0 46269.8 46272.0 46414.1 8828.9 9168.4 9218.0 9254.5 9404.6 15616.1 15643.8 15719.4 15727.6 15744.0 6516.8 6558.2 6602.2 6644.8 6678.8 3798.8 3807.7 3855.2 3866.7 3925.0 2797.5 2871.1 2880.9 2881.0 2882.4 517.4 519.6 533.2 533.5 535.3 407.7 432.8 543.2 562.7 572.6 6852.1 7043.8 7122.5 7124.1 7325.2 466.4 490.8 490.8 524.0 548.8 3265.0 3362.4 3374.7 3381.2 3439.4 46709.3 48175.3 51293.5 51565.5 51784.7 46787.8 48302.8 48345.5 48780.8 48788.0 43901.6 44245.8 44293.3 44735.0 44963.8 7627.6 7902.3 7921.3 7930.7 7989.2 29695.0 30111.5 31137.5 31469.7 31640.0 38722.2 39650.2 39931.0 40576.4 40731.8 9759.6 10397.0 10466.3 10660.8 10773.5 11449.0 11927.6 12098.2 12259.8 12533.1 10146.4 10158.6 10230.5 10382.4 10754.1 10920.9 11004.7 11049.2 11087.3 11213.9 10017.5 10028.8 10044.9 11031.9 11215.5 8995.6 9197.4 9407.5 9596.7 9810.9 9014.8 9022.0 9139.4 9240.6 9350.4 10:39:14 INFO - PROCESS | 22212 | -------- Summary: end -------- 10:39:14 INFO - PROCESS | 22212 | 10:39:15 INFO - TEST-INFO | 22212: exit 0 10:39:15 INFO - TEST-OK | dromaeo_css | took 1124075ms 10:39:15 INFO - TEST-START | kraken 10:39:15 INFO - operating with platform_type : linux_ 10:39:15 INFO - Initialising browser for kraken test... 10:39:15 INFO - TEST-INFO | started process 22386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKec8C/profile http://localhost:34630/getInfo.html) 10:39:21 INFO - PROCESS | 22386 | __metrics Screen width/height:1600/1200 10:39:21 INFO - PROCESS | 22386 | colorDepth:24 10:39:21 INFO - PROCESS | 22386 | Browser inner width/height: 1024/697 10:39:21 INFO - PROCESS | 22386 | __metrics 10:39:23 ERROR - PROCESS | 22386 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:39:24 INFO - TEST-INFO | 22386: exit 0 10:39:24 INFO - Browser initialized. 10:39:24 INFO - Running cycle 1/1 for kraken test... 10:39:24 INFO - TEST-INFO | started process 22469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKec8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:36 INFO - PROCESS | 22469 | RSS: Main: 156364800 10:39:36 INFO - PROCESS | 22469 | 10:39:39 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34630/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:40 INFO - PROCESS | 22469 | RSS: Main: 212389888 10:39:40 INFO - PROCESS | 22469 | 10:39:43 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34630/tests/kraken/driver.html?testName=audio-dft) 10:39:43 INFO - PROCESS | 22469 | RSS: Main: 200818688 10:39:43 INFO - PROCESS | 22469 | 10:39:47 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34630/tests/kraken/driver.html?testName=audio-fft) 10:39:47 INFO - PROCESS | 22469 | RSS: Main: 269090816 10:39:47 INFO - PROCESS | 22469 | 10:39:50 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34630/tests/kraken/driver.html?testName=audio-oscillator) 10:39:50 INFO - PROCESS | 22469 | RSS: Main: 179871744 10:39:50 INFO - PROCESS | 22469 | 10:39:52 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:53 INFO - PROCESS | 22469 | RSS: Main: 182951936 10:39:53 INFO - PROCESS | 22469 | 10:39:56 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34630/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:57 INFO - PROCESS | 22469 | RSS: Main: 218509312 10:39:57 INFO - PROCESS | 22469 | 10:40:00 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34630/tests/kraken/driver.html?testName=imaging-desaturate) 10:40:01 INFO - PROCESS | 22469 | RSS: Main: 216293376 10:40:01 INFO - PROCESS | 22469 | 10:40:04 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34630/tests/kraken/driver.html?testName=json-parse-financial) 10:40:04 INFO - PROCESS | 22469 | RSS: Main: 217907200 10:40:04 INFO - PROCESS | 22469 | 10:40:06 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:40:07 INFO - PROCESS | 22469 | RSS: Main: 204779520 10:40:07 INFO - PROCESS | 22469 | 10:40:09 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:40:09 INFO - PROCESS | 22469 | RSS: Main: 209522688 10:40:09 INFO - PROCESS | 22469 | 10:40:11 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:12 INFO - PROCESS | 22469 | RSS: Main: 218279936 10:40:12 INFO - PROCESS | 22469 | 10:40:15 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:15 INFO - PROCESS | 22469 | RSS: Main: 226545664 10:40:15 INFO - PROCESS | 22469 | 10:40:18 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:19 INFO - PROCESS | 22469 | RSS: Main: 221229056 10:40:19 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:34630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34630/tests/kraken/driver.html?testName=ai-astar) 10:40:21 INFO - PROCESS | 22469 | RSS: Main: 266485760 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | __start_tp_report 10:40:21 INFO - PROCESS | 22469 | _x_x_mozilla_page_load 10:40:21 INFO - PROCESS | 22469 | _x_x_mozilla_page_load_details 10:40:21 INFO - PROCESS | 22469 | |i|pagename|runs| 10:40:21 INFO - PROCESS | 22469 | |0;ai-astar;113;108;114;117;113;113;114;113;113;113 10:40:21 INFO - PROCESS | 22469 | |1;audio-beat-detection;159;133;132;164;131;174;155;131;185;129 10:40:21 INFO - PROCESS | 22469 | |2;audio-dft;161;160;160;159;159;162;161;161;161;161 10:40:21 INFO - PROCESS | 22469 | |3;audio-fft;75;75;75;121;76;76;76;75;133;75 10:40:21 INFO - PROCESS | 22469 | |4;audio-oscillator;84;84;124;84;84;84;115;84;84;125 10:40:21 INFO - PROCESS | 22469 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;117;117 10:40:21 INFO - PROCESS | 22469 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 10:40:21 INFO - PROCESS | 22469 | |7;imaging-desaturate;95;95;95;96;94;95;95;95;95;95 10:40:21 INFO - PROCESS | 22469 | |8;json-parse-financial;66;67;66;67;66;66;68;86;64;64 10:40:21 INFO - PROCESS | 22469 | |9;json-stringify-tinderbox;66;65;66;66;65;66;66;65;65;65 10:40:21 INFO - PROCESS | 22469 | |10;stanford-crypto-aes;89;87;83;89;85;83;84;84;83;82 10:40:21 INFO - PROCESS | 22469 | |11;stanford-crypto-ccm;135;141;127;128;127;130;129;132;167;131 10:40:21 INFO - PROCESS | 22469 | |12;stanford-crypto-pbkdf2;169;175;170;169;170;174;170;171;168;172 10:40:21 INFO - PROCESS | 22469 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;67;65;64;68;66 10:40:21 INFO - PROCESS | 22469 | __end_tp_report 10:40:21 INFO - PROCESS | 22469 | __start_cc_report 10:40:21 INFO - PROCESS | 22469 | _x_x_mozilla_cycle_collect,1877 10:40:21 INFO - PROCESS | 22469 | __end_cc_report 10:40:21 INFO - PROCESS | 22469 | __startTimestamp1464284421464__endTimestamp 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | ------- Summary: start ------- 10:40:21 INFO - PROCESS | 22469 | Number of tests: 14 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:2.18 (1.9%) stddev-sans-first:2.32 10:40:21 INFO - PROCESS | 22469 | Values: 113.0 108.0 114.0 117.0 113.0 113.0 114.0 113.0 113.0 113.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:157.00 stddev:20.75 (13.2%) stddev-sans-first:21.71 10:40:21 INFO - PROCESS | 22469 | Values: 159.0 133.0 132.0 164.0 131.0 174.0 155.0 131.0 185.0 129.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 10:40:21 INFO - PROCESS | 22469 | Values: 161.0 160.0 160.0 159.0 159.0 162.0 161.0 161.0 161.0 161.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#3] audio-fft Cycles:10 Average:85.70 Median:75.00 stddev:21.95 (29.3%) stddev-sans-first:22.94 10:40:21 INFO - PROCESS | 22469 | Values: 75.0 75.0 75.0 121.0 76.0 76.0 76.0 75.0 133.0 75.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.00 stddev:18.22 (21.7%) stddev-sans-first:18.87 10:40:21 INFO - PROCESS | 22469 | Values: 84.0 84.0 124.0 84.0 84.0 84.0 115.0 84.0 84.0 125.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:40:21 INFO - PROCESS | 22469 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:40:21 INFO - PROCESS | 22469 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:40:21 INFO - PROCESS | 22469 | Values: 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:66.50 stddev:6.45 (9.7%) stddev-sans-first:6.80 10:40:21 INFO - PROCESS | 22469 | Values: 66.0 67.0 66.0 67.0 66.0 66.0 68.0 86.0 64.0 64.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:40:21 INFO - PROCESS | 22469 | Values: 66.0 65.0 66.0 66.0 65.0 66.0 66.0 65.0 65.0 65.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.56 (3.0%) stddev-sans-first:2.24 10:40:21 INFO - PROCESS | 22469 | Values: 89.0 87.0 83.0 89.0 85.0 83.0 84.0 84.0 83.0 82.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:131.50 stddev:12.12 (9.2%) stddev-sans-first:12.85 10:40:21 INFO - PROCESS | 22469 | Values: 135.0 141.0 127.0 128.0 127.0 130.0 129.0 132.0 167.0 131.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:170.50 stddev:2.25 (1.3%) stddev-sans-first:2.29 10:40:21 INFO - PROCESS | 22469 | Values: 169.0 175.0 170.0 169.0 170.0 174.0 170.0 171.0 168.0 172.0 10:40:21 INFO - PROCESS | 22469 | 10:40:21 INFO - PROCESS | 22469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 10:40:21 INFO - PROCESS | 22469 | Values: 68.0 66.0 67.0 67.0 66.0 67.0 65.0 64.0 68.0 66.0 10:40:21 INFO - PROCESS | 22469 | -------- Summary: end -------- 10:40:21 INFO - PROCESS | 22469 | 10:40:22 INFO - TEST-INFO | 22469: exit 0 10:40:22 INFO - TEST-OK | kraken | took 66850ms 10:40:22 INFO - SUITE-END | took 1190s 10:40:23 INFO - Completed test suite (00:19:51) 10:40:23 INFO - javascript benchmark 10:40:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.277944954862, 2689.3411114277005, 2723.9863800681005, 2727.5363188257993, 2743.300458383112, 4671.159191345557, 4673.462551806543, 4729.1251118543005, 4731.148393289211, 4795.280707893818, 4748.881277968053, 4763.333133361323, 4782.83260085897, 4787.114383838993, 4860.1494738420815, 4312.547182545834, 4331.43691320128, 4342.913141737164, 4449.26587113126, 4479.507254202035, 4429.822807087713, 4474.0380818124095, 4529.297958816389, 4547.7953492092765, 4565.703229290102, 4312.159128969852, 4342.457192850894, 4476.641868650533, 4517.954820451786, 4523.7285762854335, 4396.934045989313, 4399.824007039714, 4404.0, 4408.162449134654, 4416.138852923681, 4382.956170438287, 4384.758838263894, 4385.1229754049, 4388.253996820548, 4395.7142785718825, 4653.6509761768, 4678.508756580544, 4688.226442636961, 4707.529247075299, 4760.714357138583, 5064.645474816764, 5081.085404627165, 5129.769160387791, 5152.433232344477, 5197.064528384889, 5023.045621331935, 5174.404943431516, 5238.68567885928, 5252.3171987641745, 5262.947370526284, 4796.136695394827, 4826.1795494765975, 4832.106060378841, 4907.33750943618, 4914.164592019365, 5359.812406565751, 5384.515393614593, 5399.0, 5407.540359069444, 5421.945780542223, 4877.902441951142, 4993.825216117419, 5169.767360468788, 5172.379314482211, 5173.120569503193, 5137.922931156036, 5152.92270615941, 5169.508896654812, 5186.247994040843, 5188.429272779991, 5010.674306170087, 5016.648834581617, 5028.044671512401, 5030.471800460972, 5096.184610462308, 4928.654994150446, 4999.250112483084, 5024.447310795809, 5036.722980236049, 5038.672486288453, 4327.307630779061, 4354.107407981356, 4354.172707185625, 4362.847300344472, 4392.494863090722, 3773.7924414156937, 3781.5273090863643, 3785.488958990556, 3826.330392181357, 3830.157365379612, 4336.111097225062, 4384.188925048876, 4404.6035856772405, 4442.955570444255, 4448.377227188196, 5062.7468626568525, 5097.057044446789, 5111.284420181178, 5147.562457191106, 5199.194124910645, 4394.714343567658, 4417.8232870684815, 4430.712003719748, 4437.134758722083, 4461.933071003938, 4554.089182163514, 4647.37260469839, 4658.67389282747, 4669.976650116796, 4719.056188762262, 4797.688150270221, 4837.032593481388, 4850.854474365775, 4873.147199240189, 4907.631927605516, 5206.739663016759, 5212.166053431432, 5212.50481204285, 5223.2948551945, 5271.868203294948, 4690.6247500199215, 4764.618830493621, 4874.317595536699, 4883.731394773322, 4886.53577910098, 5032.345795046621, 5061.898762024665, 5076.593872490266, 5086.61850361217, 5123.410807757155, 5139.100657384868, 5155.767990440514, 5161.22581612746, 5162.6386152970435, 5177.042247184283, 4805.399325084364, 4938.851834444972, 4962.602991760723, 4992.176290911959, 5007.899842003212, 5004.174311238605, 5007.24891266313, 5023.723695196799, 5030.0, 5060.1903695408555, 4947.752612369295, 4949.133901567283, 4995.875103122451, 4997.3253610762085, 5011.699298042129, 4932.679375840559, 5000.974995125001, 5014.874628134326, 5028.622853285945, 5108.9233661495855, 4955.479674634112, 4966.155753521838, 4974.303597496281, 4979.452260251297, 5039.622028347815], "value": 4717.755548926582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2406902543519, 562.2072877243088, 565.9094544872821, 586.1939832729996, 607.283405581414, 40516.392254116174, 41456.58543414565, 41633.375499367496, 41662.37506437402, 46167.769161154145, 42222.788886055605, 42782.14435711284, 42813.571864281344, 42834.14331713364, 42887.57112428875, 7803.258690424401, 7942.602869856513, 7945.0, 7965.163657815933, 7966.44234903557, 7828.0, 7912.960435197845, 7923.049234091917, 7924.167962363956, 7924.762257132266, 7929.524228546276, 7949.880751788728, 7969.681212751483, 7971.601419929009, 7976.322012628904, 7862.410319226053, 7906.051273847175, 7907.644156012964, 7911.762647120596, 7912.802179945518, 7849.097353804328, 7906.723264685708, 7920.881186782203, 7923.72266970659, 7925.484843485155, 39018.0, 39383.21233575341, 39401.80299098486, 39417.40873886894, 39424.40863387052, 2956.49739544278, 3059.832973333474, 3221.882073731358, 3663.1757854482794, 3720.5907350191455, 30072.248193795112, 30204.84897575498, 30435.543466848016, 30511.23721906948, 30990.690093099005, 3278.852451639682, 3367.966320336814, 3455.36075825973, 3461.7749846259912, 3462.4460086386057, 246958.0, 247821.0, 249222.0, 249423.9999999982, 249662.0, 32695.50956735651, 57210.713946430835, 57428.71285643545, 57460.425395746344, 57496.0, 32616.347673046406, 34471.4829277561, 34481.482777758356, 34503.4824477633, 34575.827120864735, 12648.747025059447, 12864.807027894589, 12867.0, 12870.549530766566, 12891.35543222835, 9763.121319081316, 9866.358686685342, 9866.556004979793, 9877.753056173653, 9900.059494348025, 7948.682052717826, 7958.562279074591, 7966.402519811038, 8014.078380986145, 8037.357011439188, 3125.6249250090136, 3139.309351942569, 3143.512755522898, 3156.447621666199, 3200.423923693711, 904.8009437923646, 951.5860600638745, 967.3145316344749, 1007.4559737741538, 1037.0821822686826, 28433.147005589864, 28459.71540284612, 28754.856225719155, 28910.132696019155, 28952.42095158085, 684.3772167327708, 951.1629765806047, 987.5704068730125, 1089.199438412766, 1098.96153634624, 14786.92606536982, 14976.925115374353, 14978.925105374403, 15158.772618410512, 15219.412699840832, 390568.0, 393499.0, 394382.0, 395043.0, 395350.0, 51396.74301628468, 51911.74044129755, 52012.21981670278, 52051.47948520542, 52058.21912671313, 963.0, 1162.6686394377562, 1210.667066556704, 1219.8048312269993, 1232.9075319351084, 28449.0, 29465.410691785615, 29625.0, 29650.555241671824, 30124.54813177848, 42584.14831703411, 42652.78673606612, 43213.78393108014, 43238.0, 43258.78370608127, 281566.0, 281882.0, 282776.0, 283267.0, 284354.0, 20566.177352905717, 25038.874805625856, 25757.484850303263, 25767.484650306513, 27235.455290894468, 42981.785091074344, 43203.567964319955, 43256.567434325254, 43681.0, 44357.778211108736, 36701.44947825838, 37330.44004339883, 37682.62317376791, 37858.62141378661, 37859.81070094632, 36445.45331820078, 37116.25767484581, 37389.0, 37564.62435375721, 37579.436308455945, 36141.63858361488, 36423.0, 39388.0, 40140.59859401369, 40257.19485610213, 32047.679523204468, 33800.66199337975, 33944.66055339415, 34608.48087278642, 34661.13347166341, 25132.246032619052, 25714.8714256435, 25852.0, 25895.61156582615, 26031.21906342813], "value": 16716.21102053699, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8025295960742, 356.07775860521247, 361.409096127831, 366.84225782913336, 375.31130375760495, 15614.453494127707, 16981.490555283344, 17177.656446871057, 17496.82503174968, 17518.38685646001, 15929.52211433656, 16805.747913781302, 17487.300507979697, 17544.385946491875, 17551.82448175518, 4909.950900490994, 4936.35827342445, 4940.209566469365, 5086.872828179288, 5092.337996060507, 3590.533230680021, 3763.0592351912023, 4967.627427942901, 5438.755256013489, 5746.138079288098, 5784.392638772932, 5786.768529258846, 5800.883982320351, 5803.622764520293, 5804.0, 5609.747561359708, 5726.770929162829, 5730.512906402961, 5826.766929322822, 5835.562332825034, 3220.5491231227647, 4721.433427988629, 4945.357103576548, 5023.974880125613, 5032.6477146599755, 19013.239470421166, 19663.1151598177, 19667.803321966883, 19874.80125198744, 19884.900575497173, 1964.1848632817364, 2294.5066810635626, 2367.135995361698, 2482.329770961848, 2519.0301733832607, 12126.090543209206, 12868.678283042998, 12956.222626642431, 13162.60512184636, 13447.193168409829, 1703.9180120623369, 1755.2540170427517, 1826.8447181989548, 1830.7803063632316, 1846.1046392499627, 61615.38384616186, 61954.380456195315, 62251.0, 62839.371606284265, 63611.68194159046, 8763.693270735494, 9331.253499720005, 9642.903570964341, 10100.646477373257, 10605.310654807567, 12493.562725304571, 12494.625161245178, 12629.11596188258, 12685.365731713377, 12740.872591274154, 6994.68523916425, 7063.223045464994, 7104.573725576379, 7162.7493037743425, 7217.494775365779, 6527.510436717265, 6651.334866513407, 6679.599224046573, 6761.22245941723, 6782.118324617867, 5731.226284451629, 5983.132445795335, 5984.401559843981, 6081.878362432726, 6152.0, 1465.355243692793, 1576.1646327446472, 1733.699402737575, 1739.5998920248414, 1746.9912650436665, 749.2769477454283, 812.3582369927691, 847.6778824046946, 922.5710044829052, 942.0908822985851, 16033.518994430186, 16598.917005414896, 16786.832131678526, 17139.485815425556, 17225.1387430628, 835.3985130705883, 854.9016863060828, 875.5097145598485, 880.7974165941869, 921.9858156028449, 9556.283278754121, 9693.466859322805, 9782.608695652236, 9824.115829575372, 9859.802803944025, 358904.0, 361938.0, 367095.0, 367225.0, 367356.0, 63469.36530634727, 65012.0, 65830.34169658241, 65867.34132658708, 66025.33974660288, 888.8977767556685, 911.7629416351797, 926.972190834276, 928.1414691410419, 942.1002942190192, 15511.84488155104, 15518.534443966699, 15597.064176149468, 15802.525924222291, 15872.60318492047, 34022.31955360928, 34145.65854341425, 34651.30697386088, 34723.82638086793, 35055.82472087623, 46460.0, 49088.5091149084, 49457.752711236215, 49532.0, 49670.0, 7140.5358651687475, 7244.963775181091, 7328.706851725871, 7338.889916651147, 7421.2949769771785, 10135.0, 10903.727406814893, 10945.45272736376, 10949.671509854717, 11210.0, 8698.26064784475, 8808.0, 9151.450912945245, 9174.495402752913, 9366.906330936876, 9526.0, 9769.0, 9823.361481503965, 9836.852447213154, 10046.447445390573, 9084.727458176265, 9146.58840352199, 9540.618375264912, 9706.320557560903, 9916.752081198028, 6945.75689850873, 7089.397401220954, 7116.3951064158055, 7129.180144283474, 7234.385077268491, 7783.416243781852, 8713.215810576825, 8815.911840881508, 8874.156955089256, 9159.313051521029], "value": 8053.669887868958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1067.412922892409, 1420.602231375215, 1443.0908527627594, 1501.3994402239102, 1725.5599822045385, 6901.344372284631, 7572.129205141404, 7815.960920195391, 7825.804354891131, 8072.959635201831, 7784.649690763915, 7928.326092282163, 7933.960330198355, 7939.880901786478, 7942.523448593089, 1874.8500119990435, 2139.5399989002362, 2207.1612787140866, 2234.8267159741104, 2281.4752606900424, 2281.4752606900424, 2303.585354636165, 2305.3775480620225, 2305.7924786769186, 2309.5265470578493, 2223.3441134865175, 2228.2312602152233, 2265.63749800032, 2267.6598510223434, 2269.602819506588, 1748.615304632985, 2059.2792522617115, 2109.198504568262, 2117.2801247575744, 2121.066730638514, 2154.709114269569, 2166.1876796201423, 2168.7072245247005, 2173.2936795541514, 2174.239016344283, 7811.257930496594, 7859.0, 7865.6067196640515, 7866.213378662145, 7868.803279917991, 4578.771061446914, 4722.787474563653, 4730.408698912636, 4732.077244937239, 4735.313379559944, 2794.1058861164433, 2822.0, 2932.4868148074, 2957.275467510474, 2959.4525012872473, 914.9725508234764, 922.294444749767, 937.5827756648295, 949.2548349545642, 969.8787651543557, 10857.51141198648, 10898.673039808738, 10899.073578745816, 10924.617638382699, 10927.508262128224, 4173.8956526087095, 4233.322668373107, 4291.2275790358035, 4325.632321252729, 4333.306670932636, 9268.443893366419, 9287.303452241109, 9294.163525282756, 9296.39573427725, 9304.627814887328, 4547.3406356078185, 4548.658850586219, 4551.2717965126085, 4556.066006468666, 4557.293619488984, 3543.273628906068, 4167.562405947392, 4299.742015479019, 4310.073334233155, 4362.411074504965, 3560.537130173061, 3656.43325284576, 3668.4313931340685, 3701.056230661164, 3833.50164478616, 1174.230878774387, 1209.38925842449, 1211.8242854786006, 1219.1283232488813, 1234.1916044990546, 653.9607623542507, 747.8130467383154, 779.2052106851094, 808.2564041082219, 810.793247721839, 4772.785224664898, 4837.008413275341, 4883.072216278895, 4981.825636102719, 4990.326305948723, 386.97837708449714, 395.81001119462246, 398.61732736573214, 402.1614932864951, 410.4991909869954, 3269.084656296241, 3444.156181735441, 3527.4532447470683, 3590.4075827488173, 3606.6032736398975, 9876.617273581704, 10100.191984641211, 10110.191184705205, 10122.089011988955, 10156.593736250616, 9831.213502919749, 10054.095131438205, 10059.346142500714, 10061.144802691706, 10066.295359324924, 7236.276372362827, 7420.703171873065, 7433.962830185815, 7437.85124297511, 7438.7024519019715, 4924.63065270099, 5006.749662516932, 5159.122949098737, 5179.404368497671, 5187.403448603459, 8771.517566533901, 8872.911270887467, 8916.598753055998, 8957.10428957099, 9002.279817614706, 8990.955045224731, 9066.093390661144, 9105.0, 9125.269978401579, 9134.451932884049, 6509.088727578048, 6685.465162786868, 6758.053872457762, 6759.864802704017, 6793.286704895915, 7616.771496855104, 7630.7329243476215, 7662.8084297893, 7669.6548655309525, 7706.499077559941, 6541.836454088686, 6687.063811066552, 6714.664266786739, 6789.2192397872905, 6856.314368563104, 6592.0, 6625.503087268377, 6717.664116794043, 6789.762358317633, 6794.660266986532, 6080.087986801838, 6080.087986801838, 6085.300190477975, 6100.816975490742, 6117.816465506042, 4444.799984000663, 4472.195004899149, 4492.663050271308, 4540.977295113504, 4553.931691024571, 4219.282721937339, 4321.157374312104, 4369.279068953587, 4378.584034516716, 4406.052698669801], "value": 4040.0560741080235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.3689924956092, 306.4789857242687, 309.1421305876193, 312.3846023334034, 315.16952829294803, 4784.40194975628, 4913.82801601944, 4917.0, 4919.4749627615465, 4925.138100832358, 4833.371661683985, 4843.346148269982, 4845.854624361275, 4847.563719265266, 4875.146849301375, 3567.375709250877, 3691.8154092295413, 3718.6467285607823, 3798.4492248623933, 3822.7706337619693, 3775.660190582847, 3788.9431658525145, 3802.3345914464994, 3804.6766024887916, 3807.2956503046885, 3555.768875023115, 3744.9438258426144, 3780.3537523733357, 3781.394976803712, 3798.9810050949845, 3645.908852278688, 3778.9622103778884, 3783.243351329745, 3785.9810700946596, 3793.2603142387247, 3337.7496687748517, 3347.828260108967, 3349.765516413852, 3355.2115252915546, 3363.478660807554, 4589.724616523019, 4600.654950878664, 4602.378678878342, 4608.1705293047235, 4608.838690645811, 4210.894727631803, 4304.182205380967, 4306.224879521685, 4329.588689074533, 4349.0, 4982.725950072744, 4998.700077995332, 5026.29631851541, 5030.974845125787, 5050.747462626854, 3677.6506231907924, 3681.2269423420844, 3691.667749902522, 3695.9630403696156, 3704.2221133561984, 4972.975135124301, 5252.1596544552685, 5260.1583746600745, 5352.7348317526275, 5355.6251062425645, 3543.574771027442, 3556.794787231881, 3568.429051351823, 3570.1788588624763, 3585.71314294861, 3592.832329492925, 3607.0441333046765, 3631.455281707765, 3634.109643137448, 3647.635236476331, 4169.603887630731, 4189.895252618648, 4225.598568136023, 4227.534971153171, 4236.406903033578, 4818.494058123917, 5000.299958005882, 5036.169032109734, 5036.84889453317, 5054.191329387354, 1233.2970206982113, 1235.4749231576543, 1235.6601934468092, 1236.9690757731128, 1242.6458459339044, 786.8937693411431, 814.470594113819, 898.2364989758653, 919.8318135967284, 921.1249313152398, 4329.523752387235, 4439.267520859086, 4455.9554404456185, 4467.865964021084, 4510.278355463176, 5107.7446127693465, 5115.693058416507, 5132.358455193101, 5145.228215767665, 5180.912008478262, 4204.3693445982735, 4387.517373088957, 4416.867493975186, 4417.271150260235, 4429.623482004002, 2705.770009549171, 2744.3687951771203, 2748.2167582239367, 2751.4222013377016, 2758.7655049320633, 4850.223964165716, 4858.368412106474, 4866.148424025781, 4871.756412179377, 4872.926906096412, 5064.898702025939, 5208.192730126836, 5209.166533354721, 5236.869078272997, 5285.524302812765, 4796.0, 4801.135795556764, 4815.951840481691, 4817.9518204818205, 4826.7827947742435, 5070.923936140887, 5080.0, 5084.745762711924, 5110.029094472038, 5114.79540818378, 4792.976035119802, 4969.304297398295, 5033.39599248078, 5033.6476446648385, 5034.899302013866, 4766.356541866942, 4767.687671479399, 4783.756223381876, 4795.904081918272, 4797.361451201895, 3762.6989840813217, 3773.2830762155104, 3781.489498917721, 3786.9621303786607, 3794.79128647927, 4836.637252206028, 5034.546890779848, 5149.639525233348, 5154.226865970135, 5170.27616133734, 4902.2156454967035, 4903.436104847988, 4903.730294833818, 4910.74775932135, 4919.311296418433, 4904.871879467671, 4909.4845041270155, 4914.434839993303, 4933.161362568444, 4947.678400903929, 4580.954190458053, 4827.541383568555, 4867.975660121677, 4880.194767863263, 4883.560479556857, 4792.185328494234, 4912.92630610534, 5032.18197809228, 5032.974835125948, 5034.043531728959, 4863.781129849094, 4934.938988117572, 4957.504249575014, 4957.876053098701, 4960.809405742523], "value": 3777.090485665156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8641758065967, 739.6338812287918, 748.6743266678999, 772.1776308231733, 780.102881686061, 11626.941865290672, 12445.68885777856, 12907.741845163102, 13115.606531804062, 13150.539731109413, 11833.290002599828, 11888.405579721022, 11905.226160299575, 11913.821292680617, 11928.403579821017, 473.8957429365534, 479.161467431994, 781.1758594682622, 801.0227522422664, 802.4302745050992, 773.7949443397476, 797.5613412623034, 797.696875187428, 797.9865570725176, 798.0941631248517, 834.4117397234966, 835.2733122183678, 841.4026041510505, 841.8190089130836, 842.0232530264894, 499.116563682284, 805.2269820971874, 831.0152469323871, 837.5728378526965, 837.5979529825718, 603.9909401358983, 604.0395770724525, 604.4620287943734, 604.7550741949517, 604.8487878030493, 12547.686307842378, 12551.184173028723, 12552.937235313764, 12555.183913045714, 12566.0, 11285.492152853141, 11459.541618335257, 11714.414279286002, 12150.0, 12307.0, 10959.178061645409, 11168.720781980515, 11311.547538098466, 11376.976072153546, 11447.542098316057, 3991.7405368650943, 4060.147369052473, 4074.653654439376, 4108.958910410917, 4177.26897792885, 45847.541524584994, 46206.0, 46269.76865115687, 46272.0, 46414.07171856578, 8828.911710882809, 9168.358214925025, 9218.0, 9254.537273136317, 9404.576794044284, 15616.063036217864, 15643.843561564467, 15719.449819256271, 15727.562227854702, 15744.0, 6516.771912983023, 6558.213014438298, 6602.1747281589805, 6644.833879152963, 6678.799636010927, 3798.8290526926353, 3807.7144214183495, 3855.20968201518, 3866.7486613370043, 3924.980375098163, 2797.482465743844, 2871.124307086359, 2880.8847646093923, 2881.0492537462587, 2882.3514709190686, 517.3998162131984, 519.6336582709181, 533.2135100726475, 533.5145018033571, 535.3067777228498, 407.66978747214256, 432.8290325321543, 543.2259030881057, 562.7383266780967, 572.5534083414859, 6852.143482064742, 7043.823904402431, 7122.501424900207, 7124.109486314211, 7325.2308507607, 466.4402716739926, 490.7546226886557, 490.79631952739925, 524.0096218147704, 548.7759413446005, 3264.9836750816094, 3362.4115779738936, 3374.6962773350024, 3381.1716129547926, 3439.398105331557, 46709.29936050962, 48175.27737083947, 51293.48706512887, 51565.48434515607, 51784.74107629438, 46787.76606117016, 48302.75848620734, 48345.5165448341, 48780.75609622, 48788.0, 43901.56098438975, 44245.778771105935, 44293.33559996603, 44735.0, 44963.77518112454, 7627.580483073484, 7902.288794008567, 7921.32668723142, 7930.722424715107, 7989.161138080651, 29695.0, 30111.54832677468, 31137.53293700551, 31469.685303146674, 31640.0, 38722.2255554893, 39650.2069958605, 39931.0, 40576.391354130305, 40731.796341018104, 9759.60961561558, 10397.0, 10466.319689220176, 10660.786784264426, 10773.461326933466, 11449.0, 11927.642170734893, 12098.213616114925, 12259.816102758645, 12533.122681412578, 10146.391216527032, 10158.644447444303, 10230.539625716712, 10382.42896640692, 10754.085902698045, 10920.890791091988, 11004.724881878017, 11049.17131215146, 11087.279326843729, 11213.887861121284, 10017.5492102857, 10028.799424011624, 10044.899551004397, 11031.944840275748, 11215.49530271156, 8995.640174392951, 9197.396098134663, 9407.4825884577, 9596.712098637052, 9810.901890980998, 9014.774630634025, 9021.954890225506, 9139.405938613969, 9240.584173712065, 9350.392224505385], "value": 5812.430637359452, "unit": "score"}], "name": "dromaeo_css", "value": 6191.601441671782, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 114.0, 117.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 133.0, 132.0, 164.0, 131.0, 174.0, 155.0, 131.0, 185.0, 129.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 159.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 121.0, 76.0, 76.0, 76.0, 75.0, 133.0, 75.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 84.0, 84.0, 84.0, 115.0, 84.0, 84.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 68.0, 86.0, 64.0, 64.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 83.0, 89.0, 85.0, 83.0, 84.0, 84.0, 83.0, 82.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 127.0, 128.0, 127.0, 130.0, 129.0, 132.0, 167.0, 131.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 170.0, 169.0, 170.0, 174.0, 170.0, 171.0, 168.0, 172.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 67.0, 65.0, 64.0, 68.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1551.8000000000002, "alertThreshold": 2.0}]} 10:40:23 INFO - Return code: 0 10:40:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:40:23 ERROR - # TBPL SUCCESS # 10:40:23 INFO - Running post-action listener: _resource_record_post_action 10:40:23 INFO - ##### 10:40:23 INFO - ##### Finished run-tests step (success) 10:40:23 INFO - ##### 10:40:23 INFO - Running post-run listener: _resource_record_post_run 10:40:23 INFO - Total resource usage - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 383680512; Read time: 36; Write time: 3337376 10:40:23 INFO - TinderboxPrint: CPU usage
13.4% 10:40:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 10:40:23 INFO - TinderboxPrint: I/O write bytes / time
383,680,512 / 3,337,376 10:40:23 INFO - TinderboxPrint: CPU idle
8,367.6 (86.6%) 10:40:23 INFO - TinderboxPrint: CPU user
1,211.3 (12.5%) 10:40:23 INFO - TinderboxPrint: Swap in / out
0 / 0 10:40:23 INFO - install - Wall time: 19s; CPU: 19.0%; Read bytes: 0; Write bytes: 88756224; Read time: 0; Write time: 1692788 10:40:23 INFO - run-tests - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283496448; Read time: 36; Write time: 1520184 10:40:23 INFO - Running post-run listener: _upload_blobber_files 10:40:23 INFO - Blob upload gear active. 10:40:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:23 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 10:40:23 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'] 10:40:23 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 10:40:24 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:25 INFO - (blobuploader) - INFO - Done attempting. 10:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:40:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:29 INFO - (blobuploader) - INFO - Done attempting. 10:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:40:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:30 INFO - (blobuploader) - INFO - Done attempting. 10:40:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:30 INFO - Return code: 0 10:40:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/596f058e8b04b40f47cc8355e3b723c66716dfb17625077c8b7436fe5a654ddaa28739c420b3afddd311a71fb0e3e7314ef963c1994e90c4b3790e8fe215f825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/508a4fd44ac23a1a49ca95ee80590a57e83086cb49d3e966dfb4cc6df042c3db0eafabd349e40e59e873e91443b011c48fb418efd4eaf072b9f95d99328fdce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d9c9616165e7d5488591485d9b21f0b4972e21a0c6c7e0ad67b07c5fd8ea4dbeae172135f0123289107eb9c93e4998054f0a8f83aabf9389d1d99c0a24b4d"} 10:40:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:30 INFO - Contents: 10:40:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/596f058e8b04b40f47cc8355e3b723c66716dfb17625077c8b7436fe5a654ddaa28739c420b3afddd311a71fb0e3e7314ef963c1994e90c4b3790e8fe215f825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/508a4fd44ac23a1a49ca95ee80590a57e83086cb49d3e966dfb4cc6df042c3db0eafabd349e40e59e873e91443b011c48fb418efd4eaf072b9f95d99328fdce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d9c9616165e7d5488591485d9b21f0b4972e21a0c6c7e0ad67b07c5fd8ea4dbeae172135f0123289107eb9c93e4998054f0a8f83aabf9389d1d99c0a24b4d"} 10:40:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:30 INFO - Copying logs to upload dir... 10:40:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.068563 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-26 10:40:30.211720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 10:40:30.214939) ========= 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=33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366 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/596f058e8b04b40f47cc8355e3b723c66716dfb17625077c8b7436fe5a654ddaa28739c420b3afddd311a71fb0e3e7314ef963c1994e90c4b3790e8fe215f825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/508a4fd44ac23a1a49ca95ee80590a57e83086cb49d3e966dfb4cc6df042c3db0eafabd349e40e59e873e91443b011c48fb418efd4eaf072b9f95d99328fdce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d9c9616165e7d5488591485d9b21f0b4972e21a0c6c7e0ad67b07c5fd8ea4dbeae172135f0123289107eb9c93e4998054f0a8f83aabf9389d1d99c0a24b4d"} build_url:https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/DMjcgOq5RLOZoJGkw2cEdg/artifacts/public/build/firefox-49.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/596f058e8b04b40f47cc8355e3b723c66716dfb17625077c8b7436fe5a654ddaa28739c420b3afddd311a71fb0e3e7314ef963c1994e90c4b3790e8fe215f825", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/508a4fd44ac23a1a49ca95ee80590a57e83086cb49d3e966dfb4cc6df042c3db0eafabd349e40e59e873e91443b011c48fb418efd4eaf072b9f95d99328fdce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/650d9c9616165e7d5488591485d9b21f0b4972e21a0c6c7e0ad67b07c5fd8ea4dbeae172135f0123289107eb9c93e4998054f0a8f83aabf9389d1d99c0a24b4d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 10:40:30.240897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:40:30.241445) ========= 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=33d5923976266a1c518c4bf7000001ab-1464283080.939636-705208366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:40:30.324638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 10:40:30.324987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 10:40:30.325295) ========= ========= Total master_lag: 0.27 =========