builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1463483432.86 results: success (0) buildid: 20160517031837 builduid: 3944d8780eb547cdbb0a922b939efddc revision: 036f62007472d4e2ada1564718b617f60cd00d43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.861367) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.861867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.862171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.879104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.879509) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 04:10:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-17 04:10:33 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.978260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:32.978572) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017744 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:33.028062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 04:10:33.028385) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 036f62007472d4e2ada1564718b617f60cd00d43 --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 036f62007472d4e2ada1564718b617f60cd00d43 --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=4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 04:10:33,126 truncating revision to first 12 chars 2016-05-17 04:10:33,126 Setting DEBUG logging. 2016-05-17 04:10:33,126 attempt 1/10 2016-05-17 04:10:33,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/036f62007472?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 04:10:33,973 unpacking tar archive at: fx-team-036f62007472/testing/mozharness/ program finished with exit code 0 elapsedTime=1.198146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 04:10:34.239114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:34.239427) ========= script_repo_revision: 036f62007472d4e2ada1564718b617f60cd00d43 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:34.240099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:34.240367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 04:10:34.252230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-17 04:10:34.252628) ========= /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=4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:34 INFO - MultiFileLogger online at 20160517 04:10:34 in /builds/slave/test 04:10:34 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 04:10:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:34 INFO - {'append_to_log': False, 04:10:34 INFO - 'base_work_dir': '/builds/slave/test', 04:10:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:10:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:34 INFO - 'branch': 'Fx-Team-Non-PGO', 04:10:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:34 INFO - 'config_files': ('talos/linux_config.py',), 04:10:34 INFO - 'default_actions': ('clobber', 04:10:34 INFO - 'read-buildbot-config', 04:10:34 INFO - 'download-and-extract', 04:10:34 INFO - 'populate-webroot', 04:10:34 INFO - 'create-virtualenv', 04:10:34 INFO - 'install', 04:10:34 INFO - 'run-tests'), 04:10:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:34 INFO - 'download_minidump_stackwalk': True, 04:10:34 INFO - 'download_symbols': 'ondemand', 04:10:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:34 INFO - 'installer_path': 'installer.exe', 04:10:34 INFO - 'log_level': 'info', 04:10:34 INFO - 'log_name': 'talos', 04:10:34 INFO - 'log_to_console': True, 04:10:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:34 INFO - 'opt_config_files': (), 04:10:34 INFO - 'pip_index': False, 04:10:34 INFO - 'sps_profile': False, 04:10:34 INFO - 'sps_profile_interval': 0, 04:10:34 INFO - 'suite': 'dromaeojs', 04:10:34 INFO - 'system_bits': '32', 04:10:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:34 INFO - 'title': 'talos-linux64-ix-030', 04:10:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:34 INFO - 'use_talos_json': True, 04:10:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:34 INFO - 'work_dir': 'build'} 04:10:34 INFO - ##### 04:10:34 INFO - ##### Running clobber step. 04:10:34 INFO - ##### 04:10:34 INFO - Running pre-action listener: _resource_record_pre_action 04:10:34 INFO - Running main action method: clobber 04:10:34 INFO - rmtree: /builds/slave/test/build 04:10:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:34 INFO - Running post-action listener: _resource_record_post_action 04:10:34 INFO - ##### 04:10:34 INFO - ##### Finished clobber step (success) 04:10:34 INFO - ##### 04:10:34 INFO - ##### 04:10:34 INFO - ##### Running read-buildbot-config step. 04:10:34 INFO - ##### 04:10:34 INFO - Running pre-action listener: _resource_record_pre_action 04:10:34 INFO - Running main action method: read_buildbot_config 04:10:34 INFO - Using buildbot properties: 04:10:34 INFO - { 04:10:34 INFO - "project": "", 04:10:34 INFO - "product": "firefox", 04:10:34 INFO - "script_repo_revision": "production", 04:10:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:10:34 INFO - "repository": "", 04:10:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:10:34 INFO - "buildid": "20160517031837", 04:10:34 INFO - "pgo_build": "False", 04:10:34 INFO - "basedir": "/builds/slave/test", 04:10:34 INFO - "buildnumber": 1688, 04:10:34 INFO - "slavename": "talos-linux64-ix-030", 04:10:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:10:34 INFO - "platform": "ubuntu64_hw", 04:10:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:10:34 INFO - "branch": "fx-team", 04:10:34 INFO - "repo_path": "integration/fx-team", 04:10:34 INFO - "revision": "036f62007472d4e2ada1564718b617f60cd00d43", 04:10:34 INFO - "stage_platform": "linux64", 04:10:34 INFO - "builduid": "3944d8780eb547cdbb0a922b939efddc", 04:10:34 INFO - "slavebuilddir": "test" 04:10:34 INFO - } 04:10:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:10:34 INFO - Running post-action listener: _resource_record_post_action 04:10:34 INFO - ##### 04:10:34 INFO - ##### Finished read-buildbot-config step (success) 04:10:34 INFO - ##### 04:10:34 INFO - ##### 04:10:34 INFO - ##### Running download-and-extract step. 04:10:34 INFO - ##### 04:10:34 INFO - Running pre-action listener: _resource_record_pre_action 04:10:34 INFO - Running main action method: download_and_extract 04:10:34 INFO - mkdir: /builds/slave/test/build/tests 04:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:34 INFO - https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:10:47 INFO - Downloaded 1361 bytes. 04:10:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:10:47 INFO - Using the following test package requirements: 04:10:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:10:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:10:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'jsshell-linux-x86_64.zip'], 04:10:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:10:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:10:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:10:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:10:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:10:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:47 INFO - https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:10:57 INFO - Downloaded 22448136 bytes. 04:10:57 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'] 04:10:57 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 04:10:58 INFO - Return code: 0 04:10:58 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 04:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:58 INFO - https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:10:59 INFO - Downloaded 22448136 bytes. 04:10:59 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'] 04:10:59 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 04:11:01 INFO - Return code: 0 04:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:01 INFO - https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:11:02 INFO - Downloaded 10840194 bytes. 04:11:02 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'] 04:11:02 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 04:11:02 INFO - Return code: 0 04:11:02 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')]} 04:11:02 INFO - https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIZ9dnbKTriluQTwZN8xJg/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 04:11:03 INFO - Downloaded 54767430 bytes. 04:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:03 INFO - mkdir: /builds/slave/test/properties 04:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:03 INFO - Contents: 04:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:04 INFO - Running post-action listener: _resource_record_post_action 04:11:04 INFO - Running post-action listener: set_extra_try_arguments 04:11:04 INFO - ##### 04:11:04 INFO - ##### Finished download-and-extract step (success) 04:11:04 INFO - ##### 04:11:04 INFO - ##### 04:11:04 INFO - ##### Running populate-webroot step. 04:11:04 INFO - ##### 04:11:04 INFO - Running pre-action listener: _resource_record_pre_action 04:11:04 INFO - Running main action method: populate_webroot 04:11:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:04 INFO - '--tppagecycles', 04:11:04 INFO - '7'], 04:11:04 INFO - 'tests': ['tsvgm']}}, 04:11:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['damp', 'tps']}, 04:11:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'tests': ['damp', 'tps']}, 04:11:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['dromaeo_dom']}, 04:11:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['a11yr', 04:11:04 INFO - 'ts_paint', 04:11:04 INFO - 'tpaint', 04:11:04 INFO - 'sessionrestore', 04:11:04 INFO - 'sessionrestore_no_auto_restore', 04:11:04 INFO - 'tabpaint']}, 04:11:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:04 INFO - 'ts_paint', 04:11:04 INFO - 'tpaint', 04:11:04 INFO - 'sessionrestore', 04:11:04 INFO - 'sessionrestore_no_auto_restore', 04:11:04 INFO - 'tabpaint']}, 04:11:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:04 INFO - 'ts_paint', 04:11:04 INFO - 'tpaint', 04:11:04 INFO - 'sessionrestore', 04:11:04 INFO - 'sessionrestore_no_auto_restore', 04:11:04 INFO - 'tabpaint']}, 04:11:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:04 INFO - 'ts_paint', 04:11:04 INFO - 'tpaint', 04:11:04 INFO - 'sessionrestore', 04:11:04 INFO - 'sessionrestore_no_auto_restore', 04:11:04 INFO - 'tabpaint']}, 04:11:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['a11yr', 04:11:04 INFO - 'ts_paint', 04:11:04 INFO - 'tpaint', 04:11:04 INFO - 'sessionrestore', 04:11:04 INFO - 'sessionrestore_no_auto_restore', 04:11:04 INFO - 'tabpaint']}, 04:11:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['a11yr', 04:11:04 INFO - 'ts_paint', 04:11:04 INFO - 'tpaint', 04:11:04 INFO - 'sessionrestore', 04:11:04 INFO - 'sessionrestore_no_auto_restore', 04:11:04 INFO - 'tabpaint']}, 04:11:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['tsvgx', 04:11:04 INFO - 'tsvgr_opacity', 04:11:04 INFO - 'tart', 04:11:04 INFO - 'tscrollx', 04:11:04 INFO - 'cart']}, 04:11:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:04 INFO - 'tsvgr_opacity', 04:11:04 INFO - 'tart', 04:11:04 INFO - 'tscrollx', 04:11:04 INFO - 'cart']}, 04:11:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'talos_options': ['--disable-e10s'], 04:11:04 INFO - 'tests': ['tp5o']}, 04:11:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'tests': ['tp5o']}, 04:11:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'talos_options': ['--disable-e10s', 04:11:04 INFO - '--xperf_path', 04:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:04 INFO - 'tests': ['tp5n']}, 04:11:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:04 INFO - 'talos_options': ['--xperf_path', 04:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:04 INFO - 'tests': ['tp5n']}}, 04:11:04 INFO - 'talos.zip': {'path': '', 04:11:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:04 INFO - Running post-action listener: _resource_record_post_action 04:11:04 INFO - ##### 04:11:04 INFO - ##### Finished populate-webroot step (success) 04:11:04 INFO - ##### 04:11:04 INFO - ##### 04:11:04 INFO - ##### Running create-virtualenv step. 04:11:04 INFO - ##### 04:11:04 INFO - Running pre-action listener: _resource_record_pre_action 04:11:04 INFO - Running main action method: create_virtualenv 04:11:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:04 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 04:11:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:04 INFO - Using real prefix '/usr' 04:11:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:07 INFO - Installing pip.................done. 04:11:07 INFO - Return code: 0 04:11:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:07 INFO - Using env: {'DISPLAY': ':0', 04:11:07 INFO - 'HOME': '/home/cltbld', 04:11:07 INFO - 'LANG': 'en_US.UTF-8', 04:11:07 INFO - 'LANGUAGE': 'en_US:en', 04:11:07 INFO - 'LOGNAME': 'cltbld', 04:11:07 INFO - 'MAIL': '/var/mail/cltbld', 04:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:07 INFO - 'MOZ_NO_REMOTE': '1', 04:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:07 INFO - 'NO_EM_RESTART': '1', 04:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:07 INFO - 'PWD': '/builds/slave/test', 04:11:07 INFO - 'SHELL': '/bin/bash', 04:11:07 INFO - 'SHLVL': '1', 04:11:07 INFO - 'TERM': 'linux', 04:11:07 INFO - 'TMOUT': '86400', 04:11:07 INFO - 'USER': 'cltbld', 04:11:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:07 INFO - '_': '/tools/buildbot/bin/python'} 04:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:07 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 04:11:07 INFO - Cleaning up... 04:11:07 INFO - Return code: 0 04:11:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:11:07 INFO - Using env: {'DISPLAY': ':0', 04:11:07 INFO - 'HOME': '/home/cltbld', 04:11:07 INFO - 'LANG': 'en_US.UTF-8', 04:11:07 INFO - 'LANGUAGE': 'en_US:en', 04:11:07 INFO - 'LOGNAME': 'cltbld', 04:11:07 INFO - 'MAIL': '/var/mail/cltbld', 04:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:07 INFO - 'MOZ_NO_REMOTE': '1', 04:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:07 INFO - 'NO_EM_RESTART': '1', 04:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:07 INFO - 'PWD': '/builds/slave/test', 04:11:07 INFO - 'SHELL': '/bin/bash', 04:11:07 INFO - 'SHLVL': '1', 04:11:07 INFO - 'TERM': 'linux', 04:11:07 INFO - 'TMOUT': '86400', 04:11:07 INFO - 'USER': 'cltbld', 04:11:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:07 INFO - '_': '/tools/buildbot/bin/python'} 04:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:07 INFO - Downloading/unpacking psutil>=3.1.1 04:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:09 INFO - Installing collected packages: psutil 04:11:09 INFO - Running setup.py install for psutil 04:11:09 INFO - building 'psutil._psutil_linux' extension 04:11:09 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 04:11:09 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 04:11:09 INFO - building 'psutil._psutil_posix' extension 04:11:09 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 04:11:09 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 04:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:10 INFO - Successfully installed psutil 04:11:10 INFO - Cleaning up... 04:11:10 INFO - Return code: 0 04:11:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:11: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 mozsystemmonitor==0.3 04:11:10 INFO - Using env: {'DISPLAY': ':0', 04:11:10 INFO - 'HOME': '/home/cltbld', 04:11:10 INFO - 'LANG': 'en_US.UTF-8', 04:11:10 INFO - 'LANGUAGE': 'en_US:en', 04:11:10 INFO - 'LOGNAME': 'cltbld', 04:11:10 INFO - 'MAIL': '/var/mail/cltbld', 04:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:10 INFO - 'MOZ_NO_REMOTE': '1', 04:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:10 INFO - 'NO_EM_RESTART': '1', 04:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:10 INFO - 'PWD': '/builds/slave/test', 04:11:10 INFO - 'SHELL': '/bin/bash', 04:11:10 INFO - 'SHLVL': '1', 04:11:10 INFO - 'TERM': 'linux', 04:11:10 INFO - 'TMOUT': '86400', 04:11:10 INFO - 'USER': 'cltbld', 04:11:10 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:10 INFO - '_': '/tools/buildbot/bin/python'} 04:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 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 04:11:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:12 INFO - Installing collected packages: mozsystemmonitor 04:11:12 INFO - Running setup.py install for mozsystemmonitor 04:11:12 INFO - Successfully installed mozsystemmonitor 04:11:12 INFO - Cleaning up... 04:11:12 INFO - Return code: 0 04:11:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:11:12 INFO - Using env: {'DISPLAY': ':0', 04:11:12 INFO - 'HOME': '/home/cltbld', 04:11:12 INFO - 'LANG': 'en_US.UTF-8', 04:11:12 INFO - 'LANGUAGE': 'en_US:en', 04:11:12 INFO - 'LOGNAME': 'cltbld', 04:11:12 INFO - 'MAIL': '/var/mail/cltbld', 04:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:12 INFO - 'MOZ_NO_REMOTE': '1', 04:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:12 INFO - 'NO_EM_RESTART': '1', 04:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:12 INFO - 'PWD': '/builds/slave/test', 04:11:12 INFO - 'SHELL': '/bin/bash', 04:11:12 INFO - 'SHLVL': '1', 04:11:12 INFO - 'TERM': 'linux', 04:11:12 INFO - 'TMOUT': '86400', 04:11:12 INFO - 'USER': 'cltbld', 04:11:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:12 INFO - '_': '/tools/buildbot/bin/python'} 04:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:12 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:15 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 04:11:15 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 04:11:15 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 04:11:15 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 04:11:15 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 04:11:15 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 04:11:15 INFO - Downloading docopt-0.6.1.tar.gz 04:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:15 INFO - Running setup.py install for blobuploader 04:11:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:15 INFO - Running setup.py install for requests 04:11:15 INFO - Running setup.py install for docopt 04:11:15 INFO - Successfully installed blobuploader requests docopt 04:11:15 INFO - Cleaning up... 04:11:15 INFO - Return code: 0 04:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:15 INFO - Using env: {'DISPLAY': ':0', 04:11:15 INFO - 'HOME': '/home/cltbld', 04:11:15 INFO - 'LANG': 'en_US.UTF-8', 04:11:15 INFO - 'LANGUAGE': 'en_US:en', 04:11:15 INFO - 'LOGNAME': 'cltbld', 04:11:15 INFO - 'MAIL': '/var/mail/cltbld', 04:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:15 INFO - 'MOZ_NO_REMOTE': '1', 04:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:15 INFO - 'NO_EM_RESTART': '1', 04:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:15 INFO - 'PWD': '/builds/slave/test', 04:11:15 INFO - 'SHELL': '/bin/bash', 04:11:15 INFO - 'SHLVL': '1', 04:11:15 INFO - 'TERM': 'linux', 04:11:15 INFO - 'TMOUT': '86400', 04:11:15 INFO - 'USER': 'cltbld', 04:11:15 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:15 INFO - '_': '/tools/buildbot/bin/python'} 04:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:16 INFO - Running setup.py (path:/tmp/pip-7OHjCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:16 INFO - Running setup.py (path:/tmp/pip-qZh8lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:16 INFO - Running setup.py (path:/tmp/pip-rhXeqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:16 INFO - Running setup.py (path:/tmp/pip-Mh0Oi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:16 INFO - Running setup.py (path:/tmp/pip-2n2KY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:16 INFO - Running setup.py (path:/tmp/pip-gNRihT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:16 INFO - Running setup.py (path:/tmp/pip-b0wYFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:16 INFO - Running setup.py (path:/tmp/pip-06X0xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:16 INFO - Running setup.py (path:/tmp/pip-a2Jsvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:16 INFO - Running setup.py (path:/tmp/pip-kTOMhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:16 INFO - Running setup.py (path:/tmp/pip-_RF4mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:16 INFO - Running setup.py (path:/tmp/pip-ktcTmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:17 INFO - Running setup.py (path:/tmp/pip-URkHrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:17 INFO - Running setup.py (path:/tmp/pip-dSDQqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:17 INFO - Running setup.py (path:/tmp/pip-RP11xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:17 INFO - Running setup.py (path:/tmp/pip-vND933-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:17 INFO - Running setup.py (path:/tmp/pip-BK59HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:17 INFO - Running setup.py install for manifestparser 04:11:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:17 INFO - Running setup.py install for mozcrash 04:11:17 INFO - Running setup.py install for mozdebug 04:11:17 INFO - Running setup.py install for mozdevice 04:11:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:17 INFO - Running setup.py install for mozfile 04:11:17 INFO - Running setup.py install for mozhttpd 04:11:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:17 INFO - Running setup.py install for mozinfo 04:11:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Running setup.py install for mozInstall 04:11:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Running setup.py install for mozleak 04:11:18 INFO - Running setup.py install for mozlog 04:11:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Running setup.py install for moznetwork 04:11:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Running setup.py install for mozprocess 04:11:18 INFO - Running setup.py install for mozprofile 04:11:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Running setup.py install for mozrunner 04:11:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:18 INFO - Running setup.py install for mozscreenshot 04:11:18 INFO - Running setup.py install for moztest 04:11:19 INFO - Running setup.py install for mozversion 04:11:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:19 INFO - Cleaning up... 04:11:19 INFO - Return code: 0 04:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:19 INFO - Using env: {'DISPLAY': ':0', 04:11:19 INFO - 'HOME': '/home/cltbld', 04:11:19 INFO - 'LANG': 'en_US.UTF-8', 04:11:19 INFO - 'LANGUAGE': 'en_US:en', 04:11:19 INFO - 'LOGNAME': 'cltbld', 04:11:19 INFO - 'MAIL': '/var/mail/cltbld', 04:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:19 INFO - 'MOZ_NO_REMOTE': '1', 04:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:19 INFO - 'NO_EM_RESTART': '1', 04:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:19 INFO - 'PWD': '/builds/slave/test', 04:11:19 INFO - 'SHELL': '/bin/bash', 04:11:19 INFO - 'SHLVL': '1', 04:11:19 INFO - 'TERM': 'linux', 04:11:19 INFO - 'TMOUT': '86400', 04:11:19 INFO - 'USER': 'cltbld', 04:11:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:19 INFO - '_': '/tools/buildbot/bin/python'} 04:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:19 INFO - Running setup.py (path:/tmp/pip-v240aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:19 INFO - Running setup.py (path:/tmp/pip-zN9QdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:19 INFO - Running setup.py (path:/tmp/pip-pN4DNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:19 INFO - Running setup.py (path:/tmp/pip-KBIG20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:19 INFO - Running setup.py (path:/tmp/pip-S7oYfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:19 INFO - Running setup.py (path:/tmp/pip-IUhodn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:19 INFO - Running setup.py (path:/tmp/pip-nB1esF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:19 INFO - Running setup.py (path:/tmp/pip-cWS6sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:19 INFO - Running setup.py (path:/tmp/pip-1L9AeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:20 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)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:20 INFO - Running setup.py (path:/tmp/pip-9OKhlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:20 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)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:20 INFO - Running setup.py (path:/tmp/pip-bu7aML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:20 INFO - Running setup.py (path:/tmp/pip-GMv_9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:20 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)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:20 INFO - Running setup.py (path:/tmp/pip-CTZSb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:20 INFO - Running setup.py (path:/tmp/pip-U0mVYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:20 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)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:20 INFO - Running setup.py (path:/tmp/pip-27qLmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:20 INFO - Running setup.py (path:/tmp/pip-8z7OwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:20 INFO - Running setup.py (path:/tmp/pip-yEAudG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:22 INFO - Downloading blessings-1.6.tar.gz 04:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:22 INFO - Installing collected packages: blessings 04:11:22 INFO - Running setup.py install for blessings 04:11:22 INFO - Successfully installed blessings 04:11:22 INFO - Cleaning up... 04:11:22 INFO - Return code: 0 04:11:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:23 INFO - Reading from file tmpfile_stdout 04:11:23 INFO - Current package versions: 04:11:23 INFO - argparse == 1.2.1 04:11:23 INFO - blessings == 1.6 04:11:23 INFO - blobuploader == 1.2.4 04:11:23 INFO - docopt == 0.6.1 04:11:23 INFO - manifestparser == 1.1 04:11:23 INFO - mozInstall == 1.12 04:11:23 INFO - mozcrash == 0.17 04:11:23 INFO - mozdebug == 0.1 04:11:23 INFO - mozdevice == 0.48 04:11:23 INFO - mozfile == 1.2 04:11:23 INFO - mozhttpd == 0.7 04:11:23 INFO - mozinfo == 0.9 04:11:23 INFO - mozleak == 0.1 04:11:23 INFO - mozlog == 3.2 04:11:23 INFO - moznetwork == 0.27 04:11:23 INFO - mozprocess == 0.22 04:11:23 INFO - mozprofile == 0.28 04:11:23 INFO - mozrunner == 6.11 04:11:23 INFO - mozscreenshot == 0.1 04:11:23 INFO - mozsystemmonitor == 0.3 04:11:23 INFO - moztest == 0.7 04:11:23 INFO - mozversion == 1.4 04:11:23 INFO - psutil == 3.1.1 04:11:23 INFO - requests == 1.2.3 04:11:23 INFO - wsgiref == 0.1.2 04:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:23 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 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:23 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 04:11:23 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 04:11:23 INFO - Using env: {'DISPLAY': ':0', 04:11:23 INFO - 'HOME': '/home/cltbld', 04:11:23 INFO - 'LANG': 'en_US.UTF-8', 04:11:23 INFO - 'LANGUAGE': 'en_US:en', 04:11:23 INFO - 'LOGNAME': 'cltbld', 04:11:23 INFO - 'MAIL': '/var/mail/cltbld', 04:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:23 INFO - 'MOZ_NO_REMOTE': '1', 04:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:23 INFO - 'NO_EM_RESTART': '1', 04:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:23 INFO - 'PWD': '/builds/slave/test', 04:11:23 INFO - 'SHELL': '/bin/bash', 04:11:23 INFO - 'SHLVL': '1', 04:11:23 INFO - 'TERM': 'linux', 04:11:23 INFO - 'TMOUT': '86400', 04:11:23 INFO - 'USER': 'cltbld', 04:11:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:23 INFO - '_': '/tools/buildbot/bin/python'} 04:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:23 INFO - Cleaning up... 04:11:23 INFO - Return code: 0 04:11:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:11:23 INFO - Using env: {'DISPLAY': ':0', 04:11:23 INFO - 'HOME': '/home/cltbld', 04:11:23 INFO - 'LANG': 'en_US.UTF-8', 04:11:23 INFO - 'LANGUAGE': 'en_US:en', 04:11:23 INFO - 'LOGNAME': 'cltbld', 04:11:23 INFO - 'MAIL': '/var/mail/cltbld', 04:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:23 INFO - 'MOZ_NO_REMOTE': '1', 04:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:23 INFO - 'NO_EM_RESTART': '1', 04:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:23 INFO - 'PWD': '/builds/slave/test', 04:11:23 INFO - 'SHELL': '/bin/bash', 04:11:23 INFO - 'SHLVL': '1', 04:11:23 INFO - 'TERM': 'linux', 04:11:23 INFO - 'TMOUT': '86400', 04:11:23 INFO - 'USER': 'cltbld', 04:11:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:23 INFO - '_': '/tools/buildbot/bin/python'} 04:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:23 INFO - Downloading/unpacking jsonschema 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:25 INFO - Downloading/unpacking functools32 (from jsonschema) 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:25 INFO - warning: no files found matching '*.txt' 04:11:25 INFO - no previously-included directories found matching 'build' 04:11:25 INFO - no previously-included directories found matching 'dist' 04:11:25 INFO - no previously-included directories found matching '.git*' 04:11:25 INFO - Installing collected packages: jsonschema, functools32 04:11:25 INFO - Running setup.py install for functools32 04:11:25 INFO - warning: no files found matching '*.txt' 04:11:25 INFO - no previously-included directories found matching 'build' 04:11:25 INFO - no previously-included directories found matching 'dist' 04:11:25 INFO - no previously-included directories found matching '.git*' 04:11:25 INFO - Successfully installed jsonschema functools32 04:11:25 INFO - Cleaning up... 04:11:26 INFO - Return code: 0 04:11:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:11:26 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')]} 04:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:26 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')]} 04:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:26 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 0x7f5d9c92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', '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 04:11:26 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 04:11:26 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 04:11:26 INFO - Using env: {'DISPLAY': ':0', 04:11:26 INFO - 'HOME': '/home/cltbld', 04:11:26 INFO - 'LANG': 'en_US.UTF-8', 04:11:26 INFO - 'LANGUAGE': 'en_US:en', 04:11:26 INFO - 'LOGNAME': 'cltbld', 04:11:26 INFO - 'MAIL': '/var/mail/cltbld', 04:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:26 INFO - 'MOZ_NO_REMOTE': '1', 04:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:26 INFO - 'NO_EM_RESTART': '1', 04:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:26 INFO - 'PWD': '/builds/slave/test', 04:11:26 INFO - 'SHELL': '/bin/bash', 04:11:26 INFO - 'SHLVL': '1', 04:11:26 INFO - 'TERM': 'linux', 04:11:26 INFO - 'TMOUT': '86400', 04:11:26 INFO - 'USER': 'cltbld', 04:11:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:26 INFO - '_': '/tools/buildbot/bin/python'} 04:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:26 INFO - Downloading/unpacking flake8 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:11:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:11:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 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 04:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:11:28 INFO - no previously-included directories found matching 'docs/_build' 04:11:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:11:28 INFO - Running setup.py install for pep8 04:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:11:28 INFO - no previously-included directories found matching 'docs/_build' 04:11:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:11:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:11:29 INFO - Cleaning up... 04:11:29 INFO - Return code: 0 04:11:29 INFO - Running post-action listener: _resource_record_post_action 04:11:29 INFO - Running post-action listener: _start_resource_monitoring 04:11:29 INFO - Starting resource monitoring. 04:11:29 INFO - ##### 04:11:29 INFO - ##### Finished create-virtualenv step (success) 04:11:29 INFO - ##### 04:11:29 INFO - ##### 04:11:29 INFO - ##### Running install step. 04:11:29 INFO - ##### 04:11:29 INFO - Running pre-action listener: _resource_record_pre_action 04:11:29 INFO - Running main action method: install 04:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:29 INFO - Reading from file tmpfile_stdout 04:11:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:29 INFO - Reading from file tmpfile_stdout 04:11:29 INFO - Output received: 04:11:29 INFO - Usage: mozinstall [options] installer 04:11:29 INFO - Options: 04:11:29 INFO - -h, --help show this help message and exit 04:11:29 INFO - -d DEST, --destination=DEST 04:11:29 INFO - Directory to install application into. [default: 04:11:29 INFO - "/builds/slave/test"] 04:11:29 INFO - --app=APP Application being installed. [default: firefox] 04:11:29 INFO - mkdir: /builds/slave/test/build/application 04:11:29 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'] 04:11:29 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 04:11:45 INFO - Reading from file tmpfile_stdout 04:11:45 INFO - Output received: 04:11:45 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:45 INFO - Running post-action listener: _resource_record_post_action 04:11:45 INFO - ##### 04:11:45 INFO - ##### Finished install step (success) 04:11:45 INFO - ##### 04:11:45 INFO - ##### 04:11:45 INFO - ##### Running run-tests step. 04:11:45 INFO - ##### 04:11:45 INFO - Running pre-action listener: _resource_record_pre_action 04:11:45 INFO - Running main action method: run_tests 04:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:45 INFO - Python 2.7.3 04:11:45 INFO - Return code: 0 04:11:45 INFO - grabbing minidump binary from tooltool 04:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:45 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 0x202e9c0>, '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 0x202f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:45 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 04:11:45 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 04:11:45 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 04:11:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:45 INFO - Return code: 0 04:11:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:11:46 INFO - Return code: 0 04:11:46 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/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 04:11:46 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/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 04:11:46 INFO - Using env: {'DISPLAY': ':0', 04:11:46 INFO - 'HOME': '/home/cltbld', 04:11:46 INFO - 'LANG': 'en_US.UTF-8', 04:11:46 INFO - 'LANGUAGE': 'en_US:en', 04:11:46 INFO - 'LOGNAME': 'cltbld', 04:11:46 INFO - 'MAIL': '/var/mail/cltbld', 04:11:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:46 INFO - 'MOZ_NO_REMOTE': '1', 04:11:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:46 INFO - 'NO_EM_RESTART': '1', 04:11:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:46 INFO - 'PWD': '/builds/slave/test', 04:11:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:46 INFO - 'SHELL': '/bin/bash', 04:11:46 INFO - 'SHLVL': '1', 04:11:46 INFO - 'TERM': 'linux', 04:11:46 INFO - 'TMOUT': '86400', 04:11:46 INFO - 'USER': 'cltbld', 04:11:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436', 04:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:46 INFO - '_': '/tools/buildbot/bin/python'} 04:11:46 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/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 04:11:46 INFO - mozversion application_buildid: 20160517031837 04:11:46 INFO - mozversion application_changeset: 036f62007472d4e2ada1564718b617f60cd00d43 04:11:46 INFO - mozversion application_display_name: Nightly 04:11:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:46 INFO - mozversion application_name: Firefox 04:11:46 INFO - mozversion application_remotingname: firefox 04:11:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:11:46 INFO - mozversion application_vendor: Mozilla 04:11:46 INFO - mozversion application_version: 49.0a1 04:11:46 INFO - mozversion platform_buildid: 20160517031837 04:11:46 INFO - mozversion platform_changeset: 036f62007472d4e2ada1564718b617f60cd00d43 04:11:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:11:46 INFO - mozversion platform_version: 49.0a1 04:11:46 INFO - using testdate: 1463483506 04:11:46 INFO - actual date: 1463483506 04:11:46 INFO - starting webserver on 'localhost:53585' 04:11:46 INFO - SUITE-START | Running 2 tests 04:11:46 INFO - TEST-START | dromaeo_css 04:11:46 INFO - operating with platform_type : linux_ 04:11:46 INFO - Initialising browser for dromaeo_css test... 04:11:46 INFO - TEST-INFO | started process 12004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr7diun/profile http://localhost:53585/getInfo.html) 04:11:50 INFO - PROCESS | 12004 | __metrics Screen width/height:1600/1200 04:11:50 INFO - PROCESS | 12004 | colorDepth:24 04:11:50 INFO - PROCESS | 12004 | Browser inner width/height: 1024/697 04:11:50 INFO - PROCESS | 12004 | __metrics 04:11:51 ERROR - PROCESS | 12004 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:11:52 INFO - TEST-INFO | 12004: exit 0 04:11:52 INFO - Browser initialized. 04:11:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:52 INFO - TEST-INFO | started process 12084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr7diun/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:04 INFO - PROCESS | 12084 | RSS: Main: 154083328 04:12:04 INFO - PROCESS | 12084 | 04:12:55 INFO - PROCESS | 12084 | 1463483575760 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] 04:15:08 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:53585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53585/tests/dromaeo/cssquery-ext.html) 04:15:09 INFO - PROCESS | 12084 | RSS: Main: 245088256 04:15:09 INFO - PROCESS | 12084 | 04:18:12 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:53585/tests/dromaeo/cssquery-ext.html (next: http://localhost:53585/tests/dromaeo/cssquery-jquery.html) 04:18:12 INFO - PROCESS | 12084 | RSS: Main: 235200512 04:18:12 INFO - PROCESS | 12084 | 04:21:14 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:53585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53585/tests/dromaeo/cssquery-mootools.html) 04:21:15 INFO - PROCESS | 12084 | RSS: Main: 248922112 04:21:15 INFO - PROCESS | 12084 | 04:24:17 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:53585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53585/tests/dromaeo/cssquery-prototype.html) 04:24:18 INFO - PROCESS | 12084 | RSS: Main: 236486656 04:24:18 INFO - PROCESS | 12084 | 04:27:21 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:53585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53585/tests/dromaeo/cssquery-yui.html) 04:27:21 INFO - PROCESS | 12084 | RSS: Main: 215142400 04:27:21 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | Cycle 1(1): loaded http://localhost:53585/tests/dromaeo/cssquery-yui.html (next: http://localhost:53585/tests/dromaeo/cssquery-dojo.html) 04:30:24 INFO - PROCESS | 12084 | RSS: Main: 276660224 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | __start_tp_report 04:30:24 INFO - PROCESS | 12084 | _x_x_mozilla_page_load 04:30:24 INFO - PROCESS | 12084 | _x_x_mozilla_page_load_details 04:30:24 INFO - PROCESS | 12084 | |i|pagename|runs| 04:30:24 INFO - PROCESS | 12084 | |0;dojo.html;2638.0898589986455;2647.986760066199;2695.27227648535;2697.8785954632044;2702.6216329713843;4564.9543504564945;4636.374089497916;4672.486026537083;4745.857624271273;4807.038592281545;4639.605633521146;4677.4387073551225;4678.953210467895;4681.157391669498;4720.716756994582;4218.15636872626;4243.193793179286;4321.589449002356;4375.474943006843;4400.361947517608;4316.784160791964;4364.083542456088;4390.40729501518;4410.2943529035365;4414.845480408187;4190.559991200941;4219.3249080147025;4222.514410842762;4360.062586543908;4373.059792144672;4301.612854843079;4303.634191093761;4306.418633484471;4318.330658747899;4337.110892267077;4298.226319262531;4307.224699554079;4315.611594956437;4357.477102747659;4372.628326592244;4480.507144214133;4599.103174880899;4655.092257009885;4681.508441613616;4711.057788442291;5072.0870243356185;5120.92318615221;5130.769115389817;5166.535011848914;5167.044096842096;5130.9743451282875;5177;5194.168932970744;5196.844094677166;5204.063268611649;4566.360709500673;4643.489216186217;4676.8129274828625;4832.202686556679;4833.154198015333;5117.02776472469;5122.590192784568;5164.845054648366;5169.560587350042;5182.818601348935;4908.214685650279;4922.852314430501;4974.054929563371;4974.403071631427;4975;4867.050925069649;5001.24981252815;5013.974930125399;5035.748212589356;5063.291139240436;5020.422651395136;5029.497050295015;5035.0685123252315;5039.067772462106;5094.77073531692;5032.798688052437;5040.243963405445;5043.899122017539;5044.697318160922;5049.040682270357;4221.852235171754;4242.8727138185905;4275.957240427556;4320.179165958458;4328.935065974013;3802.961970380316;3809.6190380961684;3818.4272359145793;3820.656140947328;3821.082940094357;4274.700770946004;4287.699861009762;4332.848350307724;4337;4380.3210502372185;5045.798168073309;5050.242463630485;5052.368453943257;5056.342675452168;5105.2597373381395;4307.117041006586;4312.525622181557;4318.870433886988;4328.870133895988;4362.978185109054;4481.820727170942;4587.036722288357;4607.35497030416;4637.373954516164;4641.74470404131;4829.323894654681;4830.3237546743485;4832.9275060874115;4840.709557426566;4889.217725164028;4905.681130726492;5055.191169412877;5103.4386217516785;5112.463191365002;5167.173252279617;4761.666683332133;4818.060478206716;4835.29888166221;4837.153498137882;4838.177509823409;5019.573336266459;5036.670671938329;5037.571806396498;5043.773030213576;5094.898102038012;4785.210440277316;4991.975040124921;5085.135526960352;5103.8468845934685;5154.53609175161;4869.440014398389;4922.556969872729;4939.753012349296;4941.036497882878;4989.052080104769;4915.705057696549;4918.2868484068895;4922.384701912261;4924.679895806761;4983.775730092227;4630.814767409401;4832.685875418087;4855.441624213119;4855.441624213119;4910.312556242057;4982.003599280086;4987.625928055483;5002.574781143643;5004.3494345734825;5040.143175660073;4897.510248975074;4907.165781817171;4907.288443175791;4914.975425122851;4938.851834444972 04:30:24 INFO - PROCESS | 12084 | |1;ext.html;576.9769209231629;601.8344955137337;609.5946195779807;612.6538505744252;618.8174488525882;29972.25069373264;33524.16189595262;33572.49641255383;33657.66342336576;43367.783161084226;40656.59343406565;44832.775836120854;44856.55143448564;44896.775516122456;44909.55090449095;8005.439619226671;8177;8177.836443271131;8180.304674102678;8185.7135000275;7931.206879312081;8036.598170091501;8036.8392632147325;8040.758777236692;8043.517388956652;7992.720254791084;8041.276285134337;8045.074816396102;8046.275835174833;8047.275745182962;8015.7194498192575;8057.838843223103;8065.63704633287;8066.516009039477;8068.556229407381;8032.0361556613;8092.069412017576;8112.269895709355;8113.594320284021;8116.188381161895;40403.59596404028;40961.38557921634;40985;40988;40990.59009409927;3251.6260630027614;3456.654334566548;3510.0873772818995;3740.8503659853573;3774.3772277574167;30291.545626815616;30617.16297022186;30951.226219344473;30980.38039239225;31083.68916310853;3143.387039527293;3162.652108268089;3272.9836350818096;3302.4550949093373;3304.4052070627276;260242;261188;261374;261640.9999999981;261776;30123.246918826768;30769.230769230948;30869;56892.71553642205;57637.52443517859;36739.63260367362;36933;37015;37022;37048.629513704516;14178.291085445686;14329.06861054049;14331.140131592138;14332.785008224884;14334.211618360881;11565.132615053904;11642.301461912313;11665.066794656406;11673.474693638807;11673.708157296136;8548.700795472252;8551.102134275812;8582.270507006975;8645.913540864636;8648.135186481302;3301.4552598821406;3302.53764472974;3319.55186049885;3375.780574262665;3391.270876761508;904.0597778310615;919.4391421233042;992.9553170107363;1023.4064242739194;1050.3907733514543;28516;28914.71085289162;28988.42023159567;29395.412091758044;29420.264493387836;958.8226178157063;995.1938929467154;1033.994830025845;1051.6844946516014;1051.8632577764843;15517.224138793015;15950.68098638044;15977.360905563648;16164.27260773268;16185.838141618433;371212;371711;373796;374405;376819;53862.7306863471;54164.72917635387;54419;54524.45475545273;54552.45447545553;1170.4030944218339;1176.564671071692;1249.6500979725872;1297.1568480487758;1329.7539955108336;28793.712062879942;29941.850290748407;30234.24414389658;31241.68758312388;32183.195420114684;52104.73947630238;52178.21732674089;52975;53045;53046;349610;352477;353257;354183;355056;32219.355612887142;34101.317973640886;35482.38728965218;41166.1766764657;41890.58109418989;40830.79584602058;44383.33424998563;44773.776131119135;45193.54806451893;45849.77075114603;37474.87575372743;39337.606623933396;39620.00949976274;39929.40105898356;40000.1999960005;37294.17400155688;38330;38628;38881.416778748906;39253.2149357017;37620;37955;38125.4281185788;38835;38839.2232155361;32666.34667306688;33595.664043359255;34390.31219375649;34395.484067739504;34432.139196520286;26156.60765088563;26259.868700656374;26449.33876653099;26533.867330663223;26619.33451663724 04:30:24 INFO - PROCESS | 12084 | |2;jquery.html;377.8387622797597;385.878448288789;387.5717332347756;396.2036307022883;407.55779978723086;16219.675606487877;17538.912305438454;18372.816271837277;18389;18429.631407371846;17265.568360790985;17363;18008;18031.098445077725;18031.72952405712;5039.899202015958;5175.715335656538;5182.4299327073995;5195.116830138885;5273.604479664041;3659.7621154625;3794.677452416534;5951.791687290945;5960.97019514904;6039.124326972608;5889.852753681171;5988.431099045583;5990.970045149768;6008.639481631094;6040.063790112539;5856.707164641751;5938.406159384049;6052.455279024909;6052.909206361908;6079.331273559905;2456.2262887190655;5251.529571719924;5288.418273989858;5342.759575819097;5347.385050719178;18326.541836454195;18437.7234341485;18443.44669659899;19112.23551057956;21756.782432175634;1822.6992546229856;1983.7619485661812;2029.756429228502;2042.5914817036653;2067.452125186827;8758.605862736129;9026.413283136575;9364.531773411301;9779.266555008402;9793.853092203623;1715.3567412220418;1767.9953118326548;1770.6547223291464;1777.644471105784;1799.7840259168852;50918.49081509175;64451;65117;71864;74836;9692.563834627459;10097.545610447547;10423.218258630633;10450.790984180427;10593.629222977159;14465.78301325481;14582.635434114232;14595.562133136023;14607.342669579895;14607.415703371958;7314.86890656434;7568.810779730551;7577.810554736176;7712.460127791113;7781.844363112706;7273.3453989141235;7319.194888562254;7433.479656424107;7444.292792184734;7503.137139229058;4258.318669012943;4299.290617048215;4430.13612345596;4542.818287268472;4638.257878739386;1857.58204404008;1879.586490971984;1902.6860568006125;1918.1464248409602;1951.9902400487906;781.6170076662395;883.1609970528024;906.6781292641149;963.6579014449909;974.35205588283;16167.676646467005;16301.673966520602;16848.07335596554;17455.127243637766;18196.1811718473;866.7746385939575;894.7315805258396;901.2789768185426;905.9411138275991;928.809594033235;9938.403695778277;10054.29619926598;10087.495625218857;10094.495275236355;10107.39355638664;402803;403597;409730;410776;422518;52136;63027.6848615754;88672;89703.55148224217;90524.6421303681;960.3949511807516;975.2831668723483;983.1544871410581;983.3460748602242;991.4844280973997;14769;15647.061176329456;15648.687026259184;15777;16132.758008629646;35648.28703425969;36815.07962300964;37045.44431833579;37088.81455592705;39036.21927561376;52288;54039.45960540501;54935.72532137314;55167.448325516234;55361;7875.527468351917;7907.169747176694;7960.800979975547;7965.880511792444;8027.076886157933;10447.910417916599;11594.76810463803;11849.289042657469;11988.340641264815;12359.32023738703;10295.690060057443;10503.212259080447;10514.631987880693;10670.519826607666;10767;10236.436995965294;10425.791484170426;10577.682669519927;10606.151507879196;10667.146628269564;10654.786904261717;10697.465126743477;10900.40047797347;11066.170037247077;11233.38216398106;7848.097468791162;7871.567063811545;7884.29041386278;7960.044794624682;7983.640736167003;8067.475614085066;9835.311528192959;10546.419946902994;10564.471776410996;10703.625373111903 04:30:24 INFO - PROCESS | 12084 | |3;mootools.html;1331.46075839285;1496.6034000989737;1530.7474266745987;1667.499750074977;1841.4383612998038;7761.6507257173425;7997.200279972;8001.639926203313;8279.089300176991;8283.792905177374;8025.879611805813;8272.420930534865;8277;8277.91722082779;8282.378821588374;2057.146284292021;2065.7727649958492;2078.5635016646524;2085.0200405809323;2086.9895650521726;2176.5102851858364;2204.944876378095;2207.3708992937018;2207.602631526325;2217.634090375086;2160.8163306119;2160.924367647133;2189.4526368407896;2192.8903554822195;2193.5503221839485;2133.935981920537;2150.946226344354;2151.0535364439597;2152.45112496314;2154.041451554059;2091.173986275428;2109.9050542725463;2113.1864232270686;2120.968185477219;2129.8083172514393;7853.725119620843;8009.1590383009525;8037.7588672339925;8095.150009249003;8103.068147163092;4593.885152871171;4722.7402492862875;4750.762461876927;4753.976230118862;4764.714117152982;2946.79372443929;2952.1881482592244;3016.834074125922;3032.0903728881467;3076.600041994549;880.9207171354609;891.1667590802621;894.4230971023718;896.3277541843618;896.462122726359;10833;10833.620823271227;10873.891261087447;10875.184361172944;10879.510422030948;4017.6183262590007;4090.570490098556;4134.524529679065;4167.249895018926;4170.687198460067;8474.957625211835;8507.234348908629;8520.914790852135;8526.531040792815;8546.401751877309;4606.170889239969;4608.032313214262;4612.86161415158;4614.423197100363;4616.815327386934;3798.6581207691443;3980.980095099564;4113.4858142732155;4181.456410666655;4271.508776490743;3353.2958078803235;3377.6453472385538;3385.23832137767;3410.931781364359;3452.067941655789;991.3853410885297;1008.2488546033105;1008.8083264179783;1015.7816069545083;1017.3946501831399;803.3011280186158;912.8767616371838;924.5700749151542;926.092429419173;953.8855337359422;5575.414581468968;5646.661200327993;5793.04414771558;5864.237649105674;5891.23413956183;400.3294481743127;402.40243238790373;406.74578388507183;409.0305974839649;409.41862555171133;3683.723720720957;3780.3384407729086;3790.8104594770152;3800.9619903801163;3854.402567602026;9665.565049572786;10028.047335503115;10106.797864042677;10109.494525273707;10115.494225288854;9950.651727189514;10014.948430414846;10074.597016119273;10089.848652270222;10095.646652367132;6953.965230173817;7232.493725439169;7543.434242431839;7648.043994500687;7653.655585498666;5921.674307912934;5948.672822994777;6021.397860213943;6130.264368275835;6159.260888693386;8840.115988401109;9155.679551215675;9168.54157292146;9414.67048653294;9504.382215155993;9340.346175767903;9485.715428537154;9501.714948551555;9570.090841370058;9678;6706.161729783777;6797.4901882358035;6867.278935711678;7123.109611298588;7125.038119853753;7945.761627151194;7985.480943738638;8012.919870801217;8022.638981245975;8053.395995300259;7027.191872934678;7066.081409416743;7067.434605231672;7152.928470715435;7418.9629051856555;6753.561018533779;6817.2501024888215;6840.384365407137;6896.724131034703;6956.373926346653;6726.495512836459;6810.148731408574;6865.450763938973;6865.828354291183;6869.175698916162;4947.109520286383;5048.798048078036;5067.721275329893;5123.820666276662;5166.199239117943;4628.143793398232;4632.559906808848;5110.97444512775;5193.558547523503;5282.049231138279 04:30:24 INFO - PROCESS | 12084 | |4;prototype.html;304.7394477721548;310.64276082505114;310.96112985876766;312.35810409608246;315.27644056889443;4933.385305787933;4963.429205641352;4964.627652926031;4979.67632103913;4994.275830004652;4872.780724867381;4884.87787805305;4915.3855768029;4922.40931088269;4925.48282430345;3664.1206110533412;3777.452269420932;3782.8108594570162;3863.864764733235;3874.748141370816;3794.3739283018267;3835.3096442640312;3847.3267178243836;3875.1280961783514;3888.105735680795;3573.6426357364185;3776.433534969749;3791.507104076466;3799.772013679174;3818.6372294631965;3656.177360093971;3759.5149915783386;3767.6420740029653;3782.524815322027;3789.677877380426;3346.3641908037393;3353.899383018489;3355.76509644325;3361.983190084034;3370.8483118259737;4635.490096089427;4642.86071417858;4651.558017014736;4654.0924519718665;4675.509071547506;4186.665066794649;4292.635126014293;4363.716358436692;4368.344748287751;4381.75900325482;5036.395632524084;5046.394432668067;5060.392752869642;5076.147206269722;5077.136886729265;3703.518542589446;3709.0327737809644;3711.721620878445;3717.70258379329;3719.7396182267253;4951.900961980777;5291.153415453509;5330.946690533084;5332.600054995852;5336.226247194135;3748.306563285801;3759.4172903200047;3773.6226377362045;3779.905502362408;3782.8486860525272;3798.430235464647;3823.655870971626;3827.6363745444137;3831;3850.268448994682;4314.619321816988;4343.1530851484285;4348.978255108767;4359.346098085249;4368.497622773358;5007.824726134568;5071.7971281149075;5082.74586270685;5085.720285384339;5089.8218562350885;1338.5315139701027;1342.8254326937436;1342.905531991424;1348.4964264844823;1353.7360214758028;887.6094518411878;894.9105089491129;931.3759780946782;955.7276176289724;959.7858708733457;4446.377507149002;4453.242948698664;4459.866204013885;4498.820047198075;4504.909901801946;5206.739663016834;5235.790568377222;5245.396779370421;5246.23929530216;5251.396089449762;4346.630536404441;4403.14138742942;4446.533114022981;4465.575770301816;4489.710247773659;2787.776977841768;2790.8418006527468;2796.7905354769505;2800.159952014428;2803.341214814517;4918.1966279221215;4940.827071052496;4944.678595891256;4967.950320496749;4980.452150263468;5117;5382.973085134549;5384.730763461811;5456.072467680504;5479.397266300703;5022.367730487606;5036.622253331088;5038.722870242099;5041.369828771477;5041.470645582234;5269.736513174403;5304.427352733844;5309.309789727311;5310.097283461743;5362.70505122222;5073.518015788494;5122.016361172274;5204.401493828258;5204.427512973494;5209.583233341399;4971.726555039508;4979.402471703419;4979.452260251442;4985.700857948535;4996.750162491788;3730.347189241926;3733.2346868892355;3733.589305176374;3745;3758.812059397074;5083.38999320084;5272.261883336413;5278.841634750964;5283.1811069282785;5289.576833853205;5094.439611642791;5118.74406279692;5120.695686940817;5142.125838607521;5147.794088236428;5068.82259120929;5113.92329115071;5160.948390516047;5163.380394352702;5173.870653233699;4869.829555965524;4951;5070.4929507049;5088.363954505687;5100.591952643706;5060.569851562658;5112.412072611697;5190.584753219809;5192.24712416705;5196.714180719945;5069.214271787879;5075.365579302587;5080.053568930086;5090.643654944119;5106.259592359162 04:30:24 INFO - PROCESS | 12084 | |5;yui.html;670.51052731506;733.7798660401879;796.9442139050261;804.7304153108709;816.0052606932561;13042.282674452901;13428.59714208573;13585.796213056812;13588.864111358884;13602.931985340072;12570.560030398938;13088.541901033466;13110.082294239408;13117.67205819855;13137.146085504459;686.0669489494284;867.9262262707662;871.6426265231256;878.1569693094636;885.6944354197791;870.1602953150209;888.5557221389305;890.8396488632044;892.2638822971043;892.6830975003877;932.0818993291603;932.4684929590136;938.1884669760676;938.4088024544527;938.4885237545554;711.1750369571273;903.0698380667923;922.7370199493113;930.7393929699662;931.9114684104999;687.1582311668217;687.2783577243924;687.71116131225;688.132952479874;691.7959202035412;13291.136076155019;13317.533886313933;13334.399952002086;13357.465701371933;13375.531856385078;11977.820332695017;12316.630501084981;12390.876091239063;12617.684557886034;12800.423980920881;10733.355998640029;10747.892521074846;10798.838017429745;11012.063974562172;11036.558537658484;4145.585441455861;4175.5615660355525;4209.0529630833125;4217.536071032184;4331.6534677225745;45610.54389456129;45624.999999999665;45645.77177114126;45744.542554574364;45839.770801146115;9048.321375896834;9050.909490905138;9104.13510716481;9274.95362523183;9309.30180236485;17604.295828166985;17637.82362176362;17647.38234161824;17662.116894155242;17683.73474397885;6607.141071660653;6695.966520167368;6851.040854280404;6856.24581296057;6866.931330686729;3768.660820526111;3910.511186101737;3925.941110883339;3985.980070099631;3989.341758609855;2769.1969328894397;2850.0452348463496;2854.4576530459144;2855.914322570326;2857.1857020748985;512.423523536022;518.3883018038675;520.8697825543614;521.2025600830735;533.8665333666584;500.6645547483195;516.2823675091626;589.8495883549667;623.7629700713791;630.7981445937348;8168.959155204186;8261.669533218725;8320.779575906705;8332.541710205996;8533.829323413496;509.58723434018566;611.9755209791558;617.6942413505344;627.8085184018918;632.3297304856775;3759.5149915783113;3779.5464544254864;3947.546032206333;4001.679865610744;4036.979815100906;56716.71641641848;57725.711371443715;58557.70721146367;58745;58899;49902;50727.239091413656;51500.227496587584;52688.20967685488;52797.2080418794;46016;46638.76680616508;46998.53001469941;47452;48144.518554814706;7554.848903022019;7767.300942915164;7811.668779675433;7877.798251264511;7934.960325198337;30878;31415.528767068055;31540.05379838517;31729.5240571387;31884.202894926886;38223.61776382312;40242;40586;40765.1846963065;40894.59105409027;9227.76930576714;10189.337693049929;10210.693679189637;10233.692989210336;10396.948015259875;10312.381257124596;10532.26274160832;10550.366977981346;10572.995565421274;11104.278221915549;9810.313278070467;10025.197984161396;10187.796244074929;10268.178545716473;10470.581176752845;10101.292909496266;10419.218558607983;10423.843642345219;10666.786664266827;10816.242862999514;9370.67202647904;9600;9693.466859322805;9720.659776907774;9856.260780441638;8296.83406331858;8517.95741021291;8560.957195214232;8830.161134692195;8851;8038.919610804051;8113.310368618498;8176.264136227768;8353.540555269276;8487.830243394974 04:30:24 INFO - PROCESS | 12084 | __end_tp_report 04:30:24 INFO - PROCESS | 12084 | __start_cc_report 04:30:24 INFO - PROCESS | 12084 | _x_x_mozilla_cycle_collect,915 04:30:24 INFO - PROCESS | 12084 | __end_cc_report 04:30:24 INFO - PROCESS | 12084 | __startTimestamp1463484624678__endTimestamp 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | ------- Summary: start ------- 04:30:24 INFO - PROCESS | 12084 | Number of tests: 6 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | [#0] dojo.html Cycles:165 Average:4675.04 Median:4833.15 stddev:492.24 (10.2%) stddev-sans-first:467.10 04:30:24 INFO - PROCESS | 12084 | Values: 2638.1 2648.0 2695.3 2697.9 2702.6 4565.0 4636.4 4672.5 4745.9 4807.0 4639.6 4677.4 4679.0 4681.2 4720.7 4218.2 4243.2 4321.6 4375.5 4400.4 4316.8 4364.1 4390.4 4410.3 4414.8 4190.6 4219.3 4222.5 4360.1 4373.1 4301.6 4303.6 4306.4 4318.3 4337.1 4298.2 4307.2 4315.6 4357.5 4372.6 4480.5 4599.1 4655.1 4681.5 4711.1 5072.1 5120.9 5130.8 5166.5 5167.0 5131.0 5177.0 5194.2 5196.8 5204.1 4566.4 4643.5 4676.8 4832.2 4833.2 5117.0 5122.6 5164.8 5169.6 5182.8 4908.2 4922.9 4974.1 4974.4 4975.0 4867.1 5001.2 5014.0 5035.7 5063.3 5020.4 5029.5 5035.1 5039.1 5094.8 5032.8 5040.2 5043.9 5044.7 5049.0 4221.9 4242.9 4276.0 4320.2 4328.9 3803.0 3809.6 3818.4 3820.7 3821.1 4274.7 4287.7 4332.8 4337.0 4380.3 5045.8 5050.2 5052.4 5056.3 5105.3 4307.1 4312.5 4318.9 4328.9 4363.0 4481.8 4587.0 4607.4 4637.4 4641.7 4829.3 4830.3 4832.9 4840.7 4889.2 4905.7 5055.2 5103.4 5112.5 5167.2 4761.7 4818.1 4835.3 4837.2 4838.2 5019.6 5036.7 5037.6 5043.8 5094.9 4785.2 4992.0 5085.1 5103.8 5154.5 4869.4 4922.6 4939.8 4941.0 4989.1 4915.7 4918.3 4922.4 4924.7 4983.8 4630.8 4832.7 4855.4 4855.4 4910.3 4982.0 4987.6 5002.6 5004.3 5040.1 4897.5 4907.2 4907.3 4915.0 4938.9 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | [#1] ext.html Cycles:180 Average:48479.84 Median:205545.09 stddev:87644.53 (42.6%) stddev-sans-first:87816.60 04:30:24 INFO - PROCESS | 12084 | Values: 577.0 601.8 609.6 612.7 618.8 29972.3 33524.2 33572.5 33657.7 43367.8 40656.6 44832.8 44856.6 44896.8 44909.6 8005.4 8177.0 8177.8 8180.3 8185.7 7931.2 8036.6 8036.8 8040.8 8043.5 7992.7 8041.3 8045.1 8046.3 8047.3 8015.7 8057.8 8065.6 8066.5 8068.6 8032.0 8092.1 8112.3 8113.6 8116.2 40403.6 40961.4 40985.0 40988.0 40990.6 3251.6 3456.7 3510.1 3740.9 3774.4 30291.5 30617.2 30951.2 30980.4 31083.7 3143.4 3162.7 3273.0 3302.5 3304.4 260242.0 261188.0 261374.0 261641.0 261776.0 30123.2 30769.2 30869.0 56892.7 57637.5 36739.6 36933.0 37015.0 37022.0 37048.6 14178.3 14329.1 14331.1 14332.8 14334.2 11565.1 11642.3 11665.1 11673.5 11673.7 8548.7 8551.1 8582.3 8645.9 8648.1 3301.5 3302.5 3319.6 3375.8 3391.3 904.1 919.4 993.0 1023.4 1050.4 28516.0 28914.7 28988.4 29395.4 29420.3 958.8 995.2 1034.0 1051.7 1051.9 15517.2 15950.7 15977.4 16164.3 16185.8 371212.0 371711.0 373796.0 374405.0 376819.0 53862.7 54164.7 54419.0 54524.5 54552.5 1170.4 1176.6 1249.7 1297.2 1329.8 28793.7 29941.9 30234.2 31241.7 32183.2 52104.7 52178.2 52975.0 53045.0 53046.0 349610.0 352477.0 353257.0 354183.0 355056.0 32219.4 34101.3 35482.4 41166.2 41890.6 40830.8 44383.3 44773.8 45193.5 45849.8 37474.9 39337.6 39620.0 39929.4 40000.2 37294.2 38330.0 38628.0 38881.4 39253.2 37620.0 37955.0 38125.4 38835.0 38839.2 32666.3 33595.7 34390.3 34395.5 34432.1 26156.6 26259.9 26449.3 26533.9 26619.3 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | [#2] jquery.html Cycles:180 Average:24994.70 Median:205068.78 stddev:67569.37 (32.9%) stddev-sans-first:67733.64 04:30:24 INFO - PROCESS | 12084 | Values: 377.8 385.9 387.6 396.2 407.6 16219.7 17538.9 18372.8 18389.0 18429.6 17265.6 17363.0 18008.0 18031.1 18031.7 5039.9 5175.7 5182.4 5195.1 5273.6 3659.8 3794.7 5951.8 5961.0 6039.1 5889.9 5988.4 5991.0 6008.6 6040.1 5856.7 5938.4 6052.5 6052.9 6079.3 2456.2 5251.5 5288.4 5342.8 5347.4 18326.5 18437.7 18443.4 19112.2 21756.8 1822.7 1983.8 2029.8 2042.6 2067.5 8758.6 9026.4 9364.5 9779.3 9793.9 1715.4 1768.0 1770.7 1777.6 1799.8 50918.5 64451.0 65117.0 71864.0 74836.0 9692.6 10097.5 10423.2 10450.8 10593.6 14465.8 14582.6 14595.6 14607.3 14607.4 7314.9 7568.8 7577.8 7712.5 7781.8 7273.3 7319.2 7433.5 7444.3 7503.1 4258.3 4299.3 4430.1 4542.8 4638.3 1857.6 1879.6 1902.7 1918.1 1952.0 781.6 883.2 906.7 963.7 974.4 16167.7 16301.7 16848.1 17455.1 18196.2 866.8 894.7 901.3 905.9 928.8 9938.4 10054.3 10087.5 10094.5 10107.4 402803.0 403597.0 409730.0 410776.0 422518.0 52136.0 63027.7 88672.0 89703.6 90524.6 960.4 975.3 983.2 983.3 991.5 14769.0 15647.1 15648.7 15777.0 16132.8 35648.3 36815.1 37045.4 37088.8 39036.2 52288.0 54039.5 54935.7 55167.4 55361.0 7875.5 7907.2 7960.8 7965.9 8027.1 10447.9 11594.8 11849.3 11988.3 12359.3 10295.7 10503.2 10514.6 10670.5 10767.0 10236.4 10425.8 10577.7 10606.2 10667.1 10654.8 10697.5 10900.4 11066.2 11233.4 7848.1 7871.6 7884.3 7960.0 7983.6 8067.5 9835.3 10546.4 10564.5 10703.6 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | [#3] mootools.html Cycles:180 Average:5296.07 Median:5058.26 stddev:3019.02 (59.7%) stddev-sans-first:3012.79 04:30:24 INFO - PROCESS | 12084 | Values: 1331.5 1496.6 1530.7 1667.5 1841.4 7761.7 7997.2 8001.6 8279.1 8283.8 8025.9 8272.4 8277.0 8277.9 8282.4 2057.1 2065.8 2078.6 2085.0 2087.0 2176.5 2204.9 2207.4 2207.6 2217.6 2160.8 2160.9 2189.5 2192.9 2193.6 2133.9 2150.9 2151.1 2152.5 2154.0 2091.2 2109.9 2113.2 2121.0 2129.8 7853.7 8009.2 8037.8 8095.2 8103.1 4593.9 4722.7 4750.8 4754.0 4764.7 2946.8 2952.2 3016.8 3032.1 3076.6 880.9 891.2 894.4 896.3 896.5 10833.0 10833.6 10873.9 10875.2 10879.5 4017.6 4090.6 4134.5 4167.2 4170.7 8475.0 8507.2 8520.9 8526.5 8546.4 4606.2 4608.0 4612.9 4614.4 4616.8 3798.7 3981.0 4113.5 4181.5 4271.5 3353.3 3377.6 3385.2 3410.9 3452.1 991.4 1008.2 1008.8 1015.8 1017.4 803.3 912.9 924.6 926.1 953.9 5575.4 5646.7 5793.0 5864.2 5891.2 400.3 402.4 406.7 409.0 409.4 3683.7 3780.3 3790.8 3801.0 3854.4 9665.6 10028.0 10106.8 10109.5 10115.5 9950.7 10014.9 10074.6 10089.8 10095.6 6954.0 7232.5 7543.4 7648.0 7653.7 5921.7 5948.7 6021.4 6130.3 6159.3 8840.1 9155.7 9168.5 9414.7 9504.4 9340.3 9485.7 9501.7 9570.1 9678.0 6706.2 6797.5 6867.3 7123.1 7125.0 7945.8 7985.5 8012.9 8022.6 8053.4 7027.2 7066.1 7067.4 7152.9 7419.0 6753.6 6817.3 6840.4 6896.7 6956.4 6726.5 6810.1 6865.5 6865.8 6869.2 4947.1 5048.8 5067.7 5123.8 5166.2 4628.1 4632.6 5111.0 5193.6 5282.0 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | [#4] prototype.html Cycles:180 Average:4255.32 Median:4923.95 stddev:1225.92 (24.9%) stddev-sans-first:1192.96 04:30:24 INFO - PROCESS | 12084 | Values: 304.7 310.6 311.0 312.4 315.3 4933.4 4963.4 4964.6 4979.7 4994.3 4872.8 4884.9 4915.4 4922.4 4925.5 3664.1 3777.5 3782.8 3863.9 3874.7 3794.4 3835.3 3847.3 3875.1 3888.1 3573.6 3776.4 3791.5 3799.8 3818.6 3656.2 3759.5 3767.6 3782.5 3789.7 3346.4 3353.9 3355.8 3362.0 3370.8 4635.5 4642.9 4651.6 4654.1 4675.5 4186.7 4292.6 4363.7 4368.3 4381.8 5036.4 5046.4 5060.4 5076.1 5077.1 3703.5 3709.0 3711.7 3717.7 3719.7 4951.9 5291.2 5330.9 5332.6 5336.2 3748.3 3759.4 3773.6 3779.9 3782.8 3798.4 3823.7 3827.6 3831.0 3850.3 4314.6 4343.2 4349.0 4359.3 4368.5 5007.8 5071.8 5082.7 5085.7 5089.8 1338.5 1342.8 1342.9 1348.5 1353.7 887.6 894.9 931.4 955.7 959.8 4446.4 4453.2 4459.9 4498.8 4504.9 5206.7 5235.8 5245.4 5246.2 5251.4 4346.6 4403.1 4446.5 4465.6 4489.7 2787.8 2790.8 2796.8 2800.2 2803.3 4918.2 4940.8 4944.7 4968.0 4980.5 5117.0 5383.0 5384.7 5456.1 5479.4 5022.4 5036.6 5038.7 5041.4 5041.5 5269.7 5304.4 5309.3 5310.1 5362.7 5073.5 5122.0 5204.4 5204.4 5209.6 4971.7 4979.4 4979.5 4985.7 4996.8 3730.3 3733.2 3733.6 3745.0 3758.8 5083.4 5272.3 5278.8 5283.2 5289.6 5094.4 5118.7 5120.7 5142.1 5147.8 5068.8 5113.9 5160.9 5163.4 5173.9 4869.8 4951.0 5070.5 5088.4 5100.6 5060.6 5112.4 5190.6 5192.2 5196.7 5069.2 5075.4 5080.1 5090.6 5106.3 04:30:24 INFO - PROCESS | 12084 | 04:30:24 INFO - PROCESS | 12084 | [#5] yui.html Cycles:180 Average:13226.52 Median:25618.41 stddev:15624.06 (61.0%) stddev-sans-first:15639.44 04:30:24 INFO - PROCESS | 12084 | Values: 670.5 733.8 796.9 804.7 816.0 13042.3 13428.6 13585.8 13588.9 13602.9 12570.6 13088.5 13110.1 13117.7 13137.1 686.1 867.9 871.6 878.2 885.7 870.2 888.6 890.8 892.3 892.7 932.1 932.5 938.2 938.4 938.5 711.2 903.1 922.7 930.7 931.9 687.2 687.3 687.7 688.1 691.8 13291.1 13317.5 13334.4 13357.5 13375.5 11977.8 12316.6 12390.9 12617.7 12800.4 10733.4 10747.9 10798.8 11012.1 11036.6 4145.6 4175.6 4209.1 4217.5 4331.7 45610.5 45625.0 45645.8 45744.5 45839.8 9048.3 9050.9 9104.1 9275.0 9309.3 17604.3 17637.8 17647.4 17662.1 17683.7 6607.1 6696.0 6851.0 6856.2 6866.9 3768.7 3910.5 3925.9 3986.0 3989.3 2769.2 2850.0 2854.5 2855.9 2857.2 512.4 518.4 520.9 521.2 533.9 500.7 516.3 589.8 623.8 630.8 8169.0 8261.7 8320.8 8332.5 8533.8 509.6 612.0 617.7 627.8 632.3 3759.5 3779.5 3947.5 4001.7 4037.0 56716.7 57725.7 58557.7 58745.0 58899.0 49902.0 50727.2 51500.2 52688.2 52797.2 46016.0 46638.8 46998.5 47452.0 48144.5 7554.8 7767.3 7811.7 7877.8 7935.0 30878.0 31415.5 31540.1 31729.5 31884.2 38223.6 40242.0 40586.0 40765.2 40894.6 9227.8 10189.3 10210.7 10233.7 10396.9 10312.4 10532.3 10550.4 10573.0 11104.3 9810.3 10025.2 10187.8 10268.2 10470.6 10101.3 10419.2 10423.8 10666.8 10816.2 9370.7 9600.0 9693.5 9720.7 9856.3 8296.8 8518.0 8561.0 8830.2 8851.0 8038.9 8113.3 8176.3 8353.5 8487.8 04:30:24 INFO - PROCESS | 12084 | -------- Summary: end -------- 04:30:24 INFO - PROCESS | 12084 | 04:30:25 INFO - TEST-INFO | 12084: exit 0 04:30:25 INFO - TEST-OK | dromaeo_css | took 1118996ms 04:30:25 INFO - TEST-START | kraken 04:30:25 INFO - operating with platform_type : linux_ 04:30:25 INFO - Initialising browser for kraken test... 04:30:25 INFO - TEST-INFO | started process 12268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRTYys0/profile http://localhost:53585/getInfo.html) 04:30:29 INFO - PROCESS | 12268 | __metrics Screen width/height:1600/1200 04:30:29 INFO - PROCESS | 12268 | colorDepth:24 04:30:29 INFO - PROCESS | 12268 | Browser inner width/height: 1024/697 04:30:29 INFO - PROCESS | 12268 | __metrics 04:30:30 ERROR - PROCESS | 12268 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:30:31 INFO - TEST-INFO | 12268: exit 0 04:30:31 INFO - Browser initialized. 04:30:31 INFO - Running cycle 1/1 for kraken test... 04:30:31 INFO - TEST-INFO | started process 12347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRTYys0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:43 INFO - PROCESS | 12347 | RSS: Main: 154312704 04:30:43 INFO - PROCESS | 12347 | 04:30:45 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53585/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:46 INFO - PROCESS | 12347 | RSS: Main: 210255872 04:30:46 INFO - PROCESS | 12347 | 04:30:49 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53585/tests/kraken/driver.html?testName=audio-dft) 04:30:50 INFO - PROCESS | 12347 | RSS: Main: 196771840 04:30:50 INFO - PROCESS | 12347 | 04:30:53 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53585/tests/kraken/driver.html?testName=audio-fft) 04:30:54 INFO - PROCESS | 12347 | RSS: Main: 266788864 04:30:54 INFO - PROCESS | 12347 | 04:30:56 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53585/tests/kraken/driver.html?testName=audio-oscillator) 04:30:57 INFO - PROCESS | 12347 | RSS: Main: 176193536 04:30:57 INFO - PROCESS | 12347 | 04:30:59 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:00 INFO - PROCESS | 12347 | RSS: Main: 179601408 04:31:00 INFO - PROCESS | 12347 | 04:31:03 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53585/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:04 INFO - PROCESS | 12347 | RSS: Main: 216043520 04:31:04 INFO - PROCESS | 12347 | 04:31:07 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53585/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:08 INFO - PROCESS | 12347 | RSS: Main: 214478848 04:31:08 INFO - PROCESS | 12347 | 04:31:11 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53585/tests/kraken/driver.html?testName=json-parse-financial) 04:31:11 INFO - PROCESS | 12347 | RSS: Main: 215277568 04:31:11 INFO - PROCESS | 12347 | 04:31:13 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:14 INFO - PROCESS | 12347 | RSS: Main: 208670720 04:31:14 INFO - PROCESS | 12347 | 04:31:16 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:16 INFO - PROCESS | 12347 | RSS: Main: 210710528 04:31:16 INFO - PROCESS | 12347 | 04:31:19 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:19 INFO - PROCESS | 12347 | RSS: Main: 215224320 04:31:19 INFO - PROCESS | 12347 | 04:31:22 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:23 INFO - PROCESS | 12347 | RSS: Main: 219033600 04:31:23 INFO - PROCESS | 12347 | 04:31:26 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:26 INFO - PROCESS | 12347 | RSS: Main: 217075712 04:31:26 INFO - PROCESS | 12347 | 04:31:28 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:53585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53585/tests/kraken/driver.html?testName=ai-astar) 04:31:29 INFO - PROCESS | 12347 | RSS: Main: 263507968 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | __start_tp_report 04:31:29 INFO - PROCESS | 12347 | _x_x_mozilla_page_load 04:31:29 INFO - PROCESS | 12347 | _x_x_mozilla_page_load_details 04:31:29 INFO - PROCESS | 12347 | |i|pagename|runs| 04:31:29 INFO - PROCESS | 12347 | |0;ai-astar;115;110;114;113;113;114;113;113;113;116 04:31:29 INFO - PROCESS | 12347 | |1;audio-beat-detection;166;130;152;209;141;158;154;144;181;130 04:31:29 INFO - PROCESS | 12347 | |2;audio-dft;160;163;162;161;161;160;161;163;160;160 04:31:29 INFO - PROCESS | 12347 | |3;audio-fft;77;76;76;155;75;74;75;75;125;76 04:31:29 INFO - PROCESS | 12347 | |4;audio-oscillator;92;92;149;91;91;93;126;93;93;127 04:31:29 INFO - PROCESS | 12347 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;117;116 04:31:29 INFO - PROCESS | 12347 | |6;imaging-darkroom;147;146;147;147;147;147;147;147;147;147 04:31:29 INFO - PROCESS | 12347 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;95;95 04:31:29 INFO - PROCESS | 12347 | |8;json-parse-financial;62;65;63;63;63;63;62;64;63;63 04:31:29 INFO - PROCESS | 12347 | |9;json-stringify-tinderbox;64;64;64;64;70;64;63;64;64;64 04:31:29 INFO - PROCESS | 12347 | |10;stanford-crypto-aes;82;82;81;80;81;83;82;87;144;82 04:31:29 INFO - PROCESS | 12347 | |11;stanford-crypto-ccm;140;130;134;129;136;138;126;129;149;148 04:31:29 INFO - PROCESS | 12347 | |12;stanford-crypto-pbkdf2;181;171;173;172;169;169;170;171;171;167 04:31:29 INFO - PROCESS | 12347 | |13;stanford-crypto-sha256-iterative;65;72;68;66;66;65;64;65;65;64 04:31:29 INFO - PROCESS | 12347 | __end_tp_report 04:31:29 INFO - PROCESS | 12347 | __start_cc_report 04:31:29 INFO - PROCESS | 12347 | _x_x_mozilla_cycle_collect,2097 04:31:29 INFO - PROCESS | 12347 | __end_cc_report 04:31:29 INFO - PROCESS | 12347 | __startTimestamp1463484689022__endTimestamp 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | ------- Summary: start ------- 04:31:29 INFO - PROCESS | 12347 | Number of tests: 14 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:1.58 (1.4%) stddev-sans-first:1.56 04:31:29 INFO - PROCESS | 12347 | Values: 115.0 110.0 114.0 113.0 113.0 114.0 113.0 113.0 113.0 116.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:156.00 stddev:24.21 (15.5%) stddev-sans-first:25.44 04:31:29 INFO - PROCESS | 12347 | Values: 166.0 130.0 152.0 209.0 141.0 158.0 154.0 144.0 181.0 130.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 04:31:29 INFO - PROCESS | 12347 | Values: 160.0 163.0 162.0 161.0 161.0 160.0 161.0 163.0 160.0 160.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#3] audio-fft Cycles:10 Average:88.40 Median:75.50 stddev:28.11 (37.2%) stddev-sans-first:29.51 04:31:29 INFO - PROCESS | 12347 | Values: 77.0 76.0 76.0 155.0 75.0 74.0 75.0 75.0 125.0 76.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:92.00 stddev:21.14 (23.0%) stddev-sans-first:21.92 04:31:29 INFO - PROCESS | 12347 | Values: 92.0 92.0 149.0 91.0 91.0 93.0 126.0 93.0 93.0 127.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:31:29 INFO - PROCESS | 12347 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:31:29 INFO - PROCESS | 12347 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:31:29 INFO - PROCESS | 12347 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 04:31:29 INFO - PROCESS | 12347 | Values: 62.0 65.0 63.0 63.0 63.0 63.0 62.0 64.0 63.0 63.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:1.96 (3.1%) stddev-sans-first:2.07 04:31:29 INFO - PROCESS | 12347 | Values: 64.0 64.0 64.0 64.0 70.0 64.0 63.0 64.0 64.0 64.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:82.00 stddev:19.63 (23.9%) stddev-sans-first:20.68 04:31:29 INFO - PROCESS | 12347 | Values: 82.0 82.0 81.0 80.0 81.0 83.0 82.0 87.0 144.0 82.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:137.00 stddev:7.96 (5.8%) stddev-sans-first:8.31 04:31:29 INFO - PROCESS | 12347 | Values: 140.0 130.0 134.0 129.0 136.0 138.0 126.0 129.0 149.0 148.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:3.78 (2.2%) stddev-sans-first:1.80 04:31:29 INFO - PROCESS | 12347 | Values: 181.0 171.0 173.0 172.0 169.0 169.0 170.0 171.0 171.0 167.0 04:31:29 INFO - PROCESS | 12347 | 04:31:29 INFO - PROCESS | 12347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.50 stddev:2.40 (3.7%) stddev-sans-first:2.52 04:31:29 INFO - PROCESS | 12347 | Values: 65.0 72.0 68.0 66.0 66.0 65.0 64.0 65.0 65.0 64.0 04:31:29 INFO - PROCESS | 12347 | -------- Summary: end -------- 04:31:29 INFO - PROCESS | 12347 | 04:31:30 INFO - TEST-INFO | 12347: exit 0 04:31:30 INFO - TEST-OK | kraken | took 64626ms 04:31:30 INFO - SUITE-END | took 1183s 04:31:30 INFO - Completed test suite (00:19:43) 04:31:30 INFO - javascript benchmark 04:31:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.0898589986455, 2647.986760066199, 2695.27227648535, 2697.8785954632044, 2702.6216329713843, 4564.9543504564945, 4636.374089497916, 4672.486026537083, 4745.857624271273, 4807.038592281545, 4639.605633521146, 4677.4387073551225, 4678.953210467895, 4681.157391669498, 4720.716756994582, 4218.15636872626, 4243.193793179286, 4321.589449002356, 4375.474943006843, 4400.361947517608, 4316.784160791964, 4364.083542456088, 4390.40729501518, 4410.2943529035365, 4414.845480408187, 4190.559991200941, 4219.3249080147025, 4222.514410842762, 4360.062586543908, 4373.059792144672, 4301.612854843079, 4303.634191093761, 4306.418633484471, 4318.330658747899, 4337.110892267077, 4298.226319262531, 4307.224699554079, 4315.611594956437, 4357.477102747659, 4372.628326592244, 4480.507144214133, 4599.103174880899, 4655.092257009885, 4681.508441613616, 4711.057788442291, 5072.0870243356185, 5120.92318615221, 5130.769115389817, 5166.535011848914, 5167.044096842096, 5130.9743451282875, 5177.0, 5194.168932970744, 5196.844094677166, 5204.063268611649, 4566.360709500673, 4643.489216186217, 4676.8129274828625, 4832.202686556679, 4833.154198015333, 5117.02776472469, 5122.590192784568, 5164.845054648366, 5169.560587350042, 5182.818601348935, 4908.214685650279, 4922.852314430501, 4974.054929563371, 4974.403071631427, 4975.0, 4867.050925069649, 5001.24981252815, 5013.974930125399, 5035.748212589356, 5063.291139240436, 5020.422651395136, 5029.497050295015, 5035.0685123252315, 5039.067772462106, 5094.77073531692, 5032.798688052437, 5040.243963405445, 5043.899122017539, 5044.697318160922, 5049.040682270357, 4221.852235171754, 4242.8727138185905, 4275.957240427556, 4320.179165958458, 4328.935065974013, 3802.961970380316, 3809.6190380961684, 3818.4272359145793, 3820.656140947328, 3821.082940094357, 4274.700770946004, 4287.699861009762, 4332.848350307724, 4337.0, 4380.3210502372185, 5045.798168073309, 5050.242463630485, 5052.368453943257, 5056.342675452168, 5105.2597373381395, 4307.117041006586, 4312.525622181557, 4318.870433886988, 4328.870133895988, 4362.978185109054, 4481.820727170942, 4587.036722288357, 4607.35497030416, 4637.373954516164, 4641.74470404131, 4829.323894654681, 4830.3237546743485, 4832.9275060874115, 4840.709557426566, 4889.217725164028, 4905.681130726492, 5055.191169412877, 5103.4386217516785, 5112.463191365002, 5167.173252279617, 4761.666683332133, 4818.060478206716, 4835.29888166221, 4837.153498137882, 4838.177509823409, 5019.573336266459, 5036.670671938329, 5037.571806396498, 5043.773030213576, 5094.898102038012, 4785.210440277316, 4991.975040124921, 5085.135526960352, 5103.8468845934685, 5154.53609175161, 4869.440014398389, 4922.556969872729, 4939.753012349296, 4941.036497882878, 4989.052080104769, 4915.705057696549, 4918.2868484068895, 4922.384701912261, 4924.679895806761, 4983.775730092227, 4630.814767409401, 4832.685875418087, 4855.441624213119, 4855.441624213119, 4910.312556242057, 4982.003599280086, 4987.625928055483, 5002.574781143643, 5004.3494345734825, 5040.143175660073, 4897.510248975074, 4907.165781817171, 4907.288443175791, 4914.975425122851, 4938.851834444972], "value": 4644.015462478145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.9769209231629, 601.8344955137337, 609.5946195779807, 612.6538505744252, 618.8174488525882, 29972.25069373264, 33524.16189595262, 33572.49641255383, 33657.66342336576, 43367.783161084226, 40656.59343406565, 44832.775836120854, 44856.55143448564, 44896.775516122456, 44909.55090449095, 8005.439619226671, 8177.0, 8177.836443271131, 8180.304674102678, 8185.7135000275, 7931.206879312081, 8036.598170091501, 8036.8392632147325, 8040.758777236692, 8043.517388956652, 7992.720254791084, 8041.276285134337, 8045.074816396102, 8046.275835174833, 8047.275745182962, 8015.7194498192575, 8057.838843223103, 8065.63704633287, 8066.516009039477, 8068.556229407381, 8032.0361556613, 8092.069412017576, 8112.269895709355, 8113.594320284021, 8116.188381161895, 40403.59596404028, 40961.38557921634, 40985.0, 40988.0, 40990.59009409927, 3251.6260630027614, 3456.654334566548, 3510.0873772818995, 3740.8503659853573, 3774.3772277574167, 30291.545626815616, 30617.16297022186, 30951.226219344473, 30980.38039239225, 31083.68916310853, 3143.387039527293, 3162.652108268089, 3272.9836350818096, 3302.4550949093373, 3304.4052070627276, 260242.0, 261188.0, 261374.0, 261640.9999999981, 261776.0, 30123.246918826768, 30769.230769230948, 30869.0, 56892.71553642205, 57637.52443517859, 36739.63260367362, 36933.0, 37015.0, 37022.0, 37048.629513704516, 14178.291085445686, 14329.06861054049, 14331.140131592138, 14332.785008224884, 14334.211618360881, 11565.132615053904, 11642.301461912313, 11665.066794656406, 11673.474693638807, 11673.708157296136, 8548.700795472252, 8551.102134275812, 8582.270507006975, 8645.913540864636, 8648.135186481302, 3301.4552598821406, 3302.53764472974, 3319.55186049885, 3375.780574262665, 3391.270876761508, 904.0597778310615, 919.4391421233042, 992.9553170107363, 1023.4064242739194, 1050.3907733514543, 28516.0, 28914.71085289162, 28988.42023159567, 29395.412091758044, 29420.264493387836, 958.8226178157063, 995.1938929467154, 1033.994830025845, 1051.6844946516014, 1051.8632577764843, 15517.224138793015, 15950.68098638044, 15977.360905563648, 16164.27260773268, 16185.838141618433, 371212.0, 371711.0, 373796.0, 374405.0, 376819.0, 53862.7306863471, 54164.72917635387, 54419.0, 54524.45475545273, 54552.45447545553, 1170.4030944218339, 1176.564671071692, 1249.6500979725872, 1297.1568480487758, 1329.7539955108336, 28793.712062879942, 29941.850290748407, 30234.24414389658, 31241.68758312388, 32183.195420114684, 52104.73947630238, 52178.21732674089, 52975.0, 53045.0, 53046.0, 349610.0, 352477.0, 353257.0, 354183.0, 355056.0, 32219.355612887142, 34101.317973640886, 35482.38728965218, 41166.1766764657, 41890.58109418989, 40830.79584602058, 44383.33424998563, 44773.776131119135, 45193.54806451893, 45849.77075114603, 37474.87575372743, 39337.606623933396, 39620.00949976274, 39929.40105898356, 40000.1999960005, 37294.17400155688, 38330.0, 38628.0, 38881.416778748906, 39253.2149357017, 37620.0, 37955.0, 38125.4281185788, 38835.0, 38839.2232155361, 32666.34667306688, 33595.664043359255, 34390.31219375649, 34395.484067739504, 34432.139196520286, 26156.60765088563, 26259.868700656374, 26449.33876653099, 26533.867330663223, 26619.33451663724], "value": 17432.669364935035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.8387622797597, 385.878448288789, 387.5717332347756, 396.2036307022883, 407.55779978723086, 16219.675606487877, 17538.912305438454, 18372.816271837277, 18389.0, 18429.631407371846, 17265.568360790985, 17363.0, 18008.0, 18031.098445077725, 18031.72952405712, 5039.899202015958, 5175.715335656538, 5182.4299327073995, 5195.116830138885, 5273.604479664041, 3659.7621154625, 3794.677452416534, 5951.791687290945, 5960.97019514904, 6039.124326972608, 5889.852753681171, 5988.431099045583, 5990.970045149768, 6008.639481631094, 6040.063790112539, 5856.707164641751, 5938.406159384049, 6052.455279024909, 6052.909206361908, 6079.331273559905, 2456.2262887190655, 5251.529571719924, 5288.418273989858, 5342.759575819097, 5347.385050719178, 18326.541836454195, 18437.7234341485, 18443.44669659899, 19112.23551057956, 21756.782432175634, 1822.6992546229856, 1983.7619485661812, 2029.756429228502, 2042.5914817036653, 2067.452125186827, 8758.605862736129, 9026.413283136575, 9364.531773411301, 9779.266555008402, 9793.853092203623, 1715.3567412220418, 1767.9953118326548, 1770.6547223291464, 1777.644471105784, 1799.7840259168852, 50918.49081509175, 64451.0, 65117.0, 71864.0, 74836.0, 9692.563834627459, 10097.545610447547, 10423.218258630633, 10450.790984180427, 10593.629222977159, 14465.78301325481, 14582.635434114232, 14595.562133136023, 14607.342669579895, 14607.415703371958, 7314.86890656434, 7568.810779730551, 7577.810554736176, 7712.460127791113, 7781.844363112706, 7273.3453989141235, 7319.194888562254, 7433.479656424107, 7444.292792184734, 7503.137139229058, 4258.318669012943, 4299.290617048215, 4430.13612345596, 4542.818287268472, 4638.257878739386, 1857.58204404008, 1879.586490971984, 1902.6860568006125, 1918.1464248409602, 1951.9902400487906, 781.6170076662395, 883.1609970528024, 906.6781292641149, 963.6579014449909, 974.35205588283, 16167.676646467005, 16301.673966520602, 16848.07335596554, 17455.127243637766, 18196.1811718473, 866.7746385939575, 894.7315805258396, 901.2789768185426, 905.9411138275991, 928.809594033235, 9938.403695778277, 10054.29619926598, 10087.495625218857, 10094.495275236355, 10107.39355638664, 402803.0, 403597.0, 409730.0, 410776.0, 422518.0, 52136.0, 63027.6848615754, 88672.0, 89703.55148224217, 90524.6421303681, 960.3949511807516, 975.2831668723483, 983.1544871410581, 983.3460748602242, 991.4844280973997, 14769.0, 15647.061176329456, 15648.687026259184, 15777.0, 16132.758008629646, 35648.28703425969, 36815.07962300964, 37045.44431833579, 37088.81455592705, 39036.21927561376, 52288.0, 54039.45960540501, 54935.72532137314, 55167.448325516234, 55361.0, 7875.527468351917, 7907.169747176694, 7960.800979975547, 7965.880511792444, 8027.076886157933, 10447.910417916599, 11594.76810463803, 11849.289042657469, 11988.340641264815, 12359.32023738703, 10295.690060057443, 10503.212259080447, 10514.631987880693, 10670.519826607666, 10767.0, 10236.436995965294, 10425.791484170426, 10577.682669519927, 10606.151507879196, 10667.146628269564, 10654.786904261717, 10697.465126743477, 10900.40047797347, 11066.170037247077, 11233.38216398106, 7848.097468791162, 7871.567063811545, 7884.29041386278, 7960.044794624682, 7983.640736167003, 8067.475614085066, 9835.311528192959, 10546.419946902994, 10564.471776410996, 10703.625373111903], "value": 8404.51083873966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.46075839285, 1496.6034000989737, 1530.7474266745987, 1667.499750074977, 1841.4383612998038, 7761.6507257173425, 7997.200279972, 8001.639926203313, 8279.089300176991, 8283.792905177374, 8025.879611805813, 8272.420930534865, 8277.0, 8277.91722082779, 8282.378821588374, 2057.146284292021, 2065.7727649958492, 2078.5635016646524, 2085.0200405809323, 2086.9895650521726, 2176.5102851858364, 2204.944876378095, 2207.3708992937018, 2207.602631526325, 2217.634090375086, 2160.8163306119, 2160.924367647133, 2189.4526368407896, 2192.8903554822195, 2193.5503221839485, 2133.935981920537, 2150.946226344354, 2151.0535364439597, 2152.45112496314, 2154.041451554059, 2091.173986275428, 2109.9050542725463, 2113.1864232270686, 2120.968185477219, 2129.8083172514393, 7853.725119620843, 8009.1590383009525, 8037.7588672339925, 8095.150009249003, 8103.068147163092, 4593.885152871171, 4722.7402492862875, 4750.762461876927, 4753.976230118862, 4764.714117152982, 2946.79372443929, 2952.1881482592244, 3016.834074125922, 3032.0903728881467, 3076.600041994549, 880.9207171354609, 891.1667590802621, 894.4230971023718, 896.3277541843618, 896.462122726359, 10833.0, 10833.620823271227, 10873.891261087447, 10875.184361172944, 10879.510422030948, 4017.6183262590007, 4090.570490098556, 4134.524529679065, 4167.249895018926, 4170.687198460067, 8474.957625211835, 8507.234348908629, 8520.914790852135, 8526.531040792815, 8546.401751877309, 4606.170889239969, 4608.032313214262, 4612.86161415158, 4614.423197100363, 4616.815327386934, 3798.6581207691443, 3980.980095099564, 4113.4858142732155, 4181.456410666655, 4271.508776490743, 3353.2958078803235, 3377.6453472385538, 3385.23832137767, 3410.931781364359, 3452.067941655789, 991.3853410885297, 1008.2488546033105, 1008.8083264179783, 1015.7816069545083, 1017.3946501831399, 803.3011280186158, 912.8767616371838, 924.5700749151542, 926.092429419173, 953.8855337359422, 5575.414581468968, 5646.661200327993, 5793.04414771558, 5864.237649105674, 5891.23413956183, 400.3294481743127, 402.40243238790373, 406.74578388507183, 409.0305974839649, 409.41862555171133, 3683.723720720957, 3780.3384407729086, 3790.8104594770152, 3800.9619903801163, 3854.402567602026, 9665.565049572786, 10028.047335503115, 10106.797864042677, 10109.494525273707, 10115.494225288854, 9950.651727189514, 10014.948430414846, 10074.597016119273, 10089.848652270222, 10095.646652367132, 6953.965230173817, 7232.493725439169, 7543.434242431839, 7648.043994500687, 7653.655585498666, 5921.674307912934, 5948.672822994777, 6021.397860213943, 6130.264368275835, 6159.260888693386, 8840.115988401109, 9155.679551215675, 9168.54157292146, 9414.67048653294, 9504.382215155993, 9340.346175767903, 9485.715428537154, 9501.714948551555, 9570.090841370058, 9678.0, 6706.161729783777, 6797.4901882358035, 6867.278935711678, 7123.109611298588, 7125.038119853753, 7945.761627151194, 7985.480943738638, 8012.919870801217, 8022.638981245975, 8053.395995300259, 7027.191872934678, 7066.081409416743, 7067.434605231672, 7152.928470715435, 7418.9629051856555, 6753.561018533779, 6817.2501024888215, 6840.384365407137, 6896.724131034703, 6956.373926346653, 6726.495512836459, 6810.148731408574, 6865.450763938973, 6865.828354291183, 6869.175698916162, 4947.109520286383, 5048.798048078036, 5067.721275329893, 5123.820666276662, 5166.199239117943, 4628.143793398232, 4632.559906808848, 5110.97444512775, 5193.558547523503, 5282.049231138279], "value": 4146.652839201384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7394477721548, 310.64276082505114, 310.96112985876766, 312.35810409608246, 315.27644056889443, 4933.385305787933, 4963.429205641352, 4964.627652926031, 4979.67632103913, 4994.275830004652, 4872.780724867381, 4884.87787805305, 4915.3855768029, 4922.40931088269, 4925.48282430345, 3664.1206110533412, 3777.452269420932, 3782.8108594570162, 3863.864764733235, 3874.748141370816, 3794.3739283018267, 3835.3096442640312, 3847.3267178243836, 3875.1280961783514, 3888.105735680795, 3573.6426357364185, 3776.433534969749, 3791.507104076466, 3799.772013679174, 3818.6372294631965, 3656.177360093971, 3759.5149915783386, 3767.6420740029653, 3782.524815322027, 3789.677877380426, 3346.3641908037393, 3353.899383018489, 3355.76509644325, 3361.983190084034, 3370.8483118259737, 4635.490096089427, 4642.86071417858, 4651.558017014736, 4654.0924519718665, 4675.509071547506, 4186.665066794649, 4292.635126014293, 4363.716358436692, 4368.344748287751, 4381.75900325482, 5036.395632524084, 5046.394432668067, 5060.392752869642, 5076.147206269722, 5077.136886729265, 3703.518542589446, 3709.0327737809644, 3711.721620878445, 3717.70258379329, 3719.7396182267253, 4951.900961980777, 5291.153415453509, 5330.946690533084, 5332.600054995852, 5336.226247194135, 3748.306563285801, 3759.4172903200047, 3773.6226377362045, 3779.905502362408, 3782.8486860525272, 3798.430235464647, 3823.655870971626, 3827.6363745444137, 3831.0, 3850.268448994682, 4314.619321816988, 4343.1530851484285, 4348.978255108767, 4359.346098085249, 4368.497622773358, 5007.824726134568, 5071.7971281149075, 5082.74586270685, 5085.720285384339, 5089.8218562350885, 1338.5315139701027, 1342.8254326937436, 1342.905531991424, 1348.4964264844823, 1353.7360214758028, 887.6094518411878, 894.9105089491129, 931.3759780946782, 955.7276176289724, 959.7858708733457, 4446.377507149002, 4453.242948698664, 4459.866204013885, 4498.820047198075, 4504.909901801946, 5206.739663016834, 5235.790568377222, 5245.396779370421, 5246.23929530216, 5251.396089449762, 4346.630536404441, 4403.14138742942, 4446.533114022981, 4465.575770301816, 4489.710247773659, 2787.776977841768, 2790.8418006527468, 2796.7905354769505, 2800.159952014428, 2803.341214814517, 4918.1966279221215, 4940.827071052496, 4944.678595891256, 4967.950320496749, 4980.452150263468, 5117.0, 5382.973085134549, 5384.730763461811, 5456.072467680504, 5479.397266300703, 5022.367730487606, 5036.622253331088, 5038.722870242099, 5041.369828771477, 5041.470645582234, 5269.736513174403, 5304.427352733844, 5309.309789727311, 5310.097283461743, 5362.70505122222, 5073.518015788494, 5122.016361172274, 5204.401493828258, 5204.427512973494, 5209.583233341399, 4971.726555039508, 4979.402471703419, 4979.452260251442, 4985.700857948535, 4996.750162491788, 3730.347189241926, 3733.2346868892355, 3733.589305176374, 3745.0, 3758.812059397074, 5083.38999320084, 5272.261883336413, 5278.841634750964, 5283.1811069282785, 5289.576833853205, 5094.439611642791, 5118.74406279692, 5120.695686940817, 5142.125838607521, 5147.794088236428, 5068.82259120929, 5113.92329115071, 5160.948390516047, 5163.380394352702, 5173.870653233699, 4869.829555965524, 4951.0, 5070.4929507049, 5088.363954505687, 5100.591952643706, 5060.569851562658, 5112.412072611697, 5190.584753219809, 5192.24712416705, 5196.714180719945, 5069.214271787879, 5075.365579302587, 5080.053568930086, 5090.643654944119, 5106.259592359162], "value": 3872.754220866664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.51052731506, 733.7798660401879, 796.9442139050261, 804.7304153108709, 816.0052606932561, 13042.282674452901, 13428.59714208573, 13585.796213056812, 13588.864111358884, 13602.931985340072, 12570.560030398938, 13088.541901033466, 13110.082294239408, 13117.67205819855, 13137.146085504459, 686.0669489494284, 867.9262262707662, 871.6426265231256, 878.1569693094636, 885.6944354197791, 870.1602953150209, 888.5557221389305, 890.8396488632044, 892.2638822971043, 892.6830975003877, 932.0818993291603, 932.4684929590136, 938.1884669760676, 938.4088024544527, 938.4885237545554, 711.1750369571273, 903.0698380667923, 922.7370199493113, 930.7393929699662, 931.9114684104999, 687.1582311668217, 687.2783577243924, 687.71116131225, 688.132952479874, 691.7959202035412, 13291.136076155019, 13317.533886313933, 13334.399952002086, 13357.465701371933, 13375.531856385078, 11977.820332695017, 12316.630501084981, 12390.876091239063, 12617.684557886034, 12800.423980920881, 10733.355998640029, 10747.892521074846, 10798.838017429745, 11012.063974562172, 11036.558537658484, 4145.585441455861, 4175.5615660355525, 4209.0529630833125, 4217.536071032184, 4331.6534677225745, 45610.54389456129, 45624.999999999665, 45645.77177114126, 45744.542554574364, 45839.770801146115, 9048.321375896834, 9050.909490905138, 9104.13510716481, 9274.95362523183, 9309.30180236485, 17604.295828166985, 17637.82362176362, 17647.38234161824, 17662.116894155242, 17683.73474397885, 6607.141071660653, 6695.966520167368, 6851.040854280404, 6856.24581296057, 6866.931330686729, 3768.660820526111, 3910.511186101737, 3925.941110883339, 3985.980070099631, 3989.341758609855, 2769.1969328894397, 2850.0452348463496, 2854.4576530459144, 2855.914322570326, 2857.1857020748985, 512.423523536022, 518.3883018038675, 520.8697825543614, 521.2025600830735, 533.8665333666584, 500.6645547483195, 516.2823675091626, 589.8495883549667, 623.7629700713791, 630.7981445937348, 8168.959155204186, 8261.669533218725, 8320.779575906705, 8332.541710205996, 8533.829323413496, 509.58723434018566, 611.9755209791558, 617.6942413505344, 627.8085184018918, 632.3297304856775, 3759.5149915783113, 3779.5464544254864, 3947.546032206333, 4001.679865610744, 4036.979815100906, 56716.71641641848, 57725.711371443715, 58557.70721146367, 58745.0, 58899.0, 49902.0, 50727.239091413656, 51500.227496587584, 52688.20967685488, 52797.2080418794, 46016.0, 46638.76680616508, 46998.53001469941, 47452.0, 48144.518554814706, 7554.848903022019, 7767.300942915164, 7811.668779675433, 7877.798251264511, 7934.960325198337, 30878.0, 31415.528767068055, 31540.05379838517, 31729.5240571387, 31884.202894926886, 38223.61776382312, 40242.0, 40586.0, 40765.1846963065, 40894.59105409027, 9227.76930576714, 10189.337693049929, 10210.693679189637, 10233.692989210336, 10396.948015259875, 10312.381257124596, 10532.26274160832, 10550.366977981346, 10572.995565421274, 11104.278221915549, 9810.313278070467, 10025.197984161396, 10187.796244074929, 10268.178545716473, 10470.581176752845, 10101.292909496266, 10419.218558607983, 10423.843642345219, 10666.786664266827, 10816.242862999514, 9370.67202647904, 9600.0, 9693.466859322805, 9720.659776907774, 9856.260780441638, 8296.83406331858, 8517.95741021291, 8560.957195214232, 8830.161134692195, 8851.0, 8038.919610804051, 8113.310368618498, 8176.264136227768, 8353.540555269276, 8487.830243394974], "value": 6063.2436812828555, "unit": "score"}], "name": "dromaeo_css", "value": 6361.2177824732335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 116.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 130.0, 152.0, 209.0, 141.0, 158.0, 154.0, 144.0, 181.0, 130.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 161.0, 161.0, 160.0, 161.0, 163.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 155.0, 75.0, 74.0, 75.0, 75.0, 125.0, 76.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 91.0, 91.0, 93.0, 126.0, 93.0, 93.0, 127.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 63.0, 63.0, 63.0, 62.0, 64.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 70.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 80.0, 81.0, 83.0, 82.0, 87.0, 144.0, 82.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 134.0, 129.0, 136.0, 138.0, 126.0, 129.0, 149.0, 148.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 171.0, 173.0, 172.0, 169.0, 169.0, 170.0, 171.0, 171.0, 167.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 68.0, 66.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1571.7000000000003, "alertThreshold": 2.0}]} 04:31:30 INFO - Return code: 0 04:31:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:31:30 ERROR - # TBPL SUCCESS # 04:31:30 INFO - Running post-action listener: _resource_record_post_action 04:31:30 INFO - ##### 04:31:30 INFO - ##### Finished run-tests step (success) 04:31:30 INFO - ##### 04:31:30 INFO - Running post-run listener: _resource_record_post_run 04:31:30 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 531759104; Read time: 28; Write time: 426060 04:31:30 INFO - TinderboxPrint: CPU usage
13.1% 04:31:30 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 04:31:30 INFO - TinderboxPrint: I/O write bytes / time
531,759,104 / 426,060 04:31:30 INFO - TinderboxPrint: CPU idle
8,330.8 (86.9%) 04:31:30 INFO - TinderboxPrint: CPU user
1,212.8 (12.7%) 04:31:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:31:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236417024; Read time: 0; Write time: 258164 04:31:30 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295342080; Read time: 28; Write time: 167896 04:31:30 INFO - Running post-run listener: _upload_blobber_files 04:31:30 INFO - Blob upload gear active. 04:31:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:31:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:31:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:32 INFO - (blobuploader) - INFO - Done attempting. 04:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:33 INFO - (blobuploader) - INFO - Done attempting. 04:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:37 INFO - (blobuploader) - INFO - Done attempting. 04:31:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:37 INFO - Return code: 0 04:31:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56f39ec5989431fa94e2ce4e22e614d6b5d0cd6dbffcb600ff701a18e85cfdbcd43ee555ddd0bad4609a5bc1a17cdecb41d183c3a777f5b841b95e5f8e568a26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39424fbe83dd758269da8491bbfe85ce6ccdcc23216e887aa90265b0f9aab15e06cc37d67509ad8158caf5bcc5c04cba6f4e94fead763b33cdeeb02994eae670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83a3f8397b318eb869fb041672d5207f4ea6d6ba14133a600f63569ccaecbd9326d44ba52ddb6831d721fb756260a12fb21082c2534e6b9635063c8c0d725b21"} 04:31:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:37 INFO - Contents: 04:31:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56f39ec5989431fa94e2ce4e22e614d6b5d0cd6dbffcb600ff701a18e85cfdbcd43ee555ddd0bad4609a5bc1a17cdecb41d183c3a777f5b841b95e5f8e568a26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39424fbe83dd758269da8491bbfe85ce6ccdcc23216e887aa90265b0f9aab15e06cc37d67509ad8158caf5bcc5c04cba6f4e94fead763b33cdeeb02994eae670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83a3f8397b318eb869fb041672d5207f4ea6d6ba14133a600f63569ccaecbd9326d44ba52ddb6831d721fb756260a12fb21082c2534e6b9635063c8c0d725b21"} 04:31:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:37 INFO - Copying logs to upload dir... 04:31:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.397019 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-17 04:31:37.671602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 04:31:37.674859) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436 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/56f39ec5989431fa94e2ce4e22e614d6b5d0cd6dbffcb600ff701a18e85cfdbcd43ee555ddd0bad4609a5bc1a17cdecb41d183c3a777f5b841b95e5f8e568a26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39424fbe83dd758269da8491bbfe85ce6ccdcc23216e887aa90265b0f9aab15e06cc37d67509ad8158caf5bcc5c04cba6f4e94fead763b33cdeeb02994eae670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83a3f8397b318eb869fb041672d5207f4ea6d6ba14133a600f63569ccaecbd9326d44ba52ddb6831d721fb756260a12fb21082c2534e6b9635063c8c0d725b21"} build_url:https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/PIZ9dnbKTriluQTwZN8xJg/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/56f39ec5989431fa94e2ce4e22e614d6b5d0cd6dbffcb600ff701a18e85cfdbcd43ee555ddd0bad4609a5bc1a17cdecb41d183c3a777f5b841b95e5f8e568a26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39424fbe83dd758269da8491bbfe85ce6ccdcc23216e887aa90265b0f9aab15e06cc37d67509ad8158caf5bcc5c04cba6f4e94fead763b33cdeeb02994eae670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83a3f8397b318eb869fb041672d5207f4ea6d6ba14133a600f63569ccaecbd9326d44ba52ddb6831d721fb756260a12fb21082c2534e6b9635063c8c0d725b21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 04:31:37.699549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 04:31:37.699851) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463481427.490149-1313176436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 04:31:37.784501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 04:31:37.784820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 04:31:37.785122) ========= ========= Total master_lag: 0.18 =========