builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1464038872.62 results: success (0) buildid: 20160523140246 builduid: 96841e9debb84a929b67c1d9857f5291 revision: ca0d04ce03040d726cd96d112761e79317587c18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.616947) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.617382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.617659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.631133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.631436) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 14:27:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.1M=0s 2016-05-23 14:27:52 (50.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.756277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.756608) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020858 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.806688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:52.807048) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca0d04ce03040d726cd96d112761e79317587c18 --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 ca0d04ce03040d726cd96d112761e79317587c18 --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=5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 14:27:53,051 truncating revision to first 12 chars 2016-05-23 14:27:53,051 Setting DEBUG logging. 2016-05-23 14:27:53,051 attempt 1/10 2016-05-23 14:27:53,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca0d04ce0304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 14:27:53,300 unpacking tar archive at: fx-team-ca0d04ce0304/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524018 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:53.343838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:53.344159) ========= script_repo_revision: ca0d04ce03040d726cd96d112761e79317587c18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:53.344532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:53.344810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:27:53.354910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-23 14:27:53.355290) ========= /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=5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:27:53 INFO - MultiFileLogger online at 20160523 14:27:53 in /builds/slave/test 14:27:53 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 14:27:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:53 INFO - {'append_to_log': False, 14:27:53 INFO - 'base_work_dir': '/builds/slave/test', 14:27:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:27:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:53 INFO - 'branch': 'Fx-Team-Non-PGO', 14:27:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:53 INFO - 'config_files': ('talos/linux_config.py',), 14:27:53 INFO - 'default_actions': ('clobber', 14:27:53 INFO - 'read-buildbot-config', 14:27:53 INFO - 'download-and-extract', 14:27:53 INFO - 'populate-webroot', 14:27:53 INFO - 'create-virtualenv', 14:27:53 INFO - 'install', 14:27:53 INFO - 'run-tests'), 14:27:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:53 INFO - 'download_minidump_stackwalk': True, 14:27:53 INFO - 'download_symbols': 'ondemand', 14:27:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:53 INFO - 'installer_path': 'installer.exe', 14:27:53 INFO - 'log_level': 'info', 14:27:53 INFO - 'log_name': 'talos', 14:27:53 INFO - 'log_to_console': True, 14:27:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:27:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:27:53 INFO - 'opt_config_files': (), 14:27:53 INFO - 'pip_index': False, 14:27:53 INFO - 'sps_profile': False, 14:27:53 INFO - 'sps_profile_interval': 0, 14:27:53 INFO - 'suite': 'dromaeojs', 14:27:53 INFO - 'system_bits': '32', 14:27:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:53 INFO - 'title': 'talos-linux64-ix-011', 14:27:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:53 INFO - 'use_talos_json': True, 14:27:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:53 INFO - 'work_dir': 'build'} 14:27:53 INFO - ##### 14:27:53 INFO - ##### Running clobber step. 14:27:53 INFO - ##### 14:27:53 INFO - Running pre-action listener: _resource_record_pre_action 14:27:53 INFO - Running main action method: clobber 14:27:53 INFO - rmtree: /builds/slave/test/build 14:27:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:27:54 INFO - Running post-action listener: _resource_record_post_action 14:27:54 INFO - ##### 14:27:54 INFO - ##### Finished clobber step (success) 14:27:54 INFO - ##### 14:27:54 INFO - ##### 14:27:54 INFO - ##### Running read-buildbot-config step. 14:27:54 INFO - ##### 14:27:54 INFO - Running pre-action listener: _resource_record_pre_action 14:27:54 INFO - Running main action method: read_buildbot_config 14:27:54 INFO - Using buildbot properties: 14:27:54 INFO - { 14:27:54 INFO - "project": "", 14:27:54 INFO - "product": "firefox", 14:27:54 INFO - "script_repo_revision": "production", 14:27:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:27:54 INFO - "repository": "", 14:27:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:27:54 INFO - "buildid": "20160523140246", 14:27:54 INFO - "pgo_build": "False", 14:27:54 INFO - "basedir": "/builds/slave/test", 14:27:54 INFO - "buildnumber": 2998, 14:27:54 INFO - "slavename": "talos-linux64-ix-011", 14:27:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:27:54 INFO - "platform": "ubuntu64_hw", 14:27:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:27:54 INFO - "branch": "fx-team", 14:27:54 INFO - "repo_path": "integration/fx-team", 14:27:54 INFO - "revision": "ca0d04ce03040d726cd96d112761e79317587c18", 14:27:54 INFO - "stage_platform": "linux64", 14:27:54 INFO - "builduid": "96841e9debb84a929b67c1d9857f5291", 14:27:54 INFO - "slavebuilddir": "test" 14:27:54 INFO - } 14:27:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:27:54 INFO - Running post-action listener: _resource_record_post_action 14:27:54 INFO - ##### 14:27:54 INFO - ##### Finished read-buildbot-config step (success) 14:27:54 INFO - ##### 14:27:54 INFO - ##### 14:27:54 INFO - ##### Running download-and-extract step. 14:27:54 INFO - ##### 14:27:54 INFO - Running pre-action listener: _resource_record_pre_action 14:27:54 INFO - Running main action method: download_and_extract 14:27:54 INFO - mkdir: /builds/slave/test/build/tests 14:27: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')]} 14:27:54 INFO - https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:54 INFO - Downloaded 1361 bytes. 14:27:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:27:54 INFO - Using the following test package requirements: 14:27:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:27:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:27:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'jsshell-linux-x86_64.zip'], 14:27:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:27:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:27:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:27:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:27:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:27:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:27:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:27:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:27: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')]} 14:27:54 INFO - https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:55 INFO - Downloaded 22814893 bytes. 14:27:55 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'] 14:27:55 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 14:27:57 INFO - Return code: 0 14:27:57 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 14:27:57 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')]} 14:27:57 INFO - https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:27:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:27:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:27:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:58 INFO - Downloaded 22814893 bytes. 14:27:58 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'] 14:27:58 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 14:27:59 INFO - Return code: 0 14:27: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')]} 14:27:59 INFO - https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:28:00 INFO - Downloaded 10840359 bytes. 14:28:00 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'] 14:28:00 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 14:28:00 INFO - Return code: 0 14:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:00 INFO - https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:28:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSrLHAaSRSakCdssQssCRA/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 14:28:02 INFO - Downloaded 54814285 bytes. 14:28:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:02 INFO - mkdir: /builds/slave/test/properties 14:28:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:02 INFO - Contents: 14:28:02 INFO - build_url:https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:02 INFO - Running post-action listener: _resource_record_post_action 14:28:02 INFO - Running post-action listener: set_extra_try_arguments 14:28:02 INFO - ##### 14:28:02 INFO - ##### Finished download-and-extract step (success) 14:28:02 INFO - ##### 14:28:02 INFO - ##### 14:28:02 INFO - ##### Running populate-webroot step. 14:28:02 INFO - ##### 14:28:02 INFO - Running pre-action listener: _resource_record_pre_action 14:28:02 INFO - Running main action method: populate_webroot 14:28:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:02 INFO - '--tppagecycles', 14:28:02 INFO - '7'], 14:28:02 INFO - 'tests': ['tsvgm']}}, 14:28:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:28:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:28:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:28:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['damp', 'tps']}, 14:28:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'tests': ['damp', 'tps']}, 14:28:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['dromaeo_dom']}, 14:28:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['a11yr', 14:28:02 INFO - 'ts_paint', 14:28:02 INFO - 'tpaint', 14:28:02 INFO - 'sessionrestore', 14:28:02 INFO - 'sessionrestore_no_auto_restore', 14:28:02 INFO - 'tabpaint']}, 14:28:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:28:02 INFO - 'ts_paint', 14:28:02 INFO - 'tpaint', 14:28:02 INFO - 'sessionrestore', 14:28:02 INFO - 'sessionrestore_no_auto_restore', 14:28:02 INFO - 'tabpaint']}, 14:28:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:28:02 INFO - 'ts_paint', 14:28:02 INFO - 'tpaint', 14:28:02 INFO - 'sessionrestore', 14:28:02 INFO - 'sessionrestore_no_auto_restore', 14:28:02 INFO - 'tabpaint']}, 14:28:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:28:02 INFO - 'ts_paint', 14:28:02 INFO - 'tpaint', 14:28:02 INFO - 'sessionrestore', 14:28:02 INFO - 'sessionrestore_no_auto_restore', 14:28:02 INFO - 'tabpaint']}, 14:28:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['a11yr', 14:28:02 INFO - 'ts_paint', 14:28:02 INFO - 'tpaint', 14:28:02 INFO - 'sessionrestore', 14:28:02 INFO - 'sessionrestore_no_auto_restore', 14:28:02 INFO - 'tabpaint']}, 14:28:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['a11yr', 14:28:02 INFO - 'ts_paint', 14:28:02 INFO - 'tpaint', 14:28:02 INFO - 'sessionrestore', 14:28:02 INFO - 'sessionrestore_no_auto_restore', 14:28:02 INFO - 'tabpaint']}, 14:28:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['tsvgx', 14:28:02 INFO - 'tsvgr_opacity', 14:28:02 INFO - 'tart', 14:28:02 INFO - 'tscrollx', 14:28:02 INFO - 'cart']}, 14:28:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:28:02 INFO - 'tsvgr_opacity', 14:28:02 INFO - 'tart', 14:28:02 INFO - 'tscrollx', 14:28:02 INFO - 'cart']}, 14:28:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'talos_options': ['--disable-e10s'], 14:28:02 INFO - 'tests': ['tp5o']}, 14:28:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'tests': ['tp5o']}, 14:28:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'talos_options': ['--disable-e10s', 14:28:02 INFO - '--xperf_path', 14:28:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:02 INFO - 'tests': ['tp5n']}, 14:28:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:02 INFO - 'talos_options': ['--xperf_path', 14:28:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:02 INFO - 'tests': ['tp5n']}}, 14:28:02 INFO - 'talos.zip': {'path': '', 14:28:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:02 INFO - Running post-action listener: _resource_record_post_action 14:28:02 INFO - ##### 14:28:02 INFO - ##### Finished populate-webroot step (success) 14:28:02 INFO - ##### 14:28:02 INFO - ##### 14:28:02 INFO - ##### Running create-virtualenv step. 14:28:02 INFO - ##### 14:28:02 INFO - Running pre-action listener: _resource_record_pre_action 14:28:02 INFO - Running main action method: create_virtualenv 14:28:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:02 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 14:28:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:03 INFO - Using real prefix '/usr' 14:28:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:05 INFO - Installing pip.................done. 14:28:05 INFO - Return code: 0 14:28:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:05 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')]} 14:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:05 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')]} 14:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:05 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:05 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 14:28:05 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 14:28:05 INFO - Using env: {'DISPLAY': ':0', 14:28:05 INFO - 'HOME': '/home/cltbld', 14:28:05 INFO - 'LANG': 'en_US.UTF-8', 14:28:05 INFO - 'LANGUAGE': 'en_US:en', 14:28:05 INFO - 'LOGNAME': 'cltbld', 14:28:05 INFO - 'MAIL': '/var/mail/cltbld', 14:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:05 INFO - 'MOZ_NO_REMOTE': '1', 14:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:05 INFO - 'NO_EM_RESTART': '1', 14:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:05 INFO - 'PWD': '/builds/slave/test', 14:28:05 INFO - 'SHELL': '/bin/bash', 14:28:05 INFO - 'SHLVL': '1', 14:28:05 INFO - 'TERM': 'linux', 14:28:05 INFO - 'TMOUT': '86400', 14:28:05 INFO - 'USER': 'cltbld', 14:28:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:05 INFO - '_': '/tools/buildbot/bin/python'} 14:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:05 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 14:28:05 INFO - Cleaning up... 14:28:05 INFO - Return code: 0 14:28:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:05 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')]} 14:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:05 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')]} 14:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:05 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:05 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 14:28:05 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 14:28:05 INFO - Using env: {'DISPLAY': ':0', 14:28:05 INFO - 'HOME': '/home/cltbld', 14:28:05 INFO - 'LANG': 'en_US.UTF-8', 14:28:05 INFO - 'LANGUAGE': 'en_US:en', 14:28:05 INFO - 'LOGNAME': 'cltbld', 14:28:05 INFO - 'MAIL': '/var/mail/cltbld', 14:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:05 INFO - 'MOZ_NO_REMOTE': '1', 14:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:05 INFO - 'NO_EM_RESTART': '1', 14:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:05 INFO - 'PWD': '/builds/slave/test', 14:28:05 INFO - 'SHELL': '/bin/bash', 14:28:05 INFO - 'SHLVL': '1', 14:28:05 INFO - 'TERM': 'linux', 14:28:05 INFO - 'TMOUT': '86400', 14:28:05 INFO - 'USER': 'cltbld', 14:28:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:05 INFO - '_': '/tools/buildbot/bin/python'} 14:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:06 INFO - Downloading/unpacking psutil>=3.1.1 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:06 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 14:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:08 INFO - Installing collected packages: psutil 14:28:08 INFO - Running setup.py install for psutil 14:28:08 INFO - building 'psutil._psutil_linux' extension 14:28:08 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 14:28:08 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 14:28:08 INFO - building 'psutil._psutil_posix' extension 14:28:08 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 14:28:08 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 14:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:08 INFO - Successfully installed psutil 14:28:08 INFO - Cleaning up... 14:28:08 INFO - Return code: 0 14:28:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:08 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:08 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 14:28:08 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 14:28:08 INFO - Using env: {'DISPLAY': ':0', 14:28:08 INFO - 'HOME': '/home/cltbld', 14:28:08 INFO - 'LANG': 'en_US.UTF-8', 14:28:08 INFO - 'LANGUAGE': 'en_US:en', 14:28:08 INFO - 'LOGNAME': 'cltbld', 14:28:08 INFO - 'MAIL': '/var/mail/cltbld', 14:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:08 INFO - 'MOZ_NO_REMOTE': '1', 14:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:08 INFO - 'NO_EM_RESTART': '1', 14:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:08 INFO - 'PWD': '/builds/slave/test', 14:28:08 INFO - 'SHELL': '/bin/bash', 14:28:08 INFO - 'SHLVL': '1', 14:28:08 INFO - 'TERM': 'linux', 14:28:08 INFO - 'TMOUT': '86400', 14:28:08 INFO - 'USER': 'cltbld', 14:28:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:08 INFO - '_': '/tools/buildbot/bin/python'} 14:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:08 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 14:28:08 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 14:28:08 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 14:28:08 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 14:28:08 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 14:28:08 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 14:28:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:10 INFO - Installing collected packages: mozsystemmonitor 14:28:10 INFO - Running setup.py install for mozsystemmonitor 14:28:10 INFO - Successfully installed mozsystemmonitor 14:28:10 INFO - Cleaning up... 14:28:10 INFO - Return code: 0 14:28:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:10 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')]} 14:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:10 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')]} 14:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:10 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:10 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 14:28:10 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 14:28:10 INFO - Using env: {'DISPLAY': ':0', 14:28:10 INFO - 'HOME': '/home/cltbld', 14:28:10 INFO - 'LANG': 'en_US.UTF-8', 14:28:10 INFO - 'LANGUAGE': 'en_US:en', 14:28:10 INFO - 'LOGNAME': 'cltbld', 14:28:10 INFO - 'MAIL': '/var/mail/cltbld', 14:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:10 INFO - 'MOZ_NO_REMOTE': '1', 14:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:10 INFO - 'NO_EM_RESTART': '1', 14:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:10 INFO - 'PWD': '/builds/slave/test', 14:28:10 INFO - 'SHELL': '/bin/bash', 14:28:10 INFO - 'SHLVL': '1', 14:28:10 INFO - 'TERM': 'linux', 14:28:10 INFO - 'TMOUT': '86400', 14:28:10 INFO - 'USER': 'cltbld', 14:28:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:10 INFO - '_': '/tools/buildbot/bin/python'} 14:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 INFO - Downloading docopt-0.6.1.tar.gz 14:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:13 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:13 INFO - Running setup.py install for blobuploader 14:28:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:13 INFO - Running setup.py install for requests 14:28:14 INFO - Running setup.py install for docopt 14:28:14 INFO - Successfully installed blobuploader requests docopt 14:28:14 INFO - Cleaning up... 14:28:14 INFO - Return code: 0 14:28:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:14 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')]} 14:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:14 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')]} 14:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:14 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:14 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 14:28:14 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 14:28:14 INFO - Using env: {'DISPLAY': ':0', 14:28:14 INFO - 'HOME': '/home/cltbld', 14:28:14 INFO - 'LANG': 'en_US.UTF-8', 14:28:14 INFO - 'LANGUAGE': 'en_US:en', 14:28:14 INFO - 'LOGNAME': 'cltbld', 14:28:14 INFO - 'MAIL': '/var/mail/cltbld', 14:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:14 INFO - 'MOZ_NO_REMOTE': '1', 14:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:14 INFO - 'NO_EM_RESTART': '1', 14:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:14 INFO - 'PWD': '/builds/slave/test', 14:28:14 INFO - 'SHELL': '/bin/bash', 14:28:14 INFO - 'SHLVL': '1', 14:28:14 INFO - 'TERM': 'linux', 14:28:14 INFO - 'TMOUT': '86400', 14:28:14 INFO - 'USER': 'cltbld', 14:28:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:14 INFO - '_': '/tools/buildbot/bin/python'} 14:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:14 INFO - Running setup.py (path:/tmp/pip-j_2Nu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:14 INFO - Running setup.py (path:/tmp/pip-VSgEYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:14 INFO - Running setup.py (path:/tmp/pip-j_kL8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:14 INFO - Running setup.py (path:/tmp/pip-qyrw9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:14 INFO - Running setup.py (path:/tmp/pip-7z5Fge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:14 INFO - Running setup.py (path:/tmp/pip-fqyAl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:15 INFO - Running setup.py (path:/tmp/pip-JpptfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:15 INFO - Running setup.py (path:/tmp/pip-vEjRJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:15 INFO - Running setup.py (path:/tmp/pip-8nGEZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:15 INFO - Running setup.py (path:/tmp/pip-FK4iv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:15 INFO - Running setup.py (path:/tmp/pip-OIfBe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:15 INFO - Running setup.py (path:/tmp/pip-YwVxWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:15 INFO - Running setup.py (path:/tmp/pip-j7Butv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:15 INFO - Running setup.py (path:/tmp/pip-_kh2Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:15 INFO - Running setup.py (path:/tmp/pip-GtQuND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:15 INFO - Running setup.py (path:/tmp/pip-sWzgR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:15 INFO - Running setup.py (path:/tmp/pip-dCG8B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:15 INFO - Running setup.py install for manifestparser 14:28:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:15 INFO - Running setup.py install for mozcrash 14:28:16 INFO - Running setup.py install for mozdebug 14:28:16 INFO - Running setup.py install for mozdevice 14:28:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Running setup.py install for mozfile 14:28:16 INFO - Running setup.py install for mozhttpd 14:28:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Running setup.py install for mozinfo 14:28:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Running setup.py install for mozInstall 14:28:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Running setup.py install for mozleak 14:28:16 INFO - Running setup.py install for mozlog 14:28:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Running setup.py install for moznetwork 14:28:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:16 INFO - Running setup.py install for mozprocess 14:28:17 INFO - Running setup.py install for mozprofile 14:28:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:17 INFO - Running setup.py install for mozrunner 14:28:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:17 INFO - Running setup.py install for mozscreenshot 14:28:17 INFO - Running setup.py install for moztest 14:28:17 INFO - Running setup.py install for mozversion 14:28:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:17 INFO - Cleaning up... 14:28:17 INFO - Return code: 0 14:28:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:17 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:17 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 14:28:17 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 14:28:17 INFO - Using env: {'DISPLAY': ':0', 14:28:17 INFO - 'HOME': '/home/cltbld', 14:28:17 INFO - 'LANG': 'en_US.UTF-8', 14:28:17 INFO - 'LANGUAGE': 'en_US:en', 14:28:17 INFO - 'LOGNAME': 'cltbld', 14:28:17 INFO - 'MAIL': '/var/mail/cltbld', 14:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:17 INFO - 'MOZ_NO_REMOTE': '1', 14:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:17 INFO - 'NO_EM_RESTART': '1', 14:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:17 INFO - 'PWD': '/builds/slave/test', 14:28:17 INFO - 'SHELL': '/bin/bash', 14:28:17 INFO - 'SHLVL': '1', 14:28:17 INFO - 'TERM': 'linux', 14:28:17 INFO - 'TMOUT': '86400', 14:28:17 INFO - 'USER': 'cltbld', 14:28:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:17 INFO - '_': '/tools/buildbot/bin/python'} 14:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:17 INFO - Running setup.py (path:/tmp/pip-NVJltF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:17 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)) 14:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:17 INFO - Running setup.py (path:/tmp/pip-iIaz_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:17 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)) 14:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:17 INFO - Running setup.py (path:/tmp/pip-DqoFxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:18 INFO - Running setup.py (path:/tmp/pip-XF0mW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:18 INFO - Running setup.py (path:/tmp/pip-nJ92kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:18 INFO - Running setup.py (path:/tmp/pip-BtqwdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:18 INFO - Running setup.py (path:/tmp/pip-MMToKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:18 INFO - Running setup.py (path:/tmp/pip-i9uqKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:18 INFO - Running setup.py (path:/tmp/pip-hY5LoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:18 INFO - Running setup.py (path:/tmp/pip-_TV9H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:18 INFO - Running setup.py (path:/tmp/pip-WYUu3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:18 INFO - Running setup.py (path:/tmp/pip-cdfHl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:18 INFO - Running setup.py (path:/tmp/pip-9dDTCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:18 INFO - Running setup.py (path:/tmp/pip-am0W7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:18 INFO - Running setup.py (path:/tmp/pip-fQEaGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:18 INFO - Running setup.py (path:/tmp/pip-MiccgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:18 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)) 14:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:18 INFO - Running setup.py (path:/tmp/pip-cMWMR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 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)) 14:28:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:19 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 14:28:19 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 14:28:19 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 14:28:19 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 14:28:19 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 14:28:19 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 14:28:20 INFO - Downloading blessings-1.6.tar.gz 14:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:20 INFO - Installing collected packages: blessings 14:28:20 INFO - Running setup.py install for blessings 14:28:21 INFO - Successfully installed blessings 14:28:21 INFO - Cleaning up... 14:28:21 INFO - Return code: 0 14:28:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:21 INFO - Reading from file tmpfile_stdout 14:28:21 INFO - Current package versions: 14:28:21 INFO - argparse == 1.2.1 14:28:21 INFO - blessings == 1.6 14:28:21 INFO - blobuploader == 1.2.4 14:28:21 INFO - docopt == 0.6.1 14:28:21 INFO - manifestparser == 1.1 14:28:21 INFO - mozInstall == 1.12 14:28:21 INFO - mozcrash == 0.17 14:28:21 INFO - mozdebug == 0.1 14:28:21 INFO - mozdevice == 0.48 14:28:21 INFO - mozfile == 1.2 14:28:21 INFO - mozhttpd == 0.7 14:28:21 INFO - mozinfo == 0.9 14:28:21 INFO - mozleak == 0.1 14:28:21 INFO - mozlog == 3.2 14:28:21 INFO - moznetwork == 0.27 14:28:21 INFO - mozprocess == 0.22 14:28:21 INFO - mozprofile == 0.28 14:28:21 INFO - mozrunner == 6.11 14:28:21 INFO - mozscreenshot == 0.1 14:28:21 INFO - mozsystemmonitor == 0.3 14:28:21 INFO - moztest == 0.7 14:28:21 INFO - mozversion == 1.4 14:28:21 INFO - psutil == 3.1.1 14:28:21 INFO - requests == 1.2.3 14:28:21 INFO - wsgiref == 0.1.2 14:28:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:21 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')]} 14:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 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')]} 14:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:21 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 14:28:21 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 14:28:21 INFO - Using env: {'DISPLAY': ':0', 14:28:21 INFO - 'HOME': '/home/cltbld', 14:28:21 INFO - 'LANG': 'en_US.UTF-8', 14:28:21 INFO - 'LANGUAGE': 'en_US:en', 14:28:21 INFO - 'LOGNAME': 'cltbld', 14:28:21 INFO - 'MAIL': '/var/mail/cltbld', 14:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:21 INFO - 'MOZ_NO_REMOTE': '1', 14:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:21 INFO - 'NO_EM_RESTART': '1', 14:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:21 INFO - 'PWD': '/builds/slave/test', 14:28:21 INFO - 'SHELL': '/bin/bash', 14:28:21 INFO - 'SHLVL': '1', 14:28:21 INFO - 'TERM': 'linux', 14:28:21 INFO - 'TMOUT': '86400', 14:28:21 INFO - 'USER': 'cltbld', 14:28:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:21 INFO - '_': '/tools/buildbot/bin/python'} 14:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 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)) 14:28:21 INFO - Cleaning up... 14:28:21 INFO - Return code: 0 14:28:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28:21 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')]} 14:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 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')]} 14:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 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 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:21 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 14:28:21 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 14:28:21 INFO - Using env: {'DISPLAY': ':0', 14:28:21 INFO - 'HOME': '/home/cltbld', 14:28:21 INFO - 'LANG': 'en_US.UTF-8', 14:28:21 INFO - 'LANGUAGE': 'en_US:en', 14:28:21 INFO - 'LOGNAME': 'cltbld', 14:28:21 INFO - 'MAIL': '/var/mail/cltbld', 14:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:21 INFO - 'MOZ_NO_REMOTE': '1', 14:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:21 INFO - 'NO_EM_RESTART': '1', 14:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:21 INFO - 'PWD': '/builds/slave/test', 14:28:21 INFO - 'SHELL': '/bin/bash', 14:28:21 INFO - 'SHLVL': '1', 14:28:21 INFO - 'TERM': 'linux', 14:28:21 INFO - 'TMOUT': '86400', 14:28:21 INFO - 'USER': 'cltbld', 14:28:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:21 INFO - '_': '/tools/buildbot/bin/python'} 14:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:21 INFO - Downloading/unpacking jsonschema 14:28:21 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 14:28:21 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 14:28:21 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 14:28:21 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 14:28:21 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 14:28:21 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 14:28:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:23 INFO - Downloading/unpacking functools32 (from jsonschema) 14:28:23 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 14:28:23 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 14:28:23 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 14:28:23 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 14:28:23 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 14:28:23 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 14:28:23 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:23 INFO - warning: no files found matching '*.txt' 14:28:23 INFO - no previously-included directories found matching 'build' 14:28:23 INFO - no previously-included directories found matching 'dist' 14:28:23 INFO - no previously-included directories found matching '.git*' 14:28:23 INFO - Installing collected packages: jsonschema, functools32 14:28:23 INFO - Running setup.py install for functools32 14:28:24 INFO - warning: no files found matching '*.txt' 14:28:24 INFO - no previously-included directories found matching 'build' 14:28:24 INFO - no previously-included directories found matching 'dist' 14:28:24 INFO - no previously-included directories found matching '.git*' 14:28:24 INFO - Successfully installed jsonschema functools32 14:28:24 INFO - Cleaning up... 14:28:24 INFO - Return code: 0 14:28:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5bce006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1185770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', '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 14:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:28:24 INFO - Using env: {'DISPLAY': ':0', 14:28:24 INFO - 'HOME': '/home/cltbld', 14:28:24 INFO - 'LANG': 'en_US.UTF-8', 14:28:24 INFO - 'LANGUAGE': 'en_US:en', 14:28:24 INFO - 'LOGNAME': 'cltbld', 14:28:24 INFO - 'MAIL': '/var/mail/cltbld', 14:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:24 INFO - 'MOZ_NO_REMOTE': '1', 14:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:24 INFO - 'NO_EM_RESTART': '1', 14:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:24 INFO - 'PWD': '/builds/slave/test', 14:28:24 INFO - 'SHELL': '/bin/bash', 14:28:24 INFO - 'SHLVL': '1', 14:28:24 INFO - 'TERM': 'linux', 14:28:24 INFO - 'TMOUT': '86400', 14:28:24 INFO - 'USER': 'cltbld', 14:28:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:24 INFO - '_': '/tools/buildbot/bin/python'} 14:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:24 INFO - Downloading/unpacking flake8 14:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:28:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:28:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 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 14:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:28:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:28:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:28:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:28:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:28:26 INFO - no previously-included directories found matching 'docs/_build' 14:28:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:28:27 INFO - Running setup.py install for pep8 14:28:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:28:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:28:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:28:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:28:27 INFO - no previously-included directories found matching 'docs/_build' 14:28:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:28:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:28:27 INFO - Cleaning up... 14:28:27 INFO - Return code: 0 14:28:27 INFO - Running post-action listener: _resource_record_post_action 14:28:27 INFO - Running post-action listener: _start_resource_monitoring 14:28:27 INFO - Starting resource monitoring. 14:28:27 INFO - ##### 14:28:27 INFO - ##### Finished create-virtualenv step (success) 14:28:27 INFO - ##### 14:28:27 INFO - ##### 14:28:27 INFO - ##### Running install step. 14:28:27 INFO - ##### 14:28:27 INFO - Running pre-action listener: _resource_record_pre_action 14:28:27 INFO - Running main action method: install 14:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:27 INFO - Reading from file tmpfile_stdout 14:28:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:27 INFO - Reading from file tmpfile_stdout 14:28:27 INFO - Output received: 14:28:27 INFO - Usage: mozinstall [options] installer 14:28:27 INFO - Options: 14:28:27 INFO - -h, --help show this help message and exit 14:28:27 INFO - -d DEST, --destination=DEST 14:28:27 INFO - Directory to install application into. [default: 14:28:27 INFO - "/builds/slave/test"] 14:28:27 INFO - --app=APP Application being installed. [default: firefox] 14:28:27 INFO - mkdir: /builds/slave/test/build/application 14:28:27 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'] 14:28:27 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 14:28:43 INFO - Reading from file tmpfile_stdout 14:28:43 INFO - Output received: 14:28:43 INFO - /builds/slave/test/build/application/firefox/firefox 14:28:43 INFO - Running post-action listener: _resource_record_post_action 14:28:43 INFO - ##### 14:28:43 INFO - ##### Finished install step (success) 14:28:43 INFO - ##### 14:28:43 INFO - ##### 14:28:43 INFO - ##### Running run-tests step. 14:28:43 INFO - ##### 14:28:43 INFO - Running pre-action listener: _resource_record_pre_action 14:28:43 INFO - Running main action method: run_tests 14:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:43 INFO - Python 2.7.3 14:28:43 INFO - Return code: 0 14:28:43 INFO - grabbing minidump binary from tooltool 14:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:43 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 0x12149c0>, '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 0x12158c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1215d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:43 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 14:28:43 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 14:28:43 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 14:28:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:43 INFO - Return code: 0 14:28:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:28:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:28:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:28:44 INFO - Return code: 0 14:28:44 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/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:28:44 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/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 14:28:44 INFO - Using env: {'DISPLAY': ':0', 14:28:44 INFO - 'HOME': '/home/cltbld', 14:28:44 INFO - 'LANG': 'en_US.UTF-8', 14:28:44 INFO - 'LANGUAGE': 'en_US:en', 14:28:44 INFO - 'LOGNAME': 'cltbld', 14:28:44 INFO - 'MAIL': '/var/mail/cltbld', 14:28:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:44 INFO - 'MOZ_NO_REMOTE': '1', 14:28:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:44 INFO - 'NO_EM_RESTART': '1', 14:28:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:44 INFO - 'PWD': '/builds/slave/test', 14:28:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:44 INFO - 'SHELL': '/bin/bash', 14:28:44 INFO - 'SHLVL': '1', 14:28:44 INFO - 'TERM': 'linux', 14:28:44 INFO - 'TMOUT': '86400', 14:28:44 INFO - 'USER': 'cltbld', 14:28:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572', 14:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:44 INFO - '_': '/tools/buildbot/bin/python'} 14:28:44 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/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:28:44 INFO - mozversion application_buildid: 20160523140246 14:28:44 INFO - mozversion application_changeset: ca0d04ce03040d726cd96d112761e79317587c18 14:28:44 INFO - mozversion application_display_name: Nightly 14:28:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:44 INFO - mozversion application_name: Firefox 14:28:44 INFO - mozversion application_remotingname: firefox 14:28:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:28:44 INFO - mozversion application_vendor: Mozilla 14:28:44 INFO - mozversion application_version: 49.0a1 14:28:44 INFO - mozversion platform_buildid: 20160523140246 14:28:44 INFO - mozversion platform_changeset: ca0d04ce03040d726cd96d112761e79317587c18 14:28:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:28:44 INFO - mozversion platform_version: 49.0a1 14:28:44 INFO - using testdate: 1464038924 14:28:44 INFO - actual date: 1464038924 14:28:44 INFO - starting webserver on 'localhost:35884' 14:28:44 INFO - SUITE-START | Running 2 tests 14:28:44 INFO - TEST-START | dromaeo_css 14:28:44 INFO - operating with platform_type : linux_ 14:28:44 INFO - Initialising browser for dromaeo_css test... 14:28:44 INFO - TEST-INFO | started process 18621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT9mDsj/profile http://localhost:35884/getInfo.html) 14:28:49 INFO - PROCESS | 18621 | __metrics Screen width/height:1600/1200 14:28:49 INFO - PROCESS | 18621 | colorDepth:24 14:28:49 INFO - PROCESS | 18621 | Browser inner width/height: 1024/697 14:28:49 INFO - PROCESS | 18621 | __metrics 14:28:51 ERROR - PROCESS | 18621 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:28:52 INFO - TEST-INFO | 18621: exit 0 14:28:52 INFO - Browser initialized. 14:28:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:52 INFO - TEST-INFO | started process 18705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT9mDsj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:04 INFO - PROCESS | 18705 | RSS: Main: 155357184 14:29:04 INFO - PROCESS | 18705 | 14:29:56 INFO - PROCESS | 18705 | 1464038996170 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] 14:32:08 INFO - PROCESS | 18705 | Cycle 1(1): loaded http://localhost:35884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35884/tests/dromaeo/cssquery-ext.html) 14:32:09 INFO - PROCESS | 18705 | RSS: Main: 237641728 14:32:09 INFO - PROCESS | 18705 | 14:35:11 INFO - PROCESS | 18705 | Cycle 1(1): loaded http://localhost:35884/tests/dromaeo/cssquery-ext.html (next: http://localhost:35884/tests/dromaeo/cssquery-jquery.html) 14:35:12 INFO - PROCESS | 18705 | RSS: Main: 236740608 14:35:12 INFO - PROCESS | 18705 | 14:38:14 INFO - PROCESS | 18705 | Cycle 1(1): loaded http://localhost:35884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35884/tests/dromaeo/cssquery-mootools.html) 14:38:15 INFO - PROCESS | 18705 | RSS: Main: 241143808 14:38:15 INFO - PROCESS | 18705 | 14:41:17 INFO - PROCESS | 18705 | Cycle 1(1): loaded http://localhost:35884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35884/tests/dromaeo/cssquery-prototype.html) 14:41:17 INFO - PROCESS | 18705 | RSS: Main: 233058304 14:41:17 INFO - PROCESS | 18705 | 14:44:20 INFO - PROCESS | 18705 | Cycle 1(1): loaded http://localhost:35884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35884/tests/dromaeo/cssquery-yui.html) 14:44:21 INFO - PROCESS | 18705 | RSS: Main: 216653824 14:44:21 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | Cycle 1(1): loaded http://localhost:35884/tests/dromaeo/cssquery-yui.html (next: http://localhost:35884/tests/dromaeo/cssquery-dojo.html) 14:47:24 INFO - PROCESS | 18705 | RSS: Main: 280969216 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | __start_tp_report 14:47:24 INFO - PROCESS | 18705 | _x_x_mozilla_page_load 14:47:24 INFO - PROCESS | 18705 | _x_x_mozilla_page_load_details 14:47:24 INFO - PROCESS | 18705 | |i|pagename|runs| 14:47:24 INFO - PROCESS | 18705 | |0;dojo.html;2682.5439675255207;2714.2535802654256;2721.869276413959;2743.62961000265;2763.640726705528;4633.675642705012;4688.53114688531;4775.331453596495;4854.077725232203;4870.172070747973;4710.952890471094;4714.787834547445;4724.196886529289;4796.112719146951;4798.376211092562;4179.101493178966;4314.6332561732215;4386.495553011413;4433.2241857674935;4569.428821397325;4476.216662084138;4519.706219095765;4532;4538.069695712387;4563.06457176278;4269.637080848116;4311.094670119279;4347.130573885235;4347.195768782785;4408.426904502427;4345.109252603209;4358.847440339573;4403.031333106712;4409.4047303613925;4411.955880441186;4391.6486681065435;4396.340548917656;4399.5380485049245;4406.955930440687;4433.246348120827;4485.6860019798305;4685.765711714401;4757.595604373632;4772.522747725235;4773.785179666923;5127.897442051138;5140.588752899759;5185.455527169668;5198.818041368571;5201.869953251199;5033.370828646419;5182.714950677711;5184.455632158607;5184.611154163415;5226.503482169188;4676.766161691936;4728.787204575802;4729.6452766042685;4777.713337199779;4799.112164249625;5242.213667949762;5250.18622113573;5250.212468129811;5251.501107394792;5261.789528418821;4892.975535122373;4983.975080124576;5095.668781529189;5127.948720512822;5133.178691409356;5118.61610379223;5128.1794912813775;5152.742362881841;5153.484651534816;5202.869928251748;5100.336956195671;5109.948900510947;5115.155999260155;5117.130087885069;5167.3799144102195;4922.064807686528;4979.975100124549;5051.722155281494;5086.745662716849;5094.337736094284;4310.3103503439925;4316.3093904975685;4338.414314067623;4348.239058164809;4355.412019377343;3770.0763312988493;3772.773633581994;3779.6787273081545;3795.4306853972125;3809.371453710107;4295.613394794484;4329.458817647794;4449.532799056117;4451.421315228999;4479.328100784843;5072.9746351268;5140.691558506427;5144.639875208774;5149.536541711264;5160.303359046556;4393.626541743987;4441.20058389493;4444.200043992112;4457.7548234846745;4473.955260447419;4469.4636643602325;4553.7267763933605;4606.631469482433;4617.030423611012;4643.489216186217;4863.878403039952;4867.221244600847;4886.998165376161;4901.730404827768;4931.630127740362;5140.331756871583;5156.948430515647;5161.948380516297;5162.225666150108;5203;4665;4794.4246690395985;4844.515548445127;4847.2729090636685;4935.876603084952;5064.215046667772;5076.796928122833;5088.236764485357;5091.9490805092955;5119.948800511947;5164.690118592896;5165.070287348313;5175.0167468180925;5175.896482070413;5204.531592156724;4851.078295123915;4872.464028956882;4886.657933944732;4890.24201248807;5004;4890.437599676083;4914.926276105933;4922.532359425849;4927.218315276478;4959.752012399294;4767.356406885026;4815.590674792682;4823.710577365369;4838.298446725134;4881.243407271879;5008.69947803133;5064.873378165576;5073.188289873602;5076.619253555924;5079.085764562266;4935.777889994887;4958;4971.105201063843;4974.502549744997;5019.322391477104 14:47:24 INFO - PROCESS | 18705 | |1;ext.html;539.3024958088356;578.3782433883575;579.1399771339562;595.0241603769819;600.0728873889842;26003.869980650095;39941.201175976465;40700.796496017516;40809;40850.7957460213;38915.610843891554;39248.60751392485;39340;39391.80304098483;39441;7461.888071678929;7588.430867684918;7798.727044553413;7801;9806.705798826046;9677.419354838697;10113.848292275621;10115.089641932225;10117;10121.139703125207;10077.899221007807;10151.086402223835;10154.695359139238;10157.796844063114;10158.136558392509;7562.395008399315;9857.901420985841;10058.74853128674;10086.596536138546;10088.243381746399;9990.450525221182;10085.092341689284;10092;10092.192624590016;10111.09000189979;37047.62952370469;37205;37397.62602373996;37526.62473375286;37551.62448375536;3116.9220769480717;3355.5302257683943;3530.223350862806;3786.2616789726017;3819.8090095495113;29322;29595.408091838042;29627.851860740557;29792.70207297921;29994.25014374658;3514.2268700885766;3516.314318707853;3638.7634803737938;3671.541057367829;3678.521792167001;260310;260745;261258;261812;262593;28922.566161507595;29723.770717196297;29756.702432975828;46616.533834661896;47082;33474.49788253178;33567.3286534268;33615.32769344648;33687.831560842526;33690.32619347648;11593.768124637629;11682.649520514398;11739.47172377228;11745.4714537846;11754.353510557;8235.588220588947;9100.317476189311;9292.488913109844;9308.069193080637;9467.573959171854;7851.411144164211;7884.72403465876;7923.247291507298;7970.4819186752675;7981.161977992343;3093.180307218589;3107;3118.3607360491046;3161.636411812625;3169.128489665314;868.6395146014333;871.063606622883;915.8076803871262;954.4416516337881;1022.3967858963099;27234.45531089367;28500.85749571239;28954.13137605875;29043.56434653482;29065.854670726512;972.055878304179;994.8507723841482;1037.818381783185;1045.8640376750973;1067.572970811666;14908.552743417715;15221.162836043903;15381.230938453033;15519.37922483088;15576.92211538935;399344;402057;402784;403420;404582;50135.24797128046;50615;50628;50635.24047139296;50704.49295507072;992.8957459466797;1205.090156931511;1214.8724383939737;1223.7368965672424;1237.8638349781336;28200;29312.853435732686;29441;29458.705412946452;29727.405451891274;42021;42624.786876065424;42683;42716.57283427126;42736.78631606822;235949;240381;241483;241542;241807;20296.59406811826;24291.96350456193;24775;24843.254702358958;26574.734252657225;41996;42106.578934210265;42553.787231063645;43057.354139688556;43095.78452107719;35196.12009699778;36326.27347452983;36831;36968.44547331846;37228;35600.28799423945;36027.63972360243;36136.27727445384;36350.27299454049;36474.817625912765;35009.64990350166;35331.82334088313;35909;36041.639583604876;36075;30782.384352313275;32326;32358;32628.34743305168;32848.34303313873;24628.384290392885;24785.87607061953;24957.87521062383;25260.49479010446;25523.23430297094 14:47:24 INFO - PROCESS | 18705 | |2;jquery.html;364.88688506562966;365.7567717467884;368.2487725040917;375.800825562452;390.05800990607685;15560.144192069432;16854.157292135376;16951.915240423812;17197.742033869472;17413.564660883483;15814.920925395385;15917.363305467796;16191.190440477958;16318.673626527463;16364.509064728047;5101.923471147936;5298.284731561228;5301.920471192916;5303.23103150043;5307.177387504943;3765.2469506098755;3884.6698030667426;5220.765065572039;5761.279840019997;6099.420555047285;6130.356312587181;6136.478399336062;6158.6920653967345;6165.475934545547;6171.105189747484;5979.2824861016525;6072.119542666333;6080.787172448965;6086.634801911855;6092.756289748405;3416.8804091856914;5104.387473503166;5286.867828304285;5421.864453388697;5428.647137936022;19876.503087422785;20447.795522044737;20493.79506204949;20918.058687359106;20996.265130720505;1977.2980591889816;2002.699595060738;2039.734834471524;2095.7904209579074;2174.2716190076344;8788.780280492974;9006.1894429501;9408.670696525658;9608.903910960871;13154.21074735519;1768.32803534656;1845.2895635180419;1863.5434318591897;1866.0762922353522;1882.200064972395;60315.69842150805;60600;60984.695076524775;65110.3488965109;71635;10265.178785697126;10281.383117013003;10309.74225644365;10459.110975567162;10556.841647375295;14315.069520481135;14440;14506.1296322221;14512;14544.709105817825;6208.013435700623;6393.264774550893;6485.643289619022;6492.415682588589;6547.854125528013;5673.77304907799;5756.908389719848;5818.0981947798155;5845.09401042839;5870.647761134345;4455.866324010285;4488.371627972087;4546.40896683429;4554.95445045552;4558.384618076583;1722.5607470095297;1742.7647267618963;1796.1378538301688;1850.296887182889;1867.5144462439864;875.6497401039635;928.6146249306597;928.9814203715888;934.5047125023748;969.3795970578835;16294.755578666329;16611.335546578244;17018.14909254532;17129.400470983455;17342.913285433493;868.1448772958631;872.2498651159997;905.5110240470073;921.318224513855;936.5925822267335;9218.953905230432;9678.806423871483;10298.17614590831;10508.273583824583;10638.89361106379;404443;414971;415976;417097;419185;77564.61217693989;77976.22023779803;78016;79181;80614.59692701616;982.7985263021063;991.8760154980628;995.318207028188;1010.2776514791959;1018.2973748113777;15528.145951972298;15720;15843.841561584237;15868.68262634764;16237.675246494768;24973.625395618717;36048;36130.63869361273;36257.27485450329;36541.634583653824;48536.5146348532;49068.50931490639;50680.493195067575;50822;51687.2246916289;7574.810629734301;7619.504732192389;7676.193999629959;7803.061810548104;8007.239312265326;9641.855372169563;11466.484008219484;11657.941710291734;11691.012527870113;11703;9846.60613575449;10208.591656333663;10275.7431064224;10301.690949271533;10317.535710892878;9710.75723106928;9767.218622510325;9869.802603947737;10168.186545076229;10432.791344173225;9550;9813;10228.335158214692;10510.737231569272;10592.258541901992;7357.153927298215;7450.0687414073245;7467.215942325977;7471.8879216812875;7489.28851759082;8845.336599754915;9206.907930920604;9305.255579553756;9341.11259430353;9573.329866909527 14:47:24 INFO - PROCESS | 18705 | |3;mootools.html;1280.31503145817;1424.5156646740108;1470.67645118074;1573.9921300393496;1786.9374571889987;6582.111414958979;7598.77203683889;7800.258975397328;7811.375089992794;8016.799580010503;7784.299413052824;7915.6042197890165;7929;7935.722249721261;7940.6029698514985;2193.7257842769695;2219.0679914435896;2221.8111460525793;2222.422170235742;2223.944401389962;2167.5989941860726;2186.693862859193;2204.019211450905;2205.9889700551553;2208.5914105890383;2166.7183266175375;2184.967225491611;2192.572448372568;2194.703714998471;2194.890255487227;2126.3302059851176;2131.531063166101;2133.807957283852;2134.4450442884886;2135.3273718778614;2103.4215590712524;2159.1255541505716;2159.4709296222527;2163.1996161420216;2165.404513758713;7761.72833950809;7903.446758726892;7921.049474063092;7926.445148839583;7955.920440795576;4341.500727416356;4512.661550383735;4528.954710452919;4530.478994915594;4535.478419981679;2899.3041669999047;2922.459345021178;2950.468915595192;2960.467115919134;3032.8331941743195;916.5600511754328;930.7952250504878;941.2658126661147;969.6363863551169;976.584951395661;11049.779004419946;11111.388873611948;11136.721581960435;11161.274517156358;11175.050120739746;4043.7978101094827;4094.488188976378;4158.6673066154635;4161.56303588125;4210.305299625588;8770.956145219234;8794.252488538417;8827.69103081389;8836.690715824916;8845.24815390699;4419.823207071746;4427.756473393994;4440.689151759346;4444.8444304449185;4444.933326000112;3473.6179020307745;3936.3505021671103;3963.742356746802;4070.816813243352;4084.2852500812833;3443.517907492953;3464.082018265162;3506.7731990186417;3552.307300076512;3574.303010912899;988.9676714352075;1017.2675673515057;1021.7343490692474;1024.9795004099876;1040.3601784902382;829.5686243153647;831.4720152703077;843.5950743643085;845.9069502354736;850.0479463001354;5145.279660847485;5337.238711225286;5358.97320513395;5456.890862182734;5529.529989950899;402.20363679913936;409.21226638720344;410.03436906086336;416.6812388522782;420.5437100745664;3630.981845090758;3746.213295208037;3750.587435382106;3804.6575808177395;3866.555346135174;9575;10164.28849980509;10166.288359814742;10176.542055607515;10179.18566514677;9962.601495940082;10014.899851001543;10103.545340459697;10143.391396516232;10160.187185025181;7442.66508007141;7590.430717696195;7613.467057306047;7639;7646.279587092859;5561.277033985556;5672;5719.370869204467;5744.253247077853;5800.738966746591;9397.530123493661;9514.809703805746;9524.809503810024;9525.618975240914;9540.713778586654;8712.607932643174;9101.40840845343;9105.726828195166;9501.952490237505;9536.904630953602;6220.409061139185;6352.777652782131;6462.579932304385;6757.695903684445;7041.647917604202;7317.15852676949;7335.413166946525;7384.48308618413;7416.147143078615;7443.18125006238;6525.543211975306;6684.364985326386;6719.832004199934;6783.491238157059;6824.7952561423235;6432.067350234283;6499;6507.837304067436;6513.576617519846;6598.241202261801;6145.35473775265;6156.107364432221;6172.290186628596;6178.1350610913605;6229.314775374796;4156.9792151040265;4266.125444283853;4384.4519435070615;4463.620592249695;4472.552744725502;4214.578542145761;4229.53475117743;4378.824847006212;4406.272964960745;4512.255477846119 14:47:24 INFO - PROCESS | 18705 | |4;prototype.html;283.8552338307463;288.26636210843407;292.4560317808875;294.7435730914105;296.3406420713912;4836.951630483694;4847.321375007497;4890.364252647159;4897.53473420025;4943.258511223314;4531.796069176887;4611.723296602207;4656.3015547667865;4768.713877167373;4778.856634300968;3783.3946568549036;3817.7136714746366;3825.7321987460887;3831.9808400957954;3853.6917046636204;3831.195448955709;3841.8271177797064;3845.288621604998;3846.788426636534;3869.2454971280613;3611.7110631149576;3683.5395575553057;3780.111673756665;3792.7345085844004;3798.7150963677695;3765.190484045916;3777.1312598102318;3785.545734511849;3808.219315040438;3823.636754508317;3354.530365748797;3360.2103505676146;3373.662633736631;3386.6613338666184;3388.695017448417;4316.633086187678;4547.431136257986;4554.681172317939;4588.609968152711;4627.676062675614;4254.659627229814;4261.595148460891;4370.907273181705;4376.5623437656295;4380.6276466500385;4905.2151655734915;4925.38432695913;4939.55544001038;4979.7261150636705;4996.600271978233;3688.391415416453;3691.187938653492;3693.672986018818;3699.1861790406338;3702.4816525686424;5017;5154.433012368637;5182.196759502283;5200.869978250536;5205.973970130125;3741.1021354874633;3744.26986737589;3746.4754934309217;3750.7937063461773;3777.3011992780876;3789.204267103884;3819.3125237457525;3823.3691440912494;3843.577206507282;3850.4994350734787;4062.979685101556;4259.5101563319995;4284.8500302489265;4311.611954924072;4324.76744127922;5017.749112544431;5037.496250374933;5066.265391518209;5069.138246498104;5079.517445842639;1206.4872429217548;1272.6563827766452;1290.3612711707765;1305.3603734170188;1334.252818421687;858.9957050214834;869.7782065573239;888.9199972002551;892.1346294094718;896.4845214001845;3957.782321972262;3981.2037592481042;3984.561698213194;3991.2217117661776;4020.577839326887;4515.209838278354;4561.931571026437;4571.771411429415;4621.560951709582;4638.234691275969;3976.5029371328583;3981.3629819228786;4003.3794761811964;4040.959590404117;4042.6361627453084;2379.262428647125;2433.2578563537936;2471.295680730983;2483.341914392687;2490.6139548370033;4334.566543345641;4414.234306277514;4422.341621891791;4428.512863585003;4443.266860967904;4632.5135860734135;4656.278276867091;4675.298705194248;4688.390509233846;4736.550027747358;4222.7888605570215;4348.891277718019;4383.2604622111185;4439.578240067124;4468;4658.715605498183;4663.906721865475;4665.370175026328;4667.813287468463;4678.391809064799;4549.977250113729;4574.977125114487;4578.771061446981;4596.287575425815;4605.769711514478;4012.518497780285;4345.2395830728865;4357.389965404783;4451.59935605797;4462.665300102441;3412.7646391613534;3426.434638284655;3428.8457019433686;3437.9656203437644;3440.346334196495;4597.264627546604;4599.379083823641;4626.033935577433;4634.702283360664;4869.342638743724;4786.305985631994;5060.292743382272;5080.339555857715;5081.611642528006;5090.618203634668;5045.672031317952;5051.520105589963;5051.696898186121;5056.544910958031;5064.417591976822;4834.1298566257;4989.775460104376;4989.950100498949;5007.699538027584;5019.121653710659;5045.949540504695;5052.72210028452;5079.9238011429115;5087.465816089405;5100.260462232881;4972.7762250699525;4987.700737955734;4992.475790042138;5004.099262132851;5014.6991180529285 14:47:24 INFO - PROCESS | 18705 | |5;yui.html;595.9851003724908;644.1690219616693;645.1709553224108;658.0918332700872;758.9051368578928;12247.387630618477;13437.798433023512;13893.444262229512;13902.096363736362;14279.571612851605;13773.93113034436;13829.585112446643;14039.719205615907;14100.788488172686;14126.364313605887;648.4423395879539;806.7983004248938;827.185222555782;830.086904405154;837.9455335403179;825.1253671108644;825.3644693585935;827.9130691277419;827.954462504562;828.1842385250524;863.6372723456163;863.9784005399853;865.5672163918041;866.0906048648925;866.5234121233296;850.8978922529274;851.8296340731847;859.1365677494109;859.1494420523636;859.3211363023266;625.0374423387977;625.2528228766625;625.262190615074;625.3902445115975;625.737190380037;12916.354182290848;12969.481220751159;13016.219026858418;13034.217946923214;13071.215727056311;12008.579699710555;12156.149069565134;12279.079069069767;12371.628851134481;12704.110712250145;9508.667196648084;10112.241581881315;10275.177985761196;10524.263301568893;10638.042576168182;3229.54786329914;3295.47272436409;3313.6189338226172;3437.1922598189403;3447;47889.52110478885;49394;49956.25065624018;50026.49973500255;50375.496245037444;9230;9342.205912497378;9378.249740020781;9522;9577.760555986017;15583.298751556207;16133.838661613234;16142.35430582787;16146.03123812575;16151.838481615268;6870.7595234166565;6891.448684105259;6912;6930.272321406281;6990.300969902969;3765.3975363941636;3783.4703141560203;3801.334766415866;3808.2383523295453;3857.8842634721004;2811.943761124766;2905.898293559715;2909.258139174497;2909.956350654742;2910.7962442628814;485.8105338917825;510.4640127865726;510.4895104895105;531.1422053383758;559.1221781802612;493.2822742909059;534.7032397019691;553.7784886045614;585.6573904266052;625.0187206086491;8131.9593402032615;8243.505389676518;8252.174782521699;8264.462809917337;8381.161883811692;540.6512799244465;614.8739508400768;619.7459041792844;638.8562573421036;648.0182523476936;3680.3743363628246;3680.5031320771886;3708.4808126862263;3764.265968136187;3846.1346197105427;62098.689506553084;62888.68555657192;63064.36935630585;63813.680931595976;63966;55207;55246;55502.72248638731;55999.160012599845;56105.43894561084;42154.789226053676;42696.35955460671;42783;45617.31574026459;50344.74827625838;8490.872636910575;8548.495117002;8550.358723095917;8565.48607083577;8567.186117318844;30200.24499387533;30808;30828.383432331677;32198.229097399868;32274.193145171557;39371.80314098411;39622.2075558493;39757.60242397539;39908.2018359637;40803;10931.453427328443;10962.232643715182;10979.28634638746;11031.61389351401;11082.667519974413;12104.45529951172;12112.818307725567;12155.088368372584;12946.287954162612;13100.475980960655;11339.092872570009;11625.941870290595;11804.940975295412;11980.161388702707;12173.939130304292;11625.302481851117;11670.70823229426;11749.765004699688;11994.792650084099;12110.878891210976;11020;11278.49246783913;11443.439524163892;11469.197156198987;11758.294502329887;9228.215601673664;9787.657431989846;9802.068803463659;10117.696469105938;10139.61925625608;9684.70945871625;9685.564149613143;9717.222622190066;9789.52326648002;10149.492525373555 14:47:24 INFO - PROCESS | 18705 | __end_tp_report 14:47:24 INFO - PROCESS | 18705 | __start_cc_report 14:47:24 INFO - PROCESS | 18705 | _x_x_mozilla_cycle_collect,848 14:47:24 INFO - PROCESS | 18705 | __end_cc_report 14:47:24 INFO - PROCESS | 18705 | __startTimestamp1464040044361__endTimestamp 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | ------- Summary: start ------- 14:47:24 INFO - PROCESS | 18705 | Number of tests: 6 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | [#0] dojo.html Cycles:165 Average:4731.24 Median:4854.08 stddev:495.47 (10.2%) stddev-sans-first:470.20 14:47:24 INFO - PROCESS | 18705 | Values: 2682.5 2714.3 2721.9 2743.6 2763.6 4633.7 4688.5 4775.3 4854.1 4870.2 4711.0 4714.8 4724.2 4796.1 4798.4 4179.1 4314.6 4386.5 4433.2 4569.4 4476.2 4519.7 4532.0 4538.1 4563.1 4269.6 4311.1 4347.1 4347.2 4408.4 4345.1 4358.8 4403.0 4409.4 4412.0 4391.6 4396.3 4399.5 4407.0 4433.2 4485.7 4685.8 4757.6 4772.5 4773.8 5127.9 5140.6 5185.5 5198.8 5201.9 5033.4 5182.7 5184.5 5184.6 5226.5 4676.8 4728.8 4729.6 4777.7 4799.1 5242.2 5250.2 5250.2 5251.5 5261.8 4893.0 4984.0 5095.7 5127.9 5133.2 5118.6 5128.2 5152.7 5153.5 5202.9 5100.3 5109.9 5115.2 5117.1 5167.4 4922.1 4980.0 5051.7 5086.7 5094.3 4310.3 4316.3 4338.4 4348.2 4355.4 3770.1 3772.8 3779.7 3795.4 3809.4 4295.6 4329.5 4449.5 4451.4 4479.3 5073.0 5140.7 5144.6 5149.5 5160.3 4393.6 4441.2 4444.2 4457.8 4474.0 4469.5 4553.7 4606.6 4617.0 4643.5 4863.9 4867.2 4887.0 4901.7 4931.6 5140.3 5156.9 5161.9 5162.2 5203.0 4665.0 4794.4 4844.5 4847.3 4935.9 5064.2 5076.8 5088.2 5091.9 5119.9 5164.7 5165.1 5175.0 5175.9 5204.5 4851.1 4872.5 4886.7 4890.2 5004.0 4890.4 4914.9 4922.5 4927.2 4959.8 4767.4 4815.6 4823.7 4838.3 4881.2 5008.7 5064.9 5073.2 5076.6 5079.1 4935.8 4958.0 4971.1 4974.5 5019.3 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | [#1] ext.html Cycles:180 Average:44637.78 Median:19261.94 stddev:81719.04 (424.3%) stddev-sans-first:81881.21 14:47:24 INFO - PROCESS | 18705 | Values: 539.3 578.4 579.1 595.0 600.1 26003.9 39941.2 40700.8 40809.0 40850.8 38915.6 39248.6 39340.0 39391.8 39441.0 7461.9 7588.4 7798.7 7801.0 9806.7 9677.4 10113.8 10115.1 10117.0 10121.1 10077.9 10151.1 10154.7 10157.8 10158.1 7562.4 9857.9 10058.7 10086.6 10088.2 9990.5 10085.1 10092.0 10092.2 10111.1 37047.6 37205.0 37397.6 37526.6 37551.6 3116.9 3355.5 3530.2 3786.3 3819.8 29322.0 29595.4 29627.9 29792.7 29994.3 3514.2 3516.3 3638.8 3671.5 3678.5 260310.0 260745.0 261258.0 261812.0 262593.0 28922.6 29723.8 29756.7 46616.5 47082.0 33474.5 33567.3 33615.3 33687.8 33690.3 11593.8 11682.6 11739.5 11745.5 11754.4 8235.6 9100.3 9292.5 9308.1 9467.6 7851.4 7884.7 7923.2 7970.5 7981.2 3093.2 3107.0 3118.4 3161.6 3169.1 868.6 871.1 915.8 954.4 1022.4 27234.5 28500.9 28954.1 29043.6 29065.9 972.1 994.9 1037.8 1045.9 1067.6 14908.6 15221.2 15381.2 15519.4 15576.9 399344.0 402057.0 402784.0 403420.0 404582.0 50135.2 50615.0 50628.0 50635.2 50704.5 992.9 1205.1 1214.9 1223.7 1237.9 28200.0 29312.9 29441.0 29458.7 29727.4 42021.0 42624.8 42683.0 42716.6 42736.8 235949.0 240381.0 241483.0 241542.0 241807.0 20296.6 24292.0 24775.0 24843.3 26574.7 41996.0 42106.6 42553.8 43057.4 43095.8 35196.1 36326.3 36831.0 36968.4 37228.0 35600.3 36027.6 36136.3 36350.3 36474.8 35009.6 35331.8 35909.0 36041.6 36075.0 30782.4 32326.0 32358.0 32628.3 32848.3 24628.4 24785.9 24957.9 25260.5 25523.2 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | [#2] jquery.html Cycles:180 Average:24748.56 Median:4556.67 stddev:68203.39 (1496.8%) stddev-sans-first:68370.14 14:47:24 INFO - PROCESS | 18705 | Values: 364.9 365.8 368.2 375.8 390.1 15560.1 16854.2 16951.9 17197.7 17413.6 15814.9 15917.4 16191.2 16318.7 16364.5 5101.9 5298.3 5301.9 5303.2 5307.2 3765.2 3884.7 5220.8 5761.3 6099.4 6130.4 6136.5 6158.7 6165.5 6171.1 5979.3 6072.1 6080.8 6086.6 6092.8 3416.9 5104.4 5286.9 5421.9 5428.6 19876.5 20447.8 20493.8 20918.1 20996.3 1977.3 2002.7 2039.7 2095.8 2174.3 8788.8 9006.2 9408.7 9608.9 13154.2 1768.3 1845.3 1863.5 1866.1 1882.2 60315.7 60600.0 60984.7 65110.3 71635.0 10265.2 10281.4 10309.7 10459.1 10556.8 14315.1 14440.0 14506.1 14512.0 14544.7 6208.0 6393.3 6485.6 6492.4 6547.9 5673.8 5756.9 5818.1 5845.1 5870.6 4455.9 4488.4 4546.4 4555.0 4558.4 1722.6 1742.8 1796.1 1850.3 1867.5 875.6 928.6 929.0 934.5 969.4 16294.8 16611.3 17018.1 17129.4 17342.9 868.1 872.2 905.5 921.3 936.6 9219.0 9678.8 10298.2 10508.3 10638.9 404443.0 414971.0 415976.0 417097.0 419185.0 77564.6 77976.2 78016.0 79181.0 80614.6 982.8 991.9 995.3 1010.3 1018.3 15528.1 15720.0 15843.8 15868.7 16237.7 24973.6 36048.0 36130.6 36257.3 36541.6 48536.5 49068.5 50680.5 50822.0 51687.2 7574.8 7619.5 7676.2 7803.1 8007.2 9641.9 11466.5 11657.9 11691.0 11703.0 9846.6 10208.6 10275.7 10301.7 10317.5 9710.8 9767.2 9869.8 10168.2 10432.8 9550.0 9813.0 10228.3 10510.7 10592.3 7357.2 7450.1 7467.2 7471.9 7489.3 8845.3 9206.9 9305.3 9341.1 9573.3 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | [#3] mootools.html Cycles:180 Average:5155.55 Median:4468.09 stddev:2991.79 (67.0%) stddev-sans-first:2986.01 14:47:24 INFO - PROCESS | 18705 | Values: 1280.3 1424.5 1470.7 1574.0 1786.9 6582.1 7598.8 7800.3 7811.4 8016.8 7784.3 7915.6 7929.0 7935.7 7940.6 2193.7 2219.1 2221.8 2222.4 2223.9 2167.6 2186.7 2204.0 2206.0 2208.6 2166.7 2185.0 2192.6 2194.7 2194.9 2126.3 2131.5 2133.8 2134.4 2135.3 2103.4 2159.1 2159.5 2163.2 2165.4 7761.7 7903.4 7921.0 7926.4 7955.9 4341.5 4512.7 4529.0 4530.5 4535.5 2899.3 2922.5 2950.5 2960.5 3032.8 916.6 930.8 941.3 969.6 976.6 11049.8 11111.4 11136.7 11161.3 11175.1 4043.8 4094.5 4158.7 4161.6 4210.3 8771.0 8794.3 8827.7 8836.7 8845.2 4419.8 4427.8 4440.7 4444.8 4444.9 3473.6 3936.4 3963.7 4070.8 4084.3 3443.5 3464.1 3506.8 3552.3 3574.3 989.0 1017.3 1021.7 1025.0 1040.4 829.6 831.5 843.6 845.9 850.0 5145.3 5337.2 5359.0 5456.9 5529.5 402.2 409.2 410.0 416.7 420.5 3631.0 3746.2 3750.6 3804.7 3866.6 9575.0 10164.3 10166.3 10176.5 10179.2 9962.6 10014.9 10103.5 10143.4 10160.2 7442.7 7590.4 7613.5 7639.0 7646.3 5561.3 5672.0 5719.4 5744.3 5800.7 9397.5 9514.8 9524.8 9525.6 9540.7 8712.6 9101.4 9105.7 9502.0 9536.9 6220.4 6352.8 6462.6 6757.7 7041.6 7317.2 7335.4 7384.5 7416.1 7443.2 6525.5 6684.4 6719.8 6783.5 6824.8 6432.1 6499.0 6507.8 6513.6 6598.2 6145.4 6156.1 6172.3 6178.1 6229.3 4157.0 4266.1 4384.5 4463.6 4472.6 4214.6 4229.5 4378.8 4406.3 4512.3 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | [#4] prototype.html Cycles:180 Average:4038.13 Median:4434.05 stddev:1146.91 (25.9%) stddev-sans-first:1114.97 14:47:24 INFO - PROCESS | 18705 | Values: 283.9 288.3 292.5 294.7 296.3 4837.0 4847.3 4890.4 4897.5 4943.3 4531.8 4611.7 4656.3 4768.7 4778.9 3783.4 3817.7 3825.7 3832.0 3853.7 3831.2 3841.8 3845.3 3846.8 3869.2 3611.7 3683.5 3780.1 3792.7 3798.7 3765.2 3777.1 3785.5 3808.2 3823.6 3354.5 3360.2 3373.7 3386.7 3388.7 4316.6 4547.4 4554.7 4588.6 4627.7 4254.7 4261.6 4370.9 4376.6 4380.6 4905.2 4925.4 4939.6 4979.7 4996.6 3688.4 3691.2 3693.7 3699.2 3702.5 5017.0 5154.4 5182.2 5200.9 5206.0 3741.1 3744.3 3746.5 3750.8 3777.3 3789.2 3819.3 3823.4 3843.6 3850.5 4063.0 4259.5 4284.9 4311.6 4324.8 5017.7 5037.5 5066.3 5069.1 5079.5 1206.5 1272.7 1290.4 1305.4 1334.3 859.0 869.8 888.9 892.1 896.5 3957.8 3981.2 3984.6 3991.2 4020.6 4515.2 4561.9 4571.8 4621.6 4638.2 3976.5 3981.4 4003.4 4041.0 4042.6 2379.3 2433.3 2471.3 2483.3 2490.6 4334.6 4414.2 4422.3 4428.5 4443.3 4632.5 4656.3 4675.3 4688.4 4736.6 4222.8 4348.9 4383.3 4439.6 4468.0 4658.7 4663.9 4665.4 4667.8 4678.4 4550.0 4575.0 4578.8 4596.3 4605.8 4012.5 4345.2 4357.4 4451.6 4462.7 3412.8 3426.4 3428.8 3438.0 3440.3 4597.3 4599.4 4626.0 4634.7 4869.3 4786.3 5060.3 5080.3 5081.6 5090.6 5045.7 5051.5 5051.7 5056.5 5064.4 4834.1 4989.8 4990.0 5007.7 5019.1 5045.9 5052.7 5079.9 5087.5 5100.3 4972.8 4987.7 4992.5 5004.1 5014.7 14:47:24 INFO - PROCESS | 18705 | 14:47:24 INFO - PROCESS | 18705 | [#5] yui.html Cycles:180 Average:13738.37 Median:46753.42 stddev:16367.98 (35.0%) stddev-sans-first:16384.14 14:47:24 INFO - PROCESS | 18705 | Values: 596.0 644.2 645.2 658.1 758.9 12247.4 13437.8 13893.4 13902.1 14279.6 13773.9 13829.6 14039.7 14100.8 14126.4 648.4 806.8 827.2 830.1 837.9 825.1 825.4 827.9 828.0 828.2 863.6 864.0 865.6 866.1 866.5 850.9 851.8 859.1 859.1 859.3 625.0 625.3 625.3 625.4 625.7 12916.4 12969.5 13016.2 13034.2 13071.2 12008.6 12156.1 12279.1 12371.6 12704.1 9508.7 10112.2 10275.2 10524.3 10638.0 3229.5 3295.5 3313.6 3437.2 3447.0 47889.5 49394.0 49956.3 50026.5 50375.5 9230.0 9342.2 9378.2 9522.0 9577.8 15583.3 16133.8 16142.4 16146.0 16151.8 6870.8 6891.4 6912.0 6930.3 6990.3 3765.4 3783.5 3801.3 3808.2 3857.9 2811.9 2905.9 2909.3 2910.0 2910.8 485.8 510.5 510.5 531.1 559.1 493.3 534.7 553.8 585.7 625.0 8132.0 8243.5 8252.2 8264.5 8381.2 540.7 614.9 619.7 638.9 648.0 3680.4 3680.5 3708.5 3764.3 3846.1 62098.7 62888.7 63064.4 63813.7 63966.0 55207.0 55246.0 55502.7 55999.2 56105.4 42154.8 42696.4 42783.0 45617.3 50344.7 8490.9 8548.5 8550.4 8565.5 8567.2 30200.2 30808.0 30828.4 32198.2 32274.2 39371.8 39622.2 39757.6 39908.2 40803.0 10931.5 10962.2 10979.3 11031.6 11082.7 12104.5 12112.8 12155.1 12946.3 13100.5 11339.1 11625.9 11804.9 11980.2 12173.9 11625.3 11670.7 11749.8 11994.8 12110.9 11020.0 11278.5 11443.4 11469.2 11758.3 9228.2 9787.7 9802.1 10117.7 10139.6 9684.7 9685.6 9717.2 9789.5 10149.5 14:47:24 INFO - PROCESS | 18705 | -------- Summary: end -------- 14:47:24 INFO - PROCESS | 18705 | 14:47:25 INFO - TEST-INFO | 18705: exit 0 14:47:25 INFO - TEST-OK | dromaeo_css | took 1120664ms 14:47:25 INFO - TEST-START | kraken 14:47:25 INFO - operating with platform_type : linux_ 14:47:25 INFO - Initialising browser for kraken test... 14:47:25 INFO - TEST-INFO | started process 18884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCrU0lb/profile http://localhost:35884/getInfo.html) 14:47:30 INFO - PROCESS | 18884 | __metrics Screen width/height:1600/1200 14:47:30 INFO - PROCESS | 18884 | colorDepth:24 14:47:30 INFO - PROCESS | 18884 | Browser inner width/height: 1024/697 14:47:30 INFO - PROCESS | 18884 | __metrics 14:47:32 ERROR - PROCESS | 18884 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:47:33 INFO - TEST-INFO | 18884: exit 0 14:47:33 INFO - Browser initialized. 14:47:33 INFO - Running cycle 1/1 for kraken test... 14:47:33 INFO - TEST-INFO | started process 18965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCrU0lb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:45 INFO - PROCESS | 18965 | RSS: Main: 154533888 14:47:45 INFO - PROCESS | 18965 | 14:47:48 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35884/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:49 INFO - PROCESS | 18965 | RSS: Main: 211021824 14:47:49 INFO - PROCESS | 18965 | 14:47:51 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35884/tests/kraken/driver.html?testName=audio-dft) 14:47:52 INFO - PROCESS | 18965 | RSS: Main: 198463488 14:47:52 INFO - PROCESS | 18965 | 14:47:55 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35884/tests/kraken/driver.html?testName=audio-fft) 14:47:56 INFO - PROCESS | 18965 | RSS: Main: 267563008 14:47:56 INFO - PROCESS | 18965 | 14:47:58 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35884/tests/kraken/driver.html?testName=audio-oscillator) 14:47:59 INFO - PROCESS | 18965 | RSS: Main: 177504256 14:47:59 INFO - PROCESS | 18965 | 14:48:01 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:02 INFO - PROCESS | 18965 | RSS: Main: 180555776 14:48:02 INFO - PROCESS | 18965 | 14:48:05 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35884/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:06 INFO - PROCESS | 18965 | RSS: Main: 216231936 14:48:06 INFO - PROCESS | 18965 | 14:48:10 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35884/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:10 INFO - PROCESS | 18965 | RSS: Main: 214491136 14:48:10 INFO - PROCESS | 18965 | 14:48:13 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35884/tests/kraken/driver.html?testName=json-parse-financial) 14:48:14 INFO - PROCESS | 18965 | RSS: Main: 215621632 14:48:14 INFO - PROCESS | 18965 | 14:48:16 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:16 INFO - PROCESS | 18965 | RSS: Main: 210034688 14:48:16 INFO - PROCESS | 18965 | 14:48:18 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:19 INFO - PROCESS | 18965 | RSS: Main: 214052864 14:48:19 INFO - PROCESS | 18965 | 14:48:21 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:22 INFO - PROCESS | 18965 | RSS: Main: 219004928 14:48:22 INFO - PROCESS | 18965 | 14:48:25 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:25 INFO - PROCESS | 18965 | RSS: Main: 220966912 14:48:25 INFO - PROCESS | 18965 | 14:48:28 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:29 INFO - PROCESS | 18965 | RSS: Main: 220450816 14:48:29 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | Cycle 1(1): loaded http://localhost:35884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35884/tests/kraken/driver.html?testName=ai-astar) 14:48:31 INFO - PROCESS | 18965 | RSS: Main: 267501568 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | __start_tp_report 14:48:31 INFO - PROCESS | 18965 | _x_x_mozilla_page_load 14:48:31 INFO - PROCESS | 18965 | _x_x_mozilla_page_load_details 14:48:31 INFO - PROCESS | 18965 | |i|pagename|runs| 14:48:31 INFO - PROCESS | 18965 | |0;ai-astar;113;110;116;114;114;113;113;114;112;112 14:48:31 INFO - PROCESS | 18965 | |1;audio-beat-detection;159;130;130;222;130;133;156;128;172;129 14:48:31 INFO - PROCESS | 18965 | |2;audio-dft;162;160;162;161;161;162;161;161;163;162 14:48:31 INFO - PROCESS | 18965 | |3;audio-fft;75;76;75;140;77;76;75;75;131;74 14:48:31 INFO - PROCESS | 18965 | |4;audio-oscillator;92;93;158;93;99;94;124;93;93;138 14:48:31 INFO - PROCESS | 18965 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;116;116 14:48:31 INFO - PROCESS | 18965 | |6;imaging-darkroom;147;146;146;147;146;146;147;148;146;146 14:48:31 INFO - PROCESS | 18965 | |7;imaging-desaturate;95;95;95;94;94;94;95;95;95;95 14:48:31 INFO - PROCESS | 18965 | |8;json-parse-financial;65;64;64;65;64;64;65;67;65;63 14:48:31 INFO - PROCESS | 18965 | |9;json-stringify-tinderbox;65;65;64;65;65;65;64;64;66;65 14:48:31 INFO - PROCESS | 18965 | |10;stanford-crypto-aes;82;81;82;83;83;87;83;85;175;95 14:48:31 INFO - PROCESS | 18965 | |11;stanford-crypto-ccm;132;140;132;137;132;144;140;138;159;130 14:48:31 INFO - PROCESS | 18965 | |12;stanford-crypto-pbkdf2;173;176;174;172;175;170;172;177;174;171 14:48:31 INFO - PROCESS | 18965 | |13;stanford-crypto-sha256-iterative;74;70;67;67;67;71;66;66;67;66 14:48:31 INFO - PROCESS | 18965 | __end_tp_report 14:48:31 INFO - PROCESS | 18965 | __start_cc_report 14:48:31 INFO - PROCESS | 18965 | _x_x_mozilla_cycle_collect,2097 14:48:31 INFO - PROCESS | 18965 | __end_cc_report 14:48:31 INFO - PROCESS | 18965 | __startTimestamp1464040111606__endTimestamp 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | ------- Summary: start ------- 14:48:31 INFO - PROCESS | 18965 | Number of tests: 14 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:1.60 (1.4%) stddev-sans-first:1.69 14:48:31 INFO - PROCESS | 18965 | Values: 113.0 110.0 116.0 114.0 114.0 113.0 113.0 114.0 112.0 112.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:144.50 stddev:30.16 (20.9%) stddev-sans-first:31.77 14:48:31 INFO - PROCESS | 18965 | Values: 159.0 130.0 130.0 222.0 130.0 133.0 156.0 128.0 172.0 129.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 14:48:31 INFO - PROCESS | 18965 | Values: 162.0 160.0 162.0 161.0 161.0 162.0 161.0 161.0 163.0 162.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:25.45 (33.9%) stddev-sans-first:26.60 14:48:31 INFO - PROCESS | 18965 | Values: 75.0 76.0 75.0 140.0 77.0 76.0 75.0 75.0 131.0 74.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.78 (25.6%) stddev-sans-first:24.53 14:48:31 INFO - PROCESS | 18965 | Values: 92.0 93.0 158.0 93.0 99.0 94.0 124.0 93.0 93.0 138.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:48:31 INFO - PROCESS | 18965 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 14:48:31 INFO - PROCESS | 18965 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 147.0 148.0 146.0 146.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:48:31 INFO - PROCESS | 18965 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 14:48:31 INFO - PROCESS | 18965 | Values: 65.0 64.0 64.0 65.0 64.0 64.0 65.0 67.0 65.0 63.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:48:31 INFO - PROCESS | 18965 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 66.0 65.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:83.00 stddev:28.89 (34.8%) stddev-sans-first:30.33 14:48:31 INFO - PROCESS | 18965 | Values: 82.0 81.0 82.0 83.0 83.0 87.0 83.0 85.0 175.0 95.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:139.00 stddev:8.54 (6.1%) stddev-sans-first:8.74 14:48:31 INFO - PROCESS | 18965 | Values: 132.0 140.0 132.0 137.0 132.0 144.0 140.0 138.0 159.0 130.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:2.22 (1.3%) stddev-sans-first:2.35 14:48:31 INFO - PROCESS | 18965 | Values: 173.0 176.0 174.0 172.0 175.0 170.0 172.0 177.0 174.0 171.0 14:48:31 INFO - PROCESS | 18965 | 14:48:31 INFO - PROCESS | 18965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.00 stddev:2.69 (4.0%) stddev-sans-first:1.81 14:48:31 INFO - PROCESS | 18965 | Values: 74.0 70.0 67.0 67.0 67.0 71.0 66.0 66.0 67.0 66.0 14:48:31 INFO - PROCESS | 18965 | -------- Summary: end -------- 14:48:31 INFO - PROCESS | 18965 | 14:48:32 INFO - TEST-INFO | 18965: exit 0 14:48:32 INFO - TEST-OK | kraken | took 67567ms 14:48:32 INFO - SUITE-END | took 1188s 14:48:33 INFO - Completed test suite (00:19:48) 14:48:33 INFO - javascript benchmark 14:48:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2682.5439675255207, 2714.2535802654256, 2721.869276413959, 2743.62961000265, 2763.640726705528, 4633.675642705012, 4688.53114688531, 4775.331453596495, 4854.077725232203, 4870.172070747973, 4710.952890471094, 4714.787834547445, 4724.196886529289, 4796.112719146951, 4798.376211092562, 4179.101493178966, 4314.6332561732215, 4386.495553011413, 4433.2241857674935, 4569.428821397325, 4476.216662084138, 4519.706219095765, 4532.0, 4538.069695712387, 4563.06457176278, 4269.637080848116, 4311.094670119279, 4347.130573885235, 4347.195768782785, 4408.426904502427, 4345.109252603209, 4358.847440339573, 4403.031333106712, 4409.4047303613925, 4411.955880441186, 4391.6486681065435, 4396.340548917656, 4399.5380485049245, 4406.955930440687, 4433.246348120827, 4485.6860019798305, 4685.765711714401, 4757.595604373632, 4772.522747725235, 4773.785179666923, 5127.897442051138, 5140.588752899759, 5185.455527169668, 5198.818041368571, 5201.869953251199, 5033.370828646419, 5182.714950677711, 5184.455632158607, 5184.611154163415, 5226.503482169188, 4676.766161691936, 4728.787204575802, 4729.6452766042685, 4777.713337199779, 4799.112164249625, 5242.213667949762, 5250.18622113573, 5250.212468129811, 5251.501107394792, 5261.789528418821, 4892.975535122373, 4983.975080124576, 5095.668781529189, 5127.948720512822, 5133.178691409356, 5118.61610379223, 5128.1794912813775, 5152.742362881841, 5153.484651534816, 5202.869928251748, 5100.336956195671, 5109.948900510947, 5115.155999260155, 5117.130087885069, 5167.3799144102195, 4922.064807686528, 4979.975100124549, 5051.722155281494, 5086.745662716849, 5094.337736094284, 4310.3103503439925, 4316.3093904975685, 4338.414314067623, 4348.239058164809, 4355.412019377343, 3770.0763312988493, 3772.773633581994, 3779.6787273081545, 3795.4306853972125, 3809.371453710107, 4295.613394794484, 4329.458817647794, 4449.532799056117, 4451.421315228999, 4479.328100784843, 5072.9746351268, 5140.691558506427, 5144.639875208774, 5149.536541711264, 5160.303359046556, 4393.626541743987, 4441.20058389493, 4444.200043992112, 4457.7548234846745, 4473.955260447419, 4469.4636643602325, 4553.7267763933605, 4606.631469482433, 4617.030423611012, 4643.489216186217, 4863.878403039952, 4867.221244600847, 4886.998165376161, 4901.730404827768, 4931.630127740362, 5140.331756871583, 5156.948430515647, 5161.948380516297, 5162.225666150108, 5203.0, 4665.0, 4794.4246690395985, 4844.515548445127, 4847.2729090636685, 4935.876603084952, 5064.215046667772, 5076.796928122833, 5088.236764485357, 5091.9490805092955, 5119.948800511947, 5164.690118592896, 5165.070287348313, 5175.0167468180925, 5175.896482070413, 5204.531592156724, 4851.078295123915, 4872.464028956882, 4886.657933944732, 4890.24201248807, 5004.0, 4890.437599676083, 4914.926276105933, 4922.532359425849, 4927.218315276478, 4959.752012399294, 4767.356406885026, 4815.590674792682, 4823.710577365369, 4838.298446725134, 4881.243407271879, 5008.69947803133, 5064.873378165576, 5073.188289873602, 5076.619253555924, 5079.085764562266, 4935.777889994887, 4958.0, 4971.105201063843, 4974.502549744997, 5019.322391477104], "value": 4700.2002242699655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3024958088356, 578.3782433883575, 579.1399771339562, 595.0241603769819, 600.0728873889842, 26003.869980650095, 39941.201175976465, 40700.796496017516, 40809.0, 40850.7957460213, 38915.610843891554, 39248.60751392485, 39340.0, 39391.80304098483, 39441.0, 7461.888071678929, 7588.430867684918, 7798.727044553413, 7801.0, 9806.705798826046, 9677.419354838697, 10113.848292275621, 10115.089641932225, 10117.0, 10121.139703125207, 10077.899221007807, 10151.086402223835, 10154.695359139238, 10157.796844063114, 10158.136558392509, 7562.395008399315, 9857.901420985841, 10058.74853128674, 10086.596536138546, 10088.243381746399, 9990.450525221182, 10085.092341689284, 10092.0, 10092.192624590016, 10111.09000189979, 37047.62952370469, 37205.0, 37397.62602373996, 37526.62473375286, 37551.62448375536, 3116.9220769480717, 3355.5302257683943, 3530.223350862806, 3786.2616789726017, 3819.8090095495113, 29322.0, 29595.408091838042, 29627.851860740557, 29792.70207297921, 29994.25014374658, 3514.2268700885766, 3516.314318707853, 3638.7634803737938, 3671.541057367829, 3678.521792167001, 260310.0, 260745.0, 261258.0, 261812.0, 262593.0, 28922.566161507595, 29723.770717196297, 29756.702432975828, 46616.533834661896, 47082.0, 33474.49788253178, 33567.3286534268, 33615.32769344648, 33687.831560842526, 33690.32619347648, 11593.768124637629, 11682.649520514398, 11739.47172377228, 11745.4714537846, 11754.353510557, 8235.588220588947, 9100.317476189311, 9292.488913109844, 9308.069193080637, 9467.573959171854, 7851.411144164211, 7884.72403465876, 7923.247291507298, 7970.4819186752675, 7981.161977992343, 3093.180307218589, 3107.0, 3118.3607360491046, 3161.636411812625, 3169.128489665314, 868.6395146014333, 871.063606622883, 915.8076803871262, 954.4416516337881, 1022.3967858963099, 27234.45531089367, 28500.85749571239, 28954.13137605875, 29043.56434653482, 29065.854670726512, 972.055878304179, 994.8507723841482, 1037.818381783185, 1045.8640376750973, 1067.572970811666, 14908.552743417715, 15221.162836043903, 15381.230938453033, 15519.37922483088, 15576.92211538935, 399344.0, 402057.0, 402784.0, 403420.0, 404582.0, 50135.24797128046, 50615.0, 50628.0, 50635.24047139296, 50704.49295507072, 992.8957459466797, 1205.090156931511, 1214.8724383939737, 1223.7368965672424, 1237.8638349781336, 28200.0, 29312.853435732686, 29441.0, 29458.705412946452, 29727.405451891274, 42021.0, 42624.786876065424, 42683.0, 42716.57283427126, 42736.78631606822, 235949.0, 240381.0, 241483.0, 241542.0, 241807.0, 20296.59406811826, 24291.96350456193, 24775.0, 24843.254702358958, 26574.734252657225, 41996.0, 42106.578934210265, 42553.787231063645, 43057.354139688556, 43095.78452107719, 35196.12009699778, 36326.27347452983, 36831.0, 36968.44547331846, 37228.0, 35600.28799423945, 36027.63972360243, 36136.27727445384, 36350.27299454049, 36474.817625912765, 35009.64990350166, 35331.82334088313, 35909.0, 36041.639583604876, 36075.0, 30782.384352313275, 32326.0, 32358.0, 32628.34743305168, 32848.34303313873, 24628.384290392885, 24785.87607061953, 24957.87521062383, 25260.49479010446, 25523.23430297094], "value": 16647.092281899175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.88688506562966, 365.7567717467884, 368.2487725040917, 375.800825562452, 390.05800990607685, 15560.144192069432, 16854.157292135376, 16951.915240423812, 17197.742033869472, 17413.564660883483, 15814.920925395385, 15917.363305467796, 16191.190440477958, 16318.673626527463, 16364.509064728047, 5101.923471147936, 5298.284731561228, 5301.920471192916, 5303.23103150043, 5307.177387504943, 3765.2469506098755, 3884.6698030667426, 5220.765065572039, 5761.279840019997, 6099.420555047285, 6130.356312587181, 6136.478399336062, 6158.6920653967345, 6165.475934545547, 6171.105189747484, 5979.2824861016525, 6072.119542666333, 6080.787172448965, 6086.634801911855, 6092.756289748405, 3416.8804091856914, 5104.387473503166, 5286.867828304285, 5421.864453388697, 5428.647137936022, 19876.503087422785, 20447.795522044737, 20493.79506204949, 20918.058687359106, 20996.265130720505, 1977.2980591889816, 2002.699595060738, 2039.734834471524, 2095.7904209579074, 2174.2716190076344, 8788.780280492974, 9006.1894429501, 9408.670696525658, 9608.903910960871, 13154.21074735519, 1768.32803534656, 1845.2895635180419, 1863.5434318591897, 1866.0762922353522, 1882.200064972395, 60315.69842150805, 60600.0, 60984.695076524775, 65110.3488965109, 71635.0, 10265.178785697126, 10281.383117013003, 10309.74225644365, 10459.110975567162, 10556.841647375295, 14315.069520481135, 14440.0, 14506.1296322221, 14512.0, 14544.709105817825, 6208.013435700623, 6393.264774550893, 6485.643289619022, 6492.415682588589, 6547.854125528013, 5673.77304907799, 5756.908389719848, 5818.0981947798155, 5845.09401042839, 5870.647761134345, 4455.866324010285, 4488.371627972087, 4546.40896683429, 4554.95445045552, 4558.384618076583, 1722.5607470095297, 1742.7647267618963, 1796.1378538301688, 1850.296887182889, 1867.5144462439864, 875.6497401039635, 928.6146249306597, 928.9814203715888, 934.5047125023748, 969.3795970578835, 16294.755578666329, 16611.335546578244, 17018.14909254532, 17129.400470983455, 17342.913285433493, 868.1448772958631, 872.2498651159997, 905.5110240470073, 921.318224513855, 936.5925822267335, 9218.953905230432, 9678.806423871483, 10298.17614590831, 10508.273583824583, 10638.89361106379, 404443.0, 414971.0, 415976.0, 417097.0, 419185.0, 77564.61217693989, 77976.22023779803, 78016.0, 79181.0, 80614.59692701616, 982.7985263021063, 991.8760154980628, 995.318207028188, 1010.2776514791959, 1018.2973748113777, 15528.145951972298, 15720.0, 15843.841561584237, 15868.68262634764, 16237.675246494768, 24973.625395618717, 36048.0, 36130.63869361273, 36257.27485450329, 36541.634583653824, 48536.5146348532, 49068.50931490639, 50680.493195067575, 50822.0, 51687.2246916289, 7574.810629734301, 7619.504732192389, 7676.193999629959, 7803.061810548104, 8007.239312265326, 9641.855372169563, 11466.484008219484, 11657.941710291734, 11691.012527870113, 11703.0, 9846.60613575449, 10208.591656333663, 10275.7431064224, 10301.690949271533, 10317.535710892878, 9710.75723106928, 9767.218622510325, 9869.802603947737, 10168.186545076229, 10432.791344173225, 9550.0, 9813.0, 10228.335158214692, 10510.737231569272, 10592.258541901992, 7357.153927298215, 7450.0687414073245, 7467.215942325977, 7471.8879216812875, 7489.28851759082, 8845.336599754915, 9206.907930920604, 9305.255579553756, 9341.11259430353, 9573.329866909527], "value": 8215.87100731242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.31503145817, 1424.5156646740108, 1470.67645118074, 1573.9921300393496, 1786.9374571889987, 6582.111414958979, 7598.77203683889, 7800.258975397328, 7811.375089992794, 8016.799580010503, 7784.299413052824, 7915.6042197890165, 7929.0, 7935.722249721261, 7940.6029698514985, 2193.7257842769695, 2219.0679914435896, 2221.8111460525793, 2222.422170235742, 2223.944401389962, 2167.5989941860726, 2186.693862859193, 2204.019211450905, 2205.9889700551553, 2208.5914105890383, 2166.7183266175375, 2184.967225491611, 2192.572448372568, 2194.703714998471, 2194.890255487227, 2126.3302059851176, 2131.531063166101, 2133.807957283852, 2134.4450442884886, 2135.3273718778614, 2103.4215590712524, 2159.1255541505716, 2159.4709296222527, 2163.1996161420216, 2165.404513758713, 7761.72833950809, 7903.446758726892, 7921.049474063092, 7926.445148839583, 7955.920440795576, 4341.500727416356, 4512.661550383735, 4528.954710452919, 4530.478994915594, 4535.478419981679, 2899.3041669999047, 2922.459345021178, 2950.468915595192, 2960.467115919134, 3032.8331941743195, 916.5600511754328, 930.7952250504878, 941.2658126661147, 969.6363863551169, 976.584951395661, 11049.779004419946, 11111.388873611948, 11136.721581960435, 11161.274517156358, 11175.050120739746, 4043.7978101094827, 4094.488188976378, 4158.6673066154635, 4161.56303588125, 4210.305299625588, 8770.956145219234, 8794.252488538417, 8827.69103081389, 8836.690715824916, 8845.24815390699, 4419.823207071746, 4427.756473393994, 4440.689151759346, 4444.8444304449185, 4444.933326000112, 3473.6179020307745, 3936.3505021671103, 3963.742356746802, 4070.816813243352, 4084.2852500812833, 3443.517907492953, 3464.082018265162, 3506.7731990186417, 3552.307300076512, 3574.303010912899, 988.9676714352075, 1017.2675673515057, 1021.7343490692474, 1024.9795004099876, 1040.3601784902382, 829.5686243153647, 831.4720152703077, 843.5950743643085, 845.9069502354736, 850.0479463001354, 5145.279660847485, 5337.238711225286, 5358.97320513395, 5456.890862182734, 5529.529989950899, 402.20363679913936, 409.21226638720344, 410.03436906086336, 416.6812388522782, 420.5437100745664, 3630.981845090758, 3746.213295208037, 3750.587435382106, 3804.6575808177395, 3866.555346135174, 9575.0, 10164.28849980509, 10166.288359814742, 10176.542055607515, 10179.18566514677, 9962.601495940082, 10014.899851001543, 10103.545340459697, 10143.391396516232, 10160.187185025181, 7442.66508007141, 7590.430717696195, 7613.467057306047, 7639.0, 7646.279587092859, 5561.277033985556, 5672.0, 5719.370869204467, 5744.253247077853, 5800.738966746591, 9397.530123493661, 9514.809703805746, 9524.809503810024, 9525.618975240914, 9540.713778586654, 8712.607932643174, 9101.40840845343, 9105.726828195166, 9501.952490237505, 9536.904630953602, 6220.409061139185, 6352.777652782131, 6462.579932304385, 6757.695903684445, 7041.647917604202, 7317.15852676949, 7335.413166946525, 7384.48308618413, 7416.147143078615, 7443.18125006238, 6525.543211975306, 6684.364985326386, 6719.832004199934, 6783.491238157059, 6824.7952561423235, 6432.067350234283, 6499.0, 6507.837304067436, 6513.576617519846, 6598.241202261801, 6145.35473775265, 6156.107364432221, 6172.290186628596, 6178.1350610913605, 6229.314775374796, 4156.9792151040265, 4266.125444283853, 4384.4519435070615, 4463.620592249695, 4472.552744725502, 4214.578542145761, 4229.53475117743, 4378.824847006212, 4406.272964960745, 4512.255477846119], "value": 4047.7189816621913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8552338307463, 288.26636210843407, 292.4560317808875, 294.7435730914105, 296.3406420713912, 4836.951630483694, 4847.321375007497, 4890.364252647159, 4897.53473420025, 4943.258511223314, 4531.796069176887, 4611.723296602207, 4656.3015547667865, 4768.713877167373, 4778.856634300968, 3783.3946568549036, 3817.7136714746366, 3825.7321987460887, 3831.9808400957954, 3853.6917046636204, 3831.195448955709, 3841.8271177797064, 3845.288621604998, 3846.788426636534, 3869.2454971280613, 3611.7110631149576, 3683.5395575553057, 3780.111673756665, 3792.7345085844004, 3798.7150963677695, 3765.190484045916, 3777.1312598102318, 3785.545734511849, 3808.219315040438, 3823.636754508317, 3354.530365748797, 3360.2103505676146, 3373.662633736631, 3386.6613338666184, 3388.695017448417, 4316.633086187678, 4547.431136257986, 4554.681172317939, 4588.609968152711, 4627.676062675614, 4254.659627229814, 4261.595148460891, 4370.907273181705, 4376.5623437656295, 4380.6276466500385, 4905.2151655734915, 4925.38432695913, 4939.55544001038, 4979.7261150636705, 4996.600271978233, 3688.391415416453, 3691.187938653492, 3693.672986018818, 3699.1861790406338, 3702.4816525686424, 5017.0, 5154.433012368637, 5182.196759502283, 5200.869978250536, 5205.973970130125, 3741.1021354874633, 3744.26986737589, 3746.4754934309217, 3750.7937063461773, 3777.3011992780876, 3789.204267103884, 3819.3125237457525, 3823.3691440912494, 3843.577206507282, 3850.4994350734787, 4062.979685101556, 4259.5101563319995, 4284.8500302489265, 4311.611954924072, 4324.76744127922, 5017.749112544431, 5037.496250374933, 5066.265391518209, 5069.138246498104, 5079.517445842639, 1206.4872429217548, 1272.6563827766452, 1290.3612711707765, 1305.3603734170188, 1334.252818421687, 858.9957050214834, 869.7782065573239, 888.9199972002551, 892.1346294094718, 896.4845214001845, 3957.782321972262, 3981.2037592481042, 3984.561698213194, 3991.2217117661776, 4020.577839326887, 4515.209838278354, 4561.931571026437, 4571.771411429415, 4621.560951709582, 4638.234691275969, 3976.5029371328583, 3981.3629819228786, 4003.3794761811964, 4040.959590404117, 4042.6361627453084, 2379.262428647125, 2433.2578563537936, 2471.295680730983, 2483.341914392687, 2490.6139548370033, 4334.566543345641, 4414.234306277514, 4422.341621891791, 4428.512863585003, 4443.266860967904, 4632.5135860734135, 4656.278276867091, 4675.298705194248, 4688.390509233846, 4736.550027747358, 4222.7888605570215, 4348.891277718019, 4383.2604622111185, 4439.578240067124, 4468.0, 4658.715605498183, 4663.906721865475, 4665.370175026328, 4667.813287468463, 4678.391809064799, 4549.977250113729, 4574.977125114487, 4578.771061446981, 4596.287575425815, 4605.769711514478, 4012.518497780285, 4345.2395830728865, 4357.389965404783, 4451.59935605797, 4462.665300102441, 3412.7646391613534, 3426.434638284655, 3428.8457019433686, 3437.9656203437644, 3440.346334196495, 4597.264627546604, 4599.379083823641, 4626.033935577433, 4634.702283360664, 4869.342638743724, 4786.305985631994, 5060.292743382272, 5080.339555857715, 5081.611642528006, 5090.618203634668, 5045.672031317952, 5051.520105589963, 5051.696898186121, 5056.544910958031, 5064.417591976822, 4834.1298566257, 4989.775460104376, 4989.950100498949, 5007.699538027584, 5019.121653710659, 5045.949540504695, 5052.72210028452, 5079.9238011429115, 5087.465816089405, 5100.260462232881, 4972.7762250699525, 4987.700737955734, 4992.475790042138, 5004.099262132851, 5014.6991180529285], "value": 3677.914621003169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9851003724908, 644.1690219616693, 645.1709553224108, 658.0918332700872, 758.9051368578928, 12247.387630618477, 13437.798433023512, 13893.444262229512, 13902.096363736362, 14279.571612851605, 13773.93113034436, 13829.585112446643, 14039.719205615907, 14100.788488172686, 14126.364313605887, 648.4423395879539, 806.7983004248938, 827.185222555782, 830.086904405154, 837.9455335403179, 825.1253671108644, 825.3644693585935, 827.9130691277419, 827.954462504562, 828.1842385250524, 863.6372723456163, 863.9784005399853, 865.5672163918041, 866.0906048648925, 866.5234121233296, 850.8978922529274, 851.8296340731847, 859.1365677494109, 859.1494420523636, 859.3211363023266, 625.0374423387977, 625.2528228766625, 625.262190615074, 625.3902445115975, 625.737190380037, 12916.354182290848, 12969.481220751159, 13016.219026858418, 13034.217946923214, 13071.215727056311, 12008.579699710555, 12156.149069565134, 12279.079069069767, 12371.628851134481, 12704.110712250145, 9508.667196648084, 10112.241581881315, 10275.177985761196, 10524.263301568893, 10638.042576168182, 3229.54786329914, 3295.47272436409, 3313.6189338226172, 3437.1922598189403, 3447.0, 47889.52110478885, 49394.0, 49956.25065624018, 50026.49973500255, 50375.496245037444, 9230.0, 9342.205912497378, 9378.249740020781, 9522.0, 9577.760555986017, 15583.298751556207, 16133.838661613234, 16142.35430582787, 16146.03123812575, 16151.838481615268, 6870.7595234166565, 6891.448684105259, 6912.0, 6930.272321406281, 6990.300969902969, 3765.3975363941636, 3783.4703141560203, 3801.334766415866, 3808.2383523295453, 3857.8842634721004, 2811.943761124766, 2905.898293559715, 2909.258139174497, 2909.956350654742, 2910.7962442628814, 485.8105338917825, 510.4640127865726, 510.4895104895105, 531.1422053383758, 559.1221781802612, 493.2822742909059, 534.7032397019691, 553.7784886045614, 585.6573904266052, 625.0187206086491, 8131.9593402032615, 8243.505389676518, 8252.174782521699, 8264.462809917337, 8381.161883811692, 540.6512799244465, 614.8739508400768, 619.7459041792844, 638.8562573421036, 648.0182523476936, 3680.3743363628246, 3680.5031320771886, 3708.4808126862263, 3764.265968136187, 3846.1346197105427, 62098.689506553084, 62888.68555657192, 63064.36935630585, 63813.680931595976, 63966.0, 55207.0, 55246.0, 55502.72248638731, 55999.160012599845, 56105.43894561084, 42154.789226053676, 42696.35955460671, 42783.0, 45617.31574026459, 50344.74827625838, 8490.872636910575, 8548.495117002, 8550.358723095917, 8565.48607083577, 8567.186117318844, 30200.24499387533, 30808.0, 30828.383432331677, 32198.229097399868, 32274.193145171557, 39371.80314098411, 39622.2075558493, 39757.60242397539, 39908.2018359637, 40803.0, 10931.453427328443, 10962.232643715182, 10979.28634638746, 11031.61389351401, 11082.667519974413, 12104.45529951172, 12112.818307725567, 12155.088368372584, 12946.287954162612, 13100.475980960655, 11339.092872570009, 11625.941870290595, 11804.940975295412, 11980.161388702707, 12173.939130304292, 11625.302481851117, 11670.70823229426, 11749.765004699688, 11994.792650084099, 12110.878891210976, 11020.0, 11278.49246783913, 11443.439524163892, 11469.197156198987, 11758.294502329887, 9228.215601673664, 9787.657431989846, 9802.068803463659, 10117.696469105938, 10139.61925625608, 9684.70945871625, 9685.564149613143, 9717.222622190066, 9789.52326648002, 10149.492525373555], "value": 6134.015735017824, "unit": "score"}], "name": "dromaeo_css", "value": 6234.272707084666, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 116.0, 114.0, 114.0, 113.0, 113.0, 114.0, 112.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 130.0, 222.0, 130.0, 133.0, 156.0, 128.0, 172.0, 129.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 140.0, 77.0, 76.0, 75.0, 75.0, 131.0, 74.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 158.0, 93.0, 99.0, 94.0, 124.0, 93.0, 93.0, 138.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 67.0, 65.0, 63.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 83.0, 83.0, 87.0, 83.0, 85.0, 175.0, 95.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 132.0, 137.0, 132.0, 144.0, 140.0, 138.0, 159.0, 130.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 174.0, 172.0, 175.0, 170.0, 172.0, 177.0, 174.0, 171.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 67.0, 67.0, 67.0, 71.0, 66.0, 66.0, 67.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1579.4, "alertThreshold": 2.0}]} 14:48:33 INFO - Return code: 0 14:48:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:48:33 ERROR - # TBPL SUCCESS # 14:48:33 INFO - Running post-action listener: _resource_record_post_action 14:48:33 INFO - ##### 14:48:33 INFO - ##### Finished run-tests step (success) 14:48:33 INFO - ##### 14:48:33 INFO - Running post-run listener: _resource_record_post_run 14:48:33 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539181056; Read time: 16; Write time: 1016536 14:48:33 INFO - TinderboxPrint: CPU usage
13.2% 14:48:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:48:33 INFO - TinderboxPrint: I/O write bytes / time
539,181,056 / 1,016,536 14:48:33 INFO - TinderboxPrint: CPU idle
8,350.6 (86.7%) 14:48:33 INFO - TinderboxPrint: CPU user
1,222.3 (12.7%) 14:48:33 INFO - TinderboxPrint: Swap in / out
0 / 0 14:48:33 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 249229312; Read time: 0; Write time: 470756 14:48:33 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289951744; Read time: 16; Write time: 545780 14:48:34 INFO - Running post-run listener: _upload_blobber_files 14:48:34 INFO - Blob upload gear active. 14:48:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:34 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 14:48:34 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'] 14:48:34 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 14:48:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:48:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:48:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:35 INFO - (blobuploader) - INFO - Done attempting. 14:48:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:48:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:36 INFO - (blobuploader) - INFO - Done attempting. 14:48:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:48:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:40 INFO - (blobuploader) - INFO - Done attempting. 14:48:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:40 INFO - Return code: 0 14:48:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/290e5678a7da6a0712825bd9e2ab8fb4fb78e8d0532e82b3a2907f4bec5bc1108d6ea3a4a8c39c0c89ee6300baa7ef0af46c839c869f2f10f954fae965a7470c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63c5ab36905a1ecf7f03457a844c1123bcda662ecd897d18467499e51445b01e099f3a3b94993e5530d4b29aeeb1a437374c3ccc6f4e8c8d424c4a169d4bddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b868f854a98ae857cd855d2f1e5a2c9a69409f0d90af788f04e57a15af8a70cd82ae9f93a56ac82dfde186524f5e4fae7b80bba8a6912bc22e7516628fb254e"} 14:48:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:40 INFO - Contents: 14:48:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/290e5678a7da6a0712825bd9e2ab8fb4fb78e8d0532e82b3a2907f4bec5bc1108d6ea3a4a8c39c0c89ee6300baa7ef0af46c839c869f2f10f954fae965a7470c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63c5ab36905a1ecf7f03457a844c1123bcda662ecd897d18467499e51445b01e099f3a3b94993e5530d4b29aeeb1a437374c3ccc6f4e8c8d424c4a169d4bddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b868f854a98ae857cd855d2f1e5a2c9a69409f0d90af788f04e57a15af8a70cd82ae9f93a56ac82dfde186524f5e4fae7b80bba8a6912bc22e7516628fb254e"} 14:48:40 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:40 INFO - Copying logs to upload dir... 14:48:40 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.861986 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-23 14:48:40.247180) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:48:40.251345) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572 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/290e5678a7da6a0712825bd9e2ab8fb4fb78e8d0532e82b3a2907f4bec5bc1108d6ea3a4a8c39c0c89ee6300baa7ef0af46c839c869f2f10f954fae965a7470c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63c5ab36905a1ecf7f03457a844c1123bcda662ecd897d18467499e51445b01e099f3a3b94993e5530d4b29aeeb1a437374c3ccc6f4e8c8d424c4a169d4bddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b868f854a98ae857cd855d2f1e5a2c9a69409f0d90af788f04e57a15af8a70cd82ae9f93a56ac82dfde186524f5e4fae7b80bba8a6912bc22e7516628fb254e"} build_url:https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/cSrLHAaSRSakCdssQssCRA/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/290e5678a7da6a0712825bd9e2ab8fb4fb78e8d0532e82b3a2907f4bec5bc1108d6ea3a4a8c39c0c89ee6300baa7ef0af46c839c869f2f10f954fae965a7470c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b63c5ab36905a1ecf7f03457a844c1123bcda662ecd897d18467499e51445b01e099f3a3b94993e5530d4b29aeeb1a437374c3ccc6f4e8c8d424c4a169d4bddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b868f854a98ae857cd855d2f1e5a2c9a69409f0d90af788f04e57a15af8a70cd82ae9f93a56ac82dfde186524f5e4fae7b80bba8a6912bc22e7516628fb254e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:48:40.277647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:48:40.278155) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464038871.891490-2022848572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:48:40.361697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:48:40.362010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:48:40.362303) ========= ========= Total master_lag: 0.18 =========