builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1463818112.98 results: success (0) buildid: 20160521003735 builduid: c2181ba5fda8461ea3c84343455ce2ef revision: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.981079) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.981639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.981934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.020953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.021624) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 01:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.6M=0s 2016-05-21 01:08:33 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.155474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.155819) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016030 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.207185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.207776) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 --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 b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 --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=3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 01:08:33,962 truncating revision to first 12 chars 2016-05-21 01:08:33,963 Setting DEBUG logging. 2016-05-21 01:08:33,963 attempt 1/10 2016-05-21 01:08:33,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7756d054ba8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 01:08:34,530 unpacking tar archive at: fx-team-b7756d054ba8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:34.083190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:34.083599) ========= script_repo_revision: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:34.084025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:34.084949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:34.095672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-21 01:08:34.096205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:34 INFO - MultiFileLogger online at 20160521 01:08:34 in /builds/slave/test 01:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:08:34 INFO - {'append_to_log': False, 01:08:34 INFO - 'base_work_dir': '/builds/slave/test', 01:08:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:08:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:34 INFO - 'config_files': ('talos/linux_config.py',), 01:08:34 INFO - 'default_actions': ('clobber', 01:08:34 INFO - 'read-buildbot-config', 01:08:34 INFO - 'download-and-extract', 01:08:34 INFO - 'populate-webroot', 01:08:34 INFO - 'create-virtualenv', 01:08:34 INFO - 'install', 01:08:34 INFO - 'run-tests'), 01:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:34 INFO - 'download_minidump_stackwalk': True, 01:08:34 INFO - 'download_symbols': 'ondemand', 01:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:34 INFO - 'installer_path': 'installer.exe', 01:08:34 INFO - 'log_level': 'info', 01:08:34 INFO - 'log_name': 'talos', 01:08:34 INFO - 'log_to_console': True, 01:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:34 INFO - 'opt_config_files': (), 01:08:34 INFO - 'pip_index': False, 01:08:34 INFO - 'sps_profile': False, 01:08:34 INFO - 'sps_profile_interval': 0, 01:08:34 INFO - 'suite': 'dromaeojs-e10s', 01:08:34 INFO - 'system_bits': '32', 01:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:34 INFO - 'title': 'talos-linux64-ix-059', 01:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:34 INFO - 'use_talos_json': True, 01:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:34 INFO - 'work_dir': 'build'} 01:08:34 INFO - ##### 01:08:34 INFO - ##### Running clobber step. 01:08:34 INFO - ##### 01:08:34 INFO - Running pre-action listener: _resource_record_pre_action 01:08:34 INFO - Running main action method: clobber 01:08:34 INFO - rmtree: /builds/slave/test/build 01:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:35 INFO - Running post-action listener: _resource_record_post_action 01:08:35 INFO - ##### 01:08:35 INFO - ##### Finished clobber step (success) 01:08:35 INFO - ##### 01:08:35 INFO - ##### 01:08:35 INFO - ##### Running read-buildbot-config step. 01:08:35 INFO - ##### 01:08:35 INFO - Running pre-action listener: _resource_record_pre_action 01:08:35 INFO - Running main action method: read_buildbot_config 01:08:35 INFO - Using buildbot properties: 01:08:35 INFO - { 01:08:35 INFO - "project": "", 01:08:35 INFO - "product": "firefox", 01:08:35 INFO - "script_repo_revision": "production", 01:08:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:08:35 INFO - "repository": "", 01:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:08:35 INFO - "buildid": "20160521003735", 01:08:35 INFO - "pgo_build": "False", 01:08:35 INFO - "basedir": "/builds/slave/test", 01:08:35 INFO - "buildnumber": 1319, 01:08:35 INFO - "slavename": "talos-linux64-ix-059", 01:08:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:08:35 INFO - "platform": "ubuntu64_hw", 01:08:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:08:35 INFO - "branch": "fx-team", 01:08:35 INFO - "repo_path": "integration/fx-team", 01:08:35 INFO - "revision": "b7756d054ba86fd2a6a9bd851dbd58b0b4542b42", 01:08:35 INFO - "stage_platform": "linux64", 01:08:35 INFO - "builduid": "c2181ba5fda8461ea3c84343455ce2ef", 01:08:35 INFO - "slavebuilddir": "test" 01:08:35 INFO - } 01:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:08:35 INFO - Running post-action listener: _resource_record_post_action 01:08:35 INFO - ##### 01:08:35 INFO - ##### Finished read-buildbot-config step (success) 01:08:35 INFO - ##### 01:08:35 INFO - ##### 01:08:35 INFO - ##### Running download-and-extract step. 01:08:35 INFO - ##### 01:08:35 INFO - Running pre-action listener: _resource_record_pre_action 01:08:35 INFO - Running main action method: download_and_extract 01:08:35 INFO - mkdir: /builds/slave/test/build/tests 01:08:35 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')]} 01:08:35 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:39 INFO - Downloaded 1361 bytes. 01:08:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:39 INFO - Using the following test package requirements: 01:08:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:08:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:08:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'jsshell-linux-x86_64.zip'], 01:08:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:08:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:08:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:08:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:08:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:08:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:08:39 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')]} 01:08:39 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:41 INFO - Downloaded 22814444 bytes. 01:08:41 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'] 01:08:41 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 01:08:42 INFO - Return code: 0 01:08:42 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 01:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:42 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:44 INFO - Downloaded 22814444 bytes. 01:08:44 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'] 01:08:44 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 01:08:45 INFO - Return code: 0 01:08: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')]} 01:08:45 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:46 INFO - Downloaded 10840359 bytes. 01:08:46 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'] 01:08:46 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 01:08:46 INFO - Return code: 0 01:08:46 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')]} 01:08:46 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:48 INFO - Downloaded 54815024 bytes. 01:08:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:48 INFO - mkdir: /builds/slave/test/properties 01:08:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:08:48 INFO - Writing to file /builds/slave/test/properties/build_url 01:08:48 INFO - Contents: 01:08:48 INFO - build_url:https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:49 INFO - Running post-action listener: _resource_record_post_action 01:08:49 INFO - Running post-action listener: set_extra_try_arguments 01:08:49 INFO - ##### 01:08:49 INFO - ##### Finished download-and-extract step (success) 01:08:49 INFO - ##### 01:08:49 INFO - ##### 01:08:49 INFO - ##### Running populate-webroot step. 01:08:49 INFO - ##### 01:08:49 INFO - Running pre-action listener: _resource_record_pre_action 01:08:49 INFO - Running main action method: populate_webroot 01:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:08:49 INFO - '--tppagecycles', 01:08:49 INFO - '7'], 01:08:49 INFO - 'tests': ['tsvgm']}}, 01:08:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:08:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:08:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:08:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['damp', 'tps']}, 01:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'tests': ['damp', 'tps']}, 01:08:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['dromaeo_dom']}, 01:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:08:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['a11yr', 01:08:49 INFO - 'ts_paint', 01:08:49 INFO - 'tpaint', 01:08:49 INFO - 'sessionrestore', 01:08:49 INFO - 'sessionrestore_no_auto_restore', 01:08:49 INFO - 'tabpaint']}, 01:08:49 INFO - 'other-e10s': {'tests': ['a11yr', 01:08:49 INFO - 'ts_paint', 01:08:49 INFO - 'tpaint', 01:08:49 INFO - 'sessionrestore', 01:08:49 INFO - 'sessionrestore_no_auto_restore', 01:08:49 INFO - 'tabpaint']}, 01:08:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:08:49 INFO - 'ts_paint', 01:08:49 INFO - 'tpaint', 01:08:49 INFO - 'sessionrestore', 01:08:49 INFO - 'sessionrestore_no_auto_restore', 01:08:49 INFO - 'tabpaint']}, 01:08:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:08:49 INFO - 'ts_paint', 01:08:49 INFO - 'tpaint', 01:08:49 INFO - 'sessionrestore', 01:08:49 INFO - 'sessionrestore_no_auto_restore', 01:08:49 INFO - 'tabpaint']}, 01:08:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['a11yr', 01:08:49 INFO - 'ts_paint', 01:08:49 INFO - 'tpaint', 01:08:49 INFO - 'sessionrestore', 01:08:49 INFO - 'sessionrestore_no_auto_restore', 01:08:49 INFO - 'tabpaint']}, 01:08:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['a11yr', 01:08:49 INFO - 'ts_paint', 01:08:49 INFO - 'tpaint', 01:08:49 INFO - 'sessionrestore', 01:08:49 INFO - 'sessionrestore_no_auto_restore', 01:08:49 INFO - 'tabpaint']}, 01:08:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['tsvgx', 01:08:49 INFO - 'tsvgr_opacity', 01:08:49 INFO - 'tart', 01:08:49 INFO - 'tscrollx', 01:08:49 INFO - 'cart']}, 01:08:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:08:49 INFO - 'tsvgr_opacity', 01:08:49 INFO - 'tart', 01:08:49 INFO - 'tscrollx', 01:08:49 INFO - 'cart']}, 01:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'talos_options': ['--disable-e10s'], 01:08:49 INFO - 'tests': ['tp5o']}, 01:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'tests': ['tp5o']}, 01:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'talos_options': ['--disable-e10s', 01:08:49 INFO - '--xperf_path', 01:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:49 INFO - 'tests': ['tp5n']}, 01:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:49 INFO - 'talos_options': ['--xperf_path', 01:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:49 INFO - 'tests': ['tp5n']}}, 01:08:49 INFO - 'talos.zip': {'path': '', 01:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:08:49 INFO - Running post-action listener: _resource_record_post_action 01:08:49 INFO - ##### 01:08:49 INFO - ##### Finished populate-webroot step (success) 01:08:49 INFO - ##### 01:08:49 INFO - ##### 01:08:49 INFO - ##### Running create-virtualenv step. 01:08:49 INFO - ##### 01:08:49 INFO - Running pre-action listener: _resource_record_pre_action 01:08:49 INFO - Running main action method: create_virtualenv 01:08:49 INFO - Creating virtualenv /builds/slave/test/build/venv 01:08:49 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 01:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:08:49 INFO - Using real prefix '/usr' 01:08:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:08:49 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:51 INFO - Installing pip.................done. 01:08:51 INFO - Return code: 0 01:08:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:51 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:08:51 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 01:08:51 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 01:08:51 INFO - Using env: {'DISPLAY': ':0', 01:08:51 INFO - 'HOME': '/home/cltbld', 01:08:51 INFO - 'LANG': 'en_US.UTF-8', 01:08:51 INFO - 'LANGUAGE': 'en_US:en', 01:08:51 INFO - 'LOGNAME': 'cltbld', 01:08:51 INFO - 'MAIL': '/var/mail/cltbld', 01:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:51 INFO - 'MOZ_NO_REMOTE': '1', 01:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:51 INFO - 'NO_EM_RESTART': '1', 01:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:51 INFO - 'PWD': '/builds/slave/test', 01:08:51 INFO - 'SHELL': '/bin/bash', 01:08:51 INFO - 'SHLVL': '1', 01:08:51 INFO - 'TERM': 'linux', 01:08:51 INFO - 'TMOUT': '86400', 01:08:51 INFO - 'USER': 'cltbld', 01:08:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:51 INFO - '_': '/tools/buildbot/bin/python'} 01:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:51 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 01:08:51 INFO - Cleaning up... 01:08:51 INFO - Return code: 0 01:08:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:51 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:08:51 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 01:08:51 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 01:08:51 INFO - Using env: {'DISPLAY': ':0', 01:08:51 INFO - 'HOME': '/home/cltbld', 01:08:51 INFO - 'LANG': 'en_US.UTF-8', 01:08:51 INFO - 'LANGUAGE': 'en_US:en', 01:08:51 INFO - 'LOGNAME': 'cltbld', 01:08:51 INFO - 'MAIL': '/var/mail/cltbld', 01:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:51 INFO - 'MOZ_NO_REMOTE': '1', 01:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:51 INFO - 'NO_EM_RESTART': '1', 01:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:51 INFO - 'PWD': '/builds/slave/test', 01:08:51 INFO - 'SHELL': '/bin/bash', 01:08:51 INFO - 'SHLVL': '1', 01:08:51 INFO - 'TERM': 'linux', 01:08:51 INFO - 'TMOUT': '86400', 01:08:51 INFO - 'USER': 'cltbld', 01:08:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:51 INFO - '_': '/tools/buildbot/bin/python'} 01:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:52 INFO - Downloading/unpacking psutil>=3.1.1 01:08:52 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 01:08:52 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 01:08:52 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 01:08:52 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 01:08:52 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 01:08:52 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 01:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:54 INFO - Installing collected packages: psutil 01:08:54 INFO - Running setup.py install for psutil 01:08:54 INFO - building 'psutil._psutil_linux' extension 01:08:54 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 01:08:54 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 01:08:54 INFO - building 'psutil._psutil_posix' extension 01:08:54 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 01:08:54 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 01:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:54 INFO - Successfully installed psutil 01:08:54 INFO - Cleaning up... 01:08:54 INFO - Return code: 0 01:08:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:54 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:08:54 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 01:08:54 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 01:08:54 INFO - Using env: {'DISPLAY': ':0', 01:08:54 INFO - 'HOME': '/home/cltbld', 01:08:54 INFO - 'LANG': 'en_US.UTF-8', 01:08:54 INFO - 'LANGUAGE': 'en_US:en', 01:08:54 INFO - 'LOGNAME': 'cltbld', 01:08:54 INFO - 'MAIL': '/var/mail/cltbld', 01:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:54 INFO - 'MOZ_NO_REMOTE': '1', 01:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:54 INFO - 'NO_EM_RESTART': '1', 01:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:54 INFO - 'PWD': '/builds/slave/test', 01:08:54 INFO - 'SHELL': '/bin/bash', 01:08:54 INFO - 'SHLVL': '1', 01:08:54 INFO - 'TERM': 'linux', 01:08:54 INFO - 'TMOUT': '86400', 01:08:54 INFO - 'USER': 'cltbld', 01:08:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:54 INFO - '_': '/tools/buildbot/bin/python'} 01:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:08:54 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 01:08:54 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 01:08:54 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 01:08:54 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 01:08:54 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 01:08:54 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 01:08:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:08:56 INFO - Installing collected packages: mozsystemmonitor 01:08:56 INFO - Running setup.py install for mozsystemmonitor 01:08:56 INFO - Successfully installed mozsystemmonitor 01:08:56 INFO - Cleaning up... 01:08:57 INFO - Return code: 0 01:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:57 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:08:57 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 01:08:57 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 01:08:57 INFO - Using env: {'DISPLAY': ':0', 01:08:57 INFO - 'HOME': '/home/cltbld', 01:08:57 INFO - 'LANG': 'en_US.UTF-8', 01:08:57 INFO - 'LANGUAGE': 'en_US:en', 01:08:57 INFO - 'LOGNAME': 'cltbld', 01:08:57 INFO - 'MAIL': '/var/mail/cltbld', 01:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:57 INFO - 'MOZ_NO_REMOTE': '1', 01:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:57 INFO - 'NO_EM_RESTART': '1', 01:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:57 INFO - 'PWD': '/builds/slave/test', 01:08:57 INFO - 'SHELL': '/bin/bash', 01:08:57 INFO - 'SHLVL': '1', 01:08:57 INFO - 'TERM': 'linux', 01:08:57 INFO - 'TMOUT': '86400', 01:08:57 INFO - 'USER': 'cltbld', 01:08:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:57 INFO - '_': '/tools/buildbot/bin/python'} 01:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:08:57 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 01:08:57 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 01:08:57 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 01:08:57 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 01:08:57 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 01:08:57 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 01:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:59 INFO - Downloading docopt-0.6.1.tar.gz 01:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:08:59 INFO - Running setup.py install for blobuploader 01:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:08:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:08:59 INFO - Running setup.py install for requests 01:09:00 INFO - Running setup.py install for docopt 01:09:00 INFO - Successfully installed blobuploader requests docopt 01:09:00 INFO - Cleaning up... 01:09:00 INFO - Return code: 0 01:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:00 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:09:00 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 01:09:00 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 01:09:00 INFO - Using env: {'DISPLAY': ':0', 01:09:00 INFO - 'HOME': '/home/cltbld', 01:09:00 INFO - 'LANG': 'en_US.UTF-8', 01:09:00 INFO - 'LANGUAGE': 'en_US:en', 01:09:00 INFO - 'LOGNAME': 'cltbld', 01:09:00 INFO - 'MAIL': '/var/mail/cltbld', 01:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:00 INFO - 'MOZ_NO_REMOTE': '1', 01:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:00 INFO - 'NO_EM_RESTART': '1', 01:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:00 INFO - 'PWD': '/builds/slave/test', 01:09:00 INFO - 'SHELL': '/bin/bash', 01:09:00 INFO - 'SHLVL': '1', 01:09:00 INFO - 'TERM': 'linux', 01:09:00 INFO - 'TMOUT': '86400', 01:09:00 INFO - 'USER': 'cltbld', 01:09:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:00 INFO - '_': '/tools/buildbot/bin/python'} 01:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:00 INFO - Running setup.py (path:/tmp/pip-r0RPJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:00 INFO - Running setup.py (path:/tmp/pip-HbDA2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:00 INFO - Running setup.py (path:/tmp/pip-iw7fxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:00 INFO - Running setup.py (path:/tmp/pip-U9ouyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:01 INFO - Running setup.py (path:/tmp/pip-mO_RK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:01 INFO - Running setup.py (path:/tmp/pip-BqHWom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:01 INFO - Running setup.py (path:/tmp/pip-31BN6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:01 INFO - Running setup.py (path:/tmp/pip-ERzLEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:01 INFO - Running setup.py (path:/tmp/pip-HajC91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:01 INFO - Running setup.py (path:/tmp/pip-ShjZst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:01 INFO - Running setup.py (path:/tmp/pip-l4hmlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:01 INFO - Running setup.py (path:/tmp/pip-VQfHkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:01 INFO - Running setup.py (path:/tmp/pip-PEyS9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:01 INFO - Running setup.py (path:/tmp/pip-EQTRye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:01 INFO - Running setup.py (path:/tmp/pip-ueh8Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:01 INFO - Running setup.py (path:/tmp/pip-CIENZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:01 INFO - Running setup.py (path:/tmp/pip-KneevJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:01 INFO - Running setup.py install for manifestparser 01:09:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Running setup.py install for mozcrash 01:09:02 INFO - Running setup.py install for mozdebug 01:09:02 INFO - Running setup.py install for mozdevice 01:09:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Running setup.py install for mozfile 01:09:02 INFO - Running setup.py install for mozhttpd 01:09:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Running setup.py install for mozinfo 01:09:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Running setup.py install for mozInstall 01:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Running setup.py install for mozleak 01:09:02 INFO - Running setup.py install for mozlog 01:09:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:02 INFO - Running setup.py install for moznetwork 01:09:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:03 INFO - Running setup.py install for mozprocess 01:09:03 INFO - Running setup.py install for mozprofile 01:09:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:03 INFO - Running setup.py install for mozrunner 01:09:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:03 INFO - Running setup.py install for mozscreenshot 01:09:03 INFO - Running setup.py install for moztest 01:09:03 INFO - Running setup.py install for mozversion 01:09:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:03 INFO - Cleaning up... 01:09:03 INFO - Return code: 0 01:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:03 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')]} 01:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:03 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')]} 01:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:03 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:09:03 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 01:09:03 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 01:09:03 INFO - Using env: {'DISPLAY': ':0', 01:09:03 INFO - 'HOME': '/home/cltbld', 01:09:03 INFO - 'LANG': 'en_US.UTF-8', 01:09:03 INFO - 'LANGUAGE': 'en_US:en', 01:09:03 INFO - 'LOGNAME': 'cltbld', 01:09:03 INFO - 'MAIL': '/var/mail/cltbld', 01:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:03 INFO - 'MOZ_NO_REMOTE': '1', 01:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:03 INFO - 'NO_EM_RESTART': '1', 01:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:03 INFO - 'PWD': '/builds/slave/test', 01:09:03 INFO - 'SHELL': '/bin/bash', 01:09:03 INFO - 'SHLVL': '1', 01:09:03 INFO - 'TERM': 'linux', 01:09:03 INFO - 'TMOUT': '86400', 01:09:03 INFO - 'USER': 'cltbld', 01:09:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:03 INFO - '_': '/tools/buildbot/bin/python'} 01:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:03 INFO - Running setup.py (path:/tmp/pip-aXSH4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:04 INFO - Running setup.py (path:/tmp/pip-3jOGu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:04 INFO - Running setup.py (path:/tmp/pip-lumfhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:04 INFO - Running setup.py (path:/tmp/pip-Z67uIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:04 INFO - Running setup.py (path:/tmp/pip-sNRRnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:04 INFO - Running setup.py (path:/tmp/pip-eEUoYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:04 INFO - Running setup.py (path:/tmp/pip-3mhdo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:04 INFO - Running setup.py (path:/tmp/pip-GDR4lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:04 INFO - Running setup.py (path:/tmp/pip-gz99oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:04 INFO - Running setup.py (path:/tmp/pip-zyproN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:04 INFO - Running setup.py (path:/tmp/pip-KDpyb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:04 INFO - Running setup.py (path:/tmp/pip-ztMZDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:04 INFO - Running setup.py (path:/tmp/pip-93er2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:04 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)) 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:04 INFO - Running setup.py (path:/tmp/pip-N8zTE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:05 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)) 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:05 INFO - Running setup.py (path:/tmp/pip-ZSMMIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:05 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)) 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:05 INFO - Running setup.py (path:/tmp/pip-T4bPQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:05 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)) 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:05 INFO - Running setup.py (path:/tmp/pip-gmY_kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:05 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)) 01:09:05 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)) 01:09:05 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)) 01:09:05 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)) 01:09:05 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)) 01:09:05 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)) 01:09:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:05 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 01:09:05 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 01:09:05 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 01:09:05 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 01:09:05 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 01:09:05 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 01:09:07 INFO - Downloading blessings-1.6.tar.gz 01:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:07 INFO - Installing collected packages: blessings 01:09:07 INFO - Running setup.py install for blessings 01:09:07 INFO - Successfully installed blessings 01:09:07 INFO - Cleaning up... 01:09:07 INFO - Return code: 0 01:09:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:07 INFO - Reading from file tmpfile_stdout 01:09:07 INFO - Current package versions: 01:09:07 INFO - argparse == 1.2.1 01:09:07 INFO - blessings == 1.6 01:09:07 INFO - blobuploader == 1.2.4 01:09:07 INFO - docopt == 0.6.1 01:09:07 INFO - manifestparser == 1.1 01:09:07 INFO - mozInstall == 1.12 01:09:07 INFO - mozcrash == 0.17 01:09:07 INFO - mozdebug == 0.1 01:09:07 INFO - mozdevice == 0.48 01:09:07 INFO - mozfile == 1.2 01:09:07 INFO - mozhttpd == 0.7 01:09:07 INFO - mozinfo == 0.9 01:09:07 INFO - mozleak == 0.1 01:09:07 INFO - mozlog == 3.2 01:09:07 INFO - moznetwork == 0.27 01:09:07 INFO - mozprocess == 0.22 01:09:07 INFO - mozprofile == 0.28 01:09:07 INFO - mozrunner == 6.11 01:09:07 INFO - mozscreenshot == 0.1 01:09:07 INFO - mozsystemmonitor == 0.3 01:09:07 INFO - moztest == 0.7 01:09:07 INFO - mozversion == 1.4 01:09:07 INFO - psutil == 3.1.1 01:09:07 INFO - requests == 1.2.3 01:09:07 INFO - wsgiref == 0.1.2 01:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09: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')]} 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09: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')]} 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:07 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 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:09:07 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 01:09:07 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 01:09:07 INFO - Using env: {'DISPLAY': ':0', 01:09:07 INFO - 'HOME': '/home/cltbld', 01:09:07 INFO - 'LANG': 'en_US.UTF-8', 01:09:07 INFO - 'LANGUAGE': 'en_US:en', 01:09:07 INFO - 'LOGNAME': 'cltbld', 01:09:07 INFO - 'MAIL': '/var/mail/cltbld', 01:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:07 INFO - 'MOZ_NO_REMOTE': '1', 01:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:07 INFO - 'NO_EM_RESTART': '1', 01:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:07 INFO - 'PWD': '/builds/slave/test', 01:09:07 INFO - 'SHELL': '/bin/bash', 01:09:07 INFO - 'SHLVL': '1', 01:09:07 INFO - 'TERM': 'linux', 01:09:07 INFO - 'TMOUT': '86400', 01:09:07 INFO - 'USER': 'cltbld', 01:09:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:07 INFO - '_': '/tools/buildbot/bin/python'} 01:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 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)) 01:09:07 INFO - Cleaning up... 01:09:07 INFO - Return code: 0 01:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09: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')]} 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09: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')]} 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:09: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', 'jsonschema'] in /builds/slave/test/build 01:09: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 jsonschema 01:09:07 INFO - Using env: {'DISPLAY': ':0', 01:09:07 INFO - 'HOME': '/home/cltbld', 01:09:07 INFO - 'LANG': 'en_US.UTF-8', 01:09:07 INFO - 'LANGUAGE': 'en_US:en', 01:09:07 INFO - 'LOGNAME': 'cltbld', 01:09:07 INFO - 'MAIL': '/var/mail/cltbld', 01:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:07 INFO - 'MOZ_NO_REMOTE': '1', 01:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:07 INFO - 'NO_EM_RESTART': '1', 01:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:07 INFO - 'PWD': '/builds/slave/test', 01:09:07 INFO - 'SHELL': '/bin/bash', 01:09:07 INFO - 'SHLVL': '1', 01:09:07 INFO - 'TERM': 'linux', 01:09:07 INFO - 'TMOUT': '86400', 01:09:07 INFO - 'USER': 'cltbld', 01:09:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:07 INFO - '_': '/tools/buildbot/bin/python'} 01:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:07 INFO - Downloading/unpacking jsonschema 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:10 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:10 INFO - warning: no files found matching '*.txt' 01:09:10 INFO - no previously-included directories found matching 'build' 01:09:10 INFO - no previously-included directories found matching 'dist' 01:09:10 INFO - no previously-included directories found matching '.git*' 01:09:10 INFO - Installing collected packages: jsonschema, functools32 01:09:10 INFO - Running setup.py install for functools32 01:09:10 INFO - warning: no files found matching '*.txt' 01:09:10 INFO - no previously-included directories found matching 'build' 01:09:10 INFO - no previously-included directories found matching 'dist' 01:09:10 INFO - no previously-included directories found matching '.git*' 01:09:10 INFO - Successfully installed jsonschema functools32 01:09:10 INFO - Cleaning up... 01:09:10 INFO - Return code: 0 01:09:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:09: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')]} 01:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09: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')]} 01:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75997bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', '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 01:09: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', 'flake8'] in /builds/slave/test/build 01:09: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 flake8 01:09:10 INFO - Using env: {'DISPLAY': ':0', 01:09:10 INFO - 'HOME': '/home/cltbld', 01:09:10 INFO - 'LANG': 'en_US.UTF-8', 01:09:10 INFO - 'LANGUAGE': 'en_US:en', 01:09:10 INFO - 'LOGNAME': 'cltbld', 01:09:10 INFO - 'MAIL': '/var/mail/cltbld', 01:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:10 INFO - 'MOZ_NO_REMOTE': '1', 01:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:10 INFO - 'NO_EM_RESTART': '1', 01:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:10 INFO - 'PWD': '/builds/slave/test', 01:09:10 INFO - 'SHELL': '/bin/bash', 01:09:10 INFO - 'SHLVL': '1', 01:09:10 INFO - 'TERM': 'linux', 01:09:10 INFO - 'TMOUT': '86400', 01:09:10 INFO - 'USER': 'cltbld', 01:09:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:10 INFO - '_': '/tools/buildbot/bin/python'} 01:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:10 INFO - Downloading/unpacking flake8 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:09:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:09:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:13 INFO - no previously-included directories found matching 'docs/_build' 01:09:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:09:13 INFO - Running setup.py install for pep8 01:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:13 INFO - no previously-included directories found matching 'docs/_build' 01:09:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:09:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:09:13 INFO - Cleaning up... 01:09:13 INFO - Return code: 0 01:09:13 INFO - Running post-action listener: _resource_record_post_action 01:09:13 INFO - Running post-action listener: _start_resource_monitoring 01:09:13 INFO - Starting resource monitoring. 01:09:13 INFO - ##### 01:09:13 INFO - ##### Finished create-virtualenv step (success) 01:09:13 INFO - ##### 01:09:13 INFO - ##### 01:09:13 INFO - ##### Running install step. 01:09:13 INFO - ##### 01:09:13 INFO - Running pre-action listener: _resource_record_pre_action 01:09:13 INFO - Running main action method: install 01:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:13 INFO - Reading from file tmpfile_stdout 01:09:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:13 INFO - Reading from file tmpfile_stdout 01:09:13 INFO - Output received: 01:09:13 INFO - Usage: mozinstall [options] installer 01:09:13 INFO - Options: 01:09:13 INFO - -h, --help show this help message and exit 01:09:13 INFO - -d DEST, --destination=DEST 01:09:13 INFO - Directory to install application into. [default: 01:09:13 INFO - "/builds/slave/test"] 01:09:13 INFO - --app=APP Application being installed. [default: firefox] 01:09:13 INFO - mkdir: /builds/slave/test/build/application 01:09:13 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'] 01:09:13 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 01:09:29 INFO - Reading from file tmpfile_stdout 01:09:29 INFO - Output received: 01:09:29 INFO - /builds/slave/test/build/application/firefox/firefox 01:09:29 INFO - Running post-action listener: _resource_record_post_action 01:09:29 INFO - ##### 01:09:29 INFO - ##### Finished install step (success) 01:09:29 INFO - ##### 01:09:29 INFO - ##### 01:09:29 INFO - ##### Running run-tests step. 01:09:29 INFO - ##### 01:09:29 INFO - Running pre-action listener: _resource_record_pre_action 01:09:29 INFO - Running main action method: run_tests 01:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:09:29 INFO - Python 2.7.3 01:09:29 INFO - Return code: 0 01:09:29 INFO - grabbing minidump binary from tooltool 01:09:29 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')]} 01:09:29 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 0x174d9c0>, '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 0x174e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:09:29 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 01:09:29 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 01:09:29 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 01:09:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:09:29 INFO - Return code: 0 01:09:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:09:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:09:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:09:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:09:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:09:30 INFO - Return code: 0 01:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:09:30 INFO - Using env: {'DISPLAY': ':0', 01:09:30 INFO - 'HOME': '/home/cltbld', 01:09:30 INFO - 'LANG': 'en_US.UTF-8', 01:09:30 INFO - 'LANGUAGE': 'en_US:en', 01:09:30 INFO - 'LOGNAME': 'cltbld', 01:09:30 INFO - 'MAIL': '/var/mail/cltbld', 01:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:30 INFO - 'MOZ_NO_REMOTE': '1', 01:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:30 INFO - 'NO_EM_RESTART': '1', 01:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:30 INFO - 'PWD': '/builds/slave/test', 01:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:09:30 INFO - 'SHELL': '/bin/bash', 01:09:30 INFO - 'SHLVL': '1', 01:09:30 INFO - 'TERM': 'linux', 01:09:30 INFO - 'TMOUT': '86400', 01:09:30 INFO - 'USER': 'cltbld', 01:09:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312', 01:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:30 INFO - '_': '/tools/buildbot/bin/python'} 01:09:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:09:30 INFO - mozversion application_buildid: 20160521003735 01:09:30 INFO - mozversion application_changeset: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 01:09:30 INFO - mozversion application_display_name: Nightly 01:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:09:30 INFO - mozversion application_name: Firefox 01:09:30 INFO - mozversion application_remotingname: firefox 01:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:09:30 INFO - mozversion application_vendor: Mozilla 01:09:30 INFO - mozversion application_version: 49.0a1 01:09:30 INFO - mozversion platform_buildid: 20160521003735 01:09:30 INFO - mozversion platform_changeset: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 01:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:09:30 INFO - mozversion platform_version: 49.0a1 01:09:30 INFO - using testdate: 1463818170 01:09:30 INFO - actual date: 1463818170 01:09:30 INFO - starting webserver on 'localhost:45148' 01:09:30 INFO - SUITE-START | Running 2 tests 01:09:30 INFO - TEST-START | dromaeo_css 01:09:30 INFO - operating with platform_type : linux_ 01:09:30 INFO - Initialising browser for dromaeo_css test... 01:09:30 INFO - TEST-INFO | started process 16469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFUUFYt/profile http://localhost:45148/getInfo.html) 01:09:34 INFO - PROCESS | 16469 | 01:09:34 INFO - PROCESS | 16469 | (process:16536): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:09:35 INFO - PROCESS | 16469 | __metrics Screen width/height:1600/1200 01:09:35 INFO - PROCESS | 16469 | colorDepth:24 01:09:35 INFO - PROCESS | 16469 | Browser inner width/height: 1024/697 01:09:35 INFO - PROCESS | 16469 | __metrics 01:09:36 ERROR - PROCESS | 16469 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:09:37 INFO - TEST-INFO | 16469: exit 0 01:09:37 INFO - Browser initialized. 01:09:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:09:37 INFO - TEST-INFO | started process 16587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFUUFYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:39 INFO - PROCESS | 16587 | 01:09:39 INFO - PROCESS | 16587 | (process:16649): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:09:49 INFO - PROCESS | 16587 | RSS: Main: 165376000 01:09:49 INFO - PROCESS | 16587 | 01:10:38 INFO - PROCESS | 16587 | 1463818238621 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] 01:12:50 INFO - PROCESS | 16587 | Cycle 1(1): loaded http://localhost:45148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45148/tests/dromaeo/cssquery-ext.html) 01:12:51 INFO - PROCESS | 16587 | RSS: Main: 168103936 01:12:51 INFO - PROCESS | 16587 | 01:15:54 INFO - PROCESS | 16587 | Cycle 1(1): loaded http://localhost:45148/tests/dromaeo/cssquery-ext.html (next: http://localhost:45148/tests/dromaeo/cssquery-jquery.html) 01:15:54 INFO - PROCESS | 16587 | RSS: Main: 167391232 01:15:54 INFO - PROCESS | 16587 | 01:18:56 INFO - PROCESS | 16587 | Cycle 1(1): loaded http://localhost:45148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45148/tests/dromaeo/cssquery-mootools.html) 01:18:57 INFO - PROCESS | 16587 | RSS: Main: 168169472 01:18:57 INFO - PROCESS | 16587 | 01:21:59 INFO - PROCESS | 16587 | Cycle 1(1): loaded http://localhost:45148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45148/tests/dromaeo/cssquery-prototype.html) 01:21:59 INFO - PROCESS | 16587 | RSS: Main: 166039552 01:21:59 INFO - PROCESS | 16587 | 01:25:02 INFO - PROCESS | 16587 | Cycle 1(1): loaded http://localhost:45148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45148/tests/dromaeo/cssquery-yui.html) 01:25:03 INFO - PROCESS | 16587 | RSS: Main: 166797312 01:25:03 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | Cycle 1(1): loaded http://localhost:45148/tests/dromaeo/cssquery-yui.html (next: http://localhost:45148/tests/dromaeo/cssquery-dojo.html) 01:28:05 INFO - PROCESS | 16587 | RSS: Main: 168521728 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | __start_tp_report 01:28:05 INFO - PROCESS | 16587 | _x_x_mozilla_page_load 01:28:05 INFO - PROCESS | 16587 | _x_x_mozilla_page_load_details 01:28:05 INFO - PROCESS | 16587 | |i|pagename|runs| 01:28:05 INFO - PROCESS | 16587 | |0;dojo.html;2637.7362263773625;2677.6519052523176;2684.6107314439405;2709.241412404525;2709.471653027659;4700.858974230774;4746.691465054773;4848;4851.878703032422;4874.317595536619;4660.766961651921;4675.345451636765;4695.812167513304;4768.380110585619;4782.521747825216;4356.411884395598;4361.258586040372;4369.890752731176;4412.161689279043;4519.887002824923;4353.978230108845;4395.9560404396025;4456.79944402501;4458.2866741321395;4511.390962220091;4340.197063543223;4432.490263619693;4456.866294011153;4476.6418686505;4479.529649386816;4426.402435671175;4433.202023635744;4444.088961762864;4478.7984540695425;4480.731156130642;4396.20868243716;4397.252467080604;4415.867523974286;4443.955560444387;4465;4575.633949284049;4657.091867085919;4681.578657920803;4721.5750582447745;4723.031778485402;5110.412302585176;5138.768755406016;5150.227465880111;5165.018646457199;5227.503387178212;5208.0365132450615;5214.739263036871;5222.895542089137;5229.816956406507;5233.738313084331;4714.080754252922;4739;4754.381930349033;4782.234842425195;4797.424309082932;5238.947610523922;5246.868828279247;5255.842324730264;5258.842234732964;5291.656042357235;4921.532454416896;5040.697558146523;5041.621878359138;5043.420006699203;5062.594992400599;5091.261767043758;5091.490850914953;5100.56645185156;5118.155504341742;5137.794488220429;5072.188449848007;5082.161443361878;5084.084864724385;5084.745762711924;5124.077666020077;4973.751312434436;5031.295618613397;5053.216751403538;5067.366579177603;5072.985402919431;4156.896077598024;4220.704550681423;4256.2764330063965;4302.204092242945;4356.6732495063;3703.3148867459604;3739.569949455793;3746.4005759078964;3752.7748335099436;3848.3073046851837;4328.675349348811;4428.977855110704;4429.15845989261;4454.064646424287;4486.461624605068;5020.623453240948;5045.091883461012;5047.722375269322;5113.488651134931;5113.821016264413;4439.1121775645;4451.777411129496;4460.643148548108;4468.285074388083;4485.753283569435;4471.396361491157;4534.614557762561;4555.840545580889;4591.609713174351;4611.838585649553;4771.546703063273;4818.277258411266;4864.051509955595;4869.488703686062;4895.143349913679;5143.048536020848;5149.304843846033;5172.663776854492;5177.249298851721;5223.895522089613;4755.977464845075;4840.491748366371;4863.805447782049;4869.732164730974;4918;5095.694258344512;5101.744912754421;5120.4111527174855;5129.384473863161;5151.2788209649925;5172.043172013189;5190.325257716473;5196.298499702491;5198.610104242272;5200.349956255468;4836.322914792002;4952.1581331173065;4955.132851751001;5010.448850626501;5037.294778730908;5005.949940500548;5017.648764586444;5024.598032157492;5026.924596130988;5104.183330667075;4920.704757714549;4927.334809800631;4953.975230123826;4965.553100220997;5014.222795466709;4922.212446008622;4941.901161976669;4998.6750861193905;5019.297298378303;5045.722485263345;4823.421189457287;4900.681455705368;4902.754862256944;4905.0189962007025;4910.7544622768 01:28:05 INFO - PROCESS | 16587 | |1;ext.html;553.5177135097928;576.2192229528988;584.5206930317141;591.7958304384987;609.9052201298668;35004.299914001705;38597;38945.22109557814;39027.414588781154;39232.80383598081;38697.41953870694;39871;39965.40051899224;40092.99767505814;40126;7699.576523291216;7724.5751483668655;7743.148253692089;7785.260400261995;7821.843563128734;7647.923520764804;7745.3416459601;7750.5349679019155;7755;7775.261350171724;7749.496282741632;7755.224477552256;7771.494852834576;7772.33935115513;7806.414518911076;7721.691132354699;7735.303822655932;7762.107357653857;7766.184550622188;7778.222177782233;7765.184655611192;7806.6096695165015;7809.960950195213;7843.411744119214;7857.489263197874;29278.853605731834;36464;36918.630813692056;36921;36951.445728314095;2976.4939960206816;3085.4754691702465;3107.6115485564305;3116.703913128249;3477.23500829817;26917.32706682329;27316.59025114625;27365;27503.724962750315;27901.860490697618;3305.2563173286057;3312.1554003729134;3377.223238655123;3473.0969947813496;3482.6343233960324;221885;223322;223762;223967;224103.87948060318;31608.683913161032;31936.520952185736;31966.360672786413;31967.52048719271;31975.52036719451;32704.345913081605;34527.30945381078;34773.13067173341;34905.47641785375;34959.65040349615;12517.123801334;12533.122681412397;12545.31000794965;12648.936755316348;12723.363831808372;9312.34813563044;9349.111834375723;9499.715008549754;9499.857502137473;9506.239500839916;18239.544011399823;18277.177527011052;18287.54281142982;18340.633187336178;18344.816551834578;6549.410553050248;6820.420264277493;6956.339147780953;7017.89473157903;7097.148342198969;858.4763294390417;920.3603495570514;929.1637526226315;940.022376728195;1043.7912417516527;27073.864630676722;28506.572401413996;28860.711392886224;28893.855530722212;29043.12870613885;932.8246409524048;940.5532372123187;969.1374676537887;1018.2057994764095;1074.167520171873;14843.40626374933;15141.318640661197;15291.311890964933;15387.769183462256;15506.457273995582;386721;387278;391289;391903;392610;48836.267455988185;48937;49139.262911056365;49225.75387123113;49548.25677614839;1211.357980270458;1223.1621339382552;1234.8888600025862;1236.097648716442;1240.8324876141605;26616.33459163459;27748.44503109886;27834.304142396602;28050.158495245174;28265.858670707337;41161.38257926193;41602.37596436116;42035.7898210507;42217.36673949955;42324.78837605792;328267;333532;333794;334116;335014;24634.260972170865;25076.373090672878;25089.74910250947;25110.49779004373;25173.118940836983;42158.78920605377;42187;42491.787541063335;42900;43199;36319.09202269858;36543.45184822177;36816.63183368132;36848.81575592105;37396.2520749578;36084;36649.81675091608;36811.63188368082;36987.81506092452;37085;36030.8198459006;36297.45553816748;36486.45270320894;36851;37002.814985924895;31054.534181986837;32783.50824737678;33293.33413331768;33374.833125834215;33599.664003359656;24979.250622481355;25686;25716.61425078588;26023.219303420927;26071.608925866505 01:28:05 INFO - PROCESS | 16587 | |2;jquery.html;365.83720244491195;366.3533862732277;371.0760207084359;378.28881702399485;380.61177598849156;15171.468998585051;16072.276747546359;16753.916230418847;16767.580810479714;16817;14268.429262829475;15899.28453219605;16328.346866125341;16354.83645163548;16495.34018639256;4985.052839960405;5136.563392111675;5194.065068287707;5200.973995130019;5211;3663.8717644882436;5090.261912022755;5691.08942569189;5995.6702381369005;6021.849453763647;6013.1581578579035;6019.969900150493;6028.246469191351;6036.215292012054;6046.062860256668;4918.237673160648;5236.554892834095;5241.9213711794355;5338;5342.866428339284;5066.214736715815;5105.310783044316;5156.432792392834;5171.689698618095;5198.558122559587;11830.290182589073;12204.694882627917;12215.694607634792;12429.31638759868;12773.936130319382;1858.7955324914249;1961.8136277053657;2060.402483279847;2273.886305684709;2457.8939477235317;8902.287816974627;9188.494632795193;9216.078392160798;11354.602588909349;11604.187706860523;1713.0578181999974;1721.432778495451;1774.7426623139702;1783.9643207135784;1790.8209179082119;67133;67718.32281677169;67844;67894.3210567893;69149;9799.657012004545;9957.153641940517;10079;10264.948675256725;10426.009529094725;13912.721745565032;14003.299835008209;14035.43858245679;14041.1575305482;14042.297885105703;6481.935180648227;6512.544121911421;6578.868422631521;6592.274849766522;6671.132752742113;5899.115132730125;5934.139549765347;5950.375210602824;5975.880482390327;5978.103284507271;4252.55348188442;4279.957200428018;4338.848140315074;4442.666799990014;4485.910281794346;1661.609521762385;1746.9039202843712;1841.1346667066457;1853.1290293562004;1875.5311172206948;872.9039805621377;875.4484674654926;922.6447817590276;945.546137853834;968.7481254873784;16608.6678266434;16677.08276044805;16872.57818554546;16912.32350705958;17538.123093845512;841.381584535366;848.9320854331762;870.6734974384606;923.9769005774909;927.874736910522;9289.581968811419;9297.395669281475;9307.348485606079;9313.674021409219;9494.050594940589;372083;375605;377097;381039;381254;71461;71662.2833771666;72989;73208.26791732015;73658.26341736621;877.6226222724163;883.6208993859449;898.7438580004667;899.6626265150569;906.4108329585822;14913.850861491681;15036.699266014837;15065.397384104514;15270.770938436155;15318.463853765064;30681.693183067884;31248.21879453032;32307.51538726874;32381.838090809397;32425.189370265933;44941.32588011117;45139.54860451353;45258;45576.772116139204;46055.309170361805;6028.728707208274;6476.31998640136;7489.988851505195;7655.2344765523;7818.921810782047;9302.813943720952;11201;11266.436678166223;11293.153013523854;11389.43052847371;9659.178969787647;9678.419294842332;9956;10073.445960472245;10186.898131018892;8276.710315138942;10167.542460589144;10681.679549613524;10711.08955738771;10769.299995500267;9713.07725766051;9972.50137493108;9990;10199.184065274909;10238.744031399274;7584.62076896164;7624.656890439833;7719;7793.961030194812;7942.324902383131;8056.274935255855;9516.571754271214;9905.603775848886;10155.89844101579;10462 01:28:05 INFO - PROCESS | 16587 | |3;mootools.html;1405.2973513243378;1418.9432422703092;1524.1617110589173;1647.3642172523955;1701.064414571985;6861.451083913287;6995.615241161734;7589.8861517077285;8073.8385232295395;8113.594320283984;7331.706731730737;7464.477486575942;7540.057492813398;7578.621068946558;7626.923730762691;2173.3805865328386;2215.667649852527;2223.844330896838;2224.421650370899;2235.3405745305095;2162.6323525000707;2166.6208413527647;2177.6298029335053;2179.8474106812528;2190.288156349185;2194.648856183011;2196.7803219677985;2205.40454077399;2209.823214142865;2212.9446763830874;2189.551142015891;2190.8466407351493;2192.0683709423433;2193.5941850757663;2203.8787866667326;2136.9465763355884;2141.068635143702;2156;2161.3515945216373;2166.9241576544905;7791.142974272825;7800.570968596781;7856.057273127204;7859.41054420915;7875.409344299201;4264.33902745075;4343.1747967886;4343.500497442803;4348.282533381988;4367.54140815213;2804.803663743539;2910.621619189492;2911.0248066897616;2914.3151359430517;2969.7030296970347;890.7149712092133;908.1009800297724;921.9354645174841;954.379653225409;963.1476143612883;9937.304388692794;10289.845652315222;10339.948300258526;10659.573617055308;10668.573257069707;4198.328267477189;4206.47419072616;4285.207236661227;4305.182015417061;4323.286657701507;9373.62505499786;9390.295727820441;9392.154706076486;9405.106514881076;9410.294227932933;4510.255807791743;4527.637788976874;4540.77296135192;4560.17916774977;4566.178087944202;3495.9825200874343;3896.9220615588097;4027.093903871664;4052.0882801370044;4054.4729185205733;3647.562292524914;3647.94528082079;3720.4233343831747;3745.9438108428394;3752.4746535485056;1157.3750174905456;1168.807146820765;1172.384498138484;1173.3898372846243;1173.6537721372215;673.2224280955504;776.2780614029007;787.271773609409;810.3476701255546;823.1357075071271;5005.549500544968;5264.289320941701;5328.387235467971;5397.055515284809;5529.0324193266015;407.08812260536183;428.421946259697;428.7822583861847;431.5878336188932;434.3506457845541;3502.667246611568;3510.315488479722;3517.9120521986642;3561.252137051248;3567.4292113261754;9164.633414663338;9640.228781697588;9695.757606059764;9701.51492425376;9736;9392.483413412192;9465.52672366379;9477.147056764787;9482.857757133648;9584.856227156599;7224.783256502208;7328.560286382834;7344.449166312548;7356.816079598053;7401.370883474965;5066.544011039025;5258.553022993088;5269.525742683177;5270.4202537721585;5359.088954877758;8943.642254309754;8990.145936136056;9007.909920900707;9052.683156089506;9088.727338179866;8374.958125209336;8718.779370888207;8730.083341249077;8957.507337096522;8976.640934362813;5772.538196944319;6530.608163510205;6580.276169621434;6734.595924244561;6785.525013249223;7669.386449083949;7674.808129796576;7685.961570192337;7696.268854458817;7699.807504812425;6751.493637977073;6991;7043.084399028094;7061.646917653994;7166.211716711262;6550.377714117151;6560.40956313934;6606.966965165336;6762.357576030269;6856.965715171592;6522;6557.573757705924;6618.867622647616;6677.933220667731;6682.599044057372;4561.8631441055495;4612.723236605814;4623.953760462352;4637.976810115928;4707.223308154116;4792.568668819823;4824.807007719652;4839.467658557485;4857.174280372275;4972 01:28:05 INFO - PROCESS | 16587 | |4;prototype.html;285.16873314288847;287.0355605166641;290.870562599643;298;301.81589230569347;4928.926066109007;4983.875403114924;4991.925121123181;5006.574441172495;5031.144705400082;4900.632452566054;4929.186684197103;4950.292149208526;4957.975210123945;4959.925601115986;3696.9094117235413;3776.6978641708733;3882.514685664292;3898.5321761388673;3901.1807520420602;3900.6879449644102;3900.960990390088;3917.118648304123;3931.9213615727667;3937.2716047531153;3891.4941057662604;3907.2771537265553;3914.7063970202207;3923.8038098095126;3928.7249892507534;3801;3876.592957739425;3893.785841778701;3911.3741801311794;3914.1388894443176;3415.4725503127506;3421.81180035098;3438.7249020078334;3442.277121804424;3451.154467155563;4753.809847606126;4756.8583539950505;4766.38037055184;4784.186688262969;4816.277558366238;4312.719673221262;4434.977825110886;4437.602155321064;4449;4460.171329754785;5089.440161582223;5157.277981082651;5180.352455943007;5190.480951904779;5201.557867581222;3741.1956429367547;3746.550413950343;3750.774953502799;3751.8744376686886;3759.7180211483974;5451.236826844205;5453.809116680897;5460.481254280877;5464.12573988164;5492.203630473599;3674.5590529136675;3800.277947190025;3824.694024478035;3832.1414114154613;3832.616738326145;3870.9612903871166;3900.7269491135917;3912.68698504119;3915.471411359487;3920.784356860343;4411.735295882258;4451;4454.354118652842;4469.687121901501;4470.530594287618;5070.7464626768515;5100.642954993189;5210.739463026909;5221.973890130525;5256.26412302278;1320.7490576790378;1343.2142196814777;1353.966150846217;1356.2947267420886;1359.136948038003;850.7362717557453;878.0999475537625;878.4026861734083;891.2914233184633;897.0446474504762;4539.296409056601;4607.170709272296;4614.353990441341;4621.70592234175;4626.629869610423;5371.382291036581;5374.677519348852;5386.946130538723;5398.973005134949;5403.297571315782;4462.085272519191;4573.810809189635;4577.244754615518;4614.953850461452;4625.283081122431;2834.0222623194963;2874.7843911706705;2890.508613535704;2896.5365541513256;2912.4466351393166;5072.137736584789;5091.898162036812;5102.209157580581;5113.974430127825;5130.692158470503;5382.946170538323;5476.945230547723;5516.613837031369;5556.944430555724;5564.10974244119;5102.8214012510125;5146.716930568779;5159.406668233126;5167.715775632376;5175.922361164586;5355.812546560852;5397.9460205397445;5433.809816656398;5439.211314359475;5447.400785913625;4986.955348307177;5247.501487358695;5259.368875734936;5274.920876186783;5280.551153151871;5015.799368025238;5049.8737531562;5080.110980578458;5093.898122037613;5126.615503837153;3860.6332398422105;3872.6832876822014;3882.3011857865854;3887.7278590498395;3901.960980390273;5176.145935920682;5256.264123022856;5311.336082989626;5356.196570514298;5382.219578161066;5228.921566176587;5243.528082472443;5253.422123566328;5272.393674727456;5276.39321478035;5233.293505376878;5245.423003469692;5267.73661316925;5270.4202537721585;5278.762455689426;4858.684185527929;5094.286799848099;5102.591792656653;5104.234364845154;5118.462561431145;4983.825566105169;5066;5225.817096401608;5230.895382092413;5246.685198888079;5070.797168113234;5086.872828179177;5093.115547247542;5129.692218466904;5132.255822905732 01:28:05 INFO - PROCESS | 16587 | |5;yui.html;620.8199622109588;742.8031571633517;743.8103283662668;747.2900744292916;752.9435292353071;10807.4055926924;11216.551337946472;11757.647270581874;11769;13145.079844410895;13011.674708132301;13598.388072536734;13603.931980340109;13630.863691363083;13709.725805483884;798.5448294472168;809.1059379385782;809.3767798794925;809.5628360685253;816.9264766171043;802.83541873916;808.2362167751477;808.8099296665279;809.7773112394079;812.4110020235312;856.9357298202628;861.6639510590875;863.5380071661631;863.7495126413364;864.3646919514152;839.689314953465;847.9533625650587;851.6806197675902;855.6149732620314;856.7772379181396;609.5824360313155;616.8242051015484;618.4681174190193;622.5890911998105;626.9623822570614;12388.442520086617;12420.503179872794;12539.373031348487;12542.184757990794;12561.874381256162;12086.697832554168;12737.108402411835;12805.679858003532;12920.483180672762;13162.315008994896;10073.345232559934;10086.344387614781;10191.59233630654;10193.74515637115;10217.386956782542;3286.556314897482;3331.1505566080737;3341.682540158681;3349.7990120592845;3389.9830500847584;46456.3031554527;46533.534664653256;46536.5346346539;47595;47689;9932.205423566098;10055.597776088875;10066.496675166212;10208.183345332356;10217.23370747182;18192.363267285848;18365.90817045906;18368.265269389074;18397.81602183961;18425.355112570996;6330.588511746721;6337.904931426032;6407.903881441782;6515.218173819172;6553.279139294674;3587.461880717913;3696.5748938872375;3748.175401411685;3748.681362084199;3805.657490825839;2770.127409865886;2859.056511351249;2863.828170309788;2866.140157952606;2866.441043996442;472.19962164131465;475.372508289062;479.37681014680777;480.82449905784136;481.8361757002566;483.33541380601673;616.1312549305458;632.3929028132952;655.3610230025687;657.1883723601348;7745.302922736981;7864.883548597293;7920.485168464146;7989.7203597873795;8145.144759800254;572.5190839694676;599.0923750517969;607.2318517075903;612.7212118486167;622.6762083716442;3668.192997540537;3843.404272337792;3848.191879705237;3860.8069596520063;3981.761094334291;54317.1852422214;54560.72719636456;55138.17292740612;55464.445355545926;56570.15144772832;49140.78023744595;49538.50461495339;49956.500434995185;50476;50984.49015509872;46444.30333544999;46553.5344646556;46866.29700554494;47072;47644.52355476401;7286.489945703962;7487.438442116972;7494;7502.662380192795;7543.585102819397;31243.218919527193;31825.840870796423;31888;32175.51736723998;32248.677513225506;37059.81470092632;37548;39151.2169756609;40652.59347406488;40804.38793418042;10653.104657610671;10822.621208257673;10903.945480272549;11035.944820276169;11117.388543629855;11712.472938717949;11872.82190767122;12081.275123492618;12239;12444.377781110727;11025.61410350634;11096.278741881752;11111.72220694489;11291.661250162508;11426.143039271921;11001.779964400506;11136.109111270916;11203.215774896005;11219.495122719334;11221.775564488502;10898.836517452402;11067.280626759235;11232.606858759904;11466.77066458683;11655.65033048976;9355.5789989452;9577.534667956692;9610.423374597547;9647.9035209647;9851.950740246253;9703.175230105238;9755.658551950648;9843.85234221473;9885.159761420073;9927.354721943051 01:28:05 INFO - PROCESS | 16587 | __end_tp_report 01:28:05 INFO - PROCESS | 16587 | __start_cc_report 01:28:05 INFO - PROCESS | 16587 | _x_x_mozilla_cycle_collect,383 01:28:05 INFO - PROCESS | 16587 | __end_cc_report 01:28:05 INFO - PROCESS | 16587 | __startTimestamp1463819285673__endTimestamp 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | ------- Summary: start ------- 01:28:05 INFO - PROCESS | 16587 | Number of tests: 6 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | [#0] dojo.html Cycles:165 Average:4733.66 Median:4869.49 stddev:500.51 (10.3%) stddev-sans-first:474.27 01:28:05 INFO - PROCESS | 16587 | Values: 2637.7 2677.7 2684.6 2709.2 2709.5 4700.9 4746.7 4848.0 4851.9 4874.3 4660.8 4675.3 4695.8 4768.4 4782.5 4356.4 4361.3 4369.9 4412.2 4519.9 4354.0 4396.0 4456.8 4458.3 4511.4 4340.2 4432.5 4456.9 4476.6 4479.5 4426.4 4433.2 4444.1 4478.8 4480.7 4396.2 4397.3 4415.9 4444.0 4465.0 4575.6 4657.1 4681.6 4721.6 4723.0 5110.4 5138.8 5150.2 5165.0 5227.5 5208.0 5214.7 5222.9 5229.8 5233.7 4714.1 4739.0 4754.4 4782.2 4797.4 5238.9 5246.9 5255.8 5258.8 5291.7 4921.5 5040.7 5041.6 5043.4 5062.6 5091.3 5091.5 5100.6 5118.2 5137.8 5072.2 5082.2 5084.1 5084.7 5124.1 4973.8 5031.3 5053.2 5067.4 5073.0 4156.9 4220.7 4256.3 4302.2 4356.7 3703.3 3739.6 3746.4 3752.8 3848.3 4328.7 4429.0 4429.2 4454.1 4486.5 5020.6 5045.1 5047.7 5113.5 5113.8 4439.1 4451.8 4460.6 4468.3 4485.8 4471.4 4534.6 4555.8 4591.6 4611.8 4771.5 4818.3 4864.1 4869.5 4895.1 5143.0 5149.3 5172.7 5177.2 5223.9 4756.0 4840.5 4863.8 4869.7 4918.0 5095.7 5101.7 5120.4 5129.4 5151.3 5172.0 5190.3 5196.3 5198.6 5200.3 4836.3 4952.2 4955.1 5010.4 5037.3 5005.9 5017.6 5024.6 5026.9 5104.2 4920.7 4927.3 4954.0 4965.6 5014.2 4922.2 4941.9 4998.7 5019.3 5045.7 4823.4 4900.7 4902.8 4905.0 4910.8 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | [#1] ext.html Cycles:180 Average:45780.62 Median:36514.95 stddev:85186.17 (233.3%) stddev-sans-first:85357.46 01:28:05 INFO - PROCESS | 16587 | Values: 553.5 576.2 584.5 591.8 609.9 35004.3 38597.0 38945.2 39027.4 39232.8 38697.4 39871.0 39965.4 40093.0 40126.0 7699.6 7724.6 7743.1 7785.3 7821.8 7647.9 7745.3 7750.5 7755.0 7775.3 7749.5 7755.2 7771.5 7772.3 7806.4 7721.7 7735.3 7762.1 7766.2 7778.2 7765.2 7806.6 7810.0 7843.4 7857.5 29278.9 36464.0 36918.6 36921.0 36951.4 2976.5 3085.5 3107.6 3116.7 3477.2 26917.3 27316.6 27365.0 27503.7 27901.9 3305.3 3312.2 3377.2 3473.1 3482.6 221885.0 223322.0 223762.0 223967.0 224103.9 31608.7 31936.5 31966.4 31967.5 31975.5 32704.3 34527.3 34773.1 34905.5 34959.7 12517.1 12533.1 12545.3 12648.9 12723.4 9312.3 9349.1 9499.7 9499.9 9506.2 18239.5 18277.2 18287.5 18340.6 18344.8 6549.4 6820.4 6956.3 7017.9 7097.1 858.5 920.4 929.2 940.0 1043.8 27073.9 28506.6 28860.7 28893.9 29043.1 932.8 940.6 969.1 1018.2 1074.2 14843.4 15141.3 15291.3 15387.8 15506.5 386721.0 387278.0 391289.0 391903.0 392610.0 48836.3 48937.0 49139.3 49225.8 49548.3 1211.4 1223.2 1234.9 1236.1 1240.8 26616.3 27748.4 27834.3 28050.2 28265.9 41161.4 41602.4 42035.8 42217.4 42324.8 328267.0 333532.0 333794.0 334116.0 335014.0 24634.3 25076.4 25089.7 25110.5 25173.1 42158.8 42187.0 42491.8 42900.0 43199.0 36319.1 36543.5 36816.6 36848.8 37396.3 36084.0 36649.8 36811.6 36987.8 37085.0 36030.8 36297.5 36486.5 36851.0 37002.8 31054.5 32783.5 33293.3 33374.8 33599.7 24979.3 25686.0 25716.6 26023.2 26071.6 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | [#2] jquery.html Cycles:180 Average:23139.33 Median:4951.65 stddev:62242.83 (1257.0%) stddev-sans-first:62393.95 01:28:05 INFO - PROCESS | 16587 | Values: 365.8 366.4 371.1 378.3 380.6 15171.5 16072.3 16753.9 16767.6 16817.0 14268.4 15899.3 16328.3 16354.8 16495.3 4985.1 5136.6 5194.1 5201.0 5211.0 3663.9 5090.3 5691.1 5995.7 6021.8 6013.2 6020.0 6028.2 6036.2 6046.1 4918.2 5236.6 5241.9 5338.0 5342.9 5066.2 5105.3 5156.4 5171.7 5198.6 11830.3 12204.7 12215.7 12429.3 12773.9 1858.8 1961.8 2060.4 2273.9 2457.9 8902.3 9188.5 9216.1 11354.6 11604.2 1713.1 1721.4 1774.7 1784.0 1790.8 67133.0 67718.3 67844.0 67894.3 69149.0 9799.7 9957.2 10079.0 10264.9 10426.0 13912.7 14003.3 14035.4 14041.2 14042.3 6481.9 6512.5 6578.9 6592.3 6671.1 5899.1 5934.1 5950.4 5975.9 5978.1 4252.6 4280.0 4338.8 4442.7 4485.9 1661.6 1746.9 1841.1 1853.1 1875.5 872.9 875.4 922.6 945.5 968.7 16608.7 16677.1 16872.6 16912.3 17538.1 841.4 848.9 870.7 924.0 927.9 9289.6 9297.4 9307.3 9313.7 9494.1 372083.0 375605.0 377097.0 381039.0 381254.0 71461.0 71662.3 72989.0 73208.3 73658.3 877.6 883.6 898.7 899.7 906.4 14913.9 15036.7 15065.4 15270.8 15318.5 30681.7 31248.2 32307.5 32381.8 32425.2 44941.3 45139.5 45258.0 45576.8 46055.3 6028.7 6476.3 7490.0 7655.2 7818.9 9302.8 11201.0 11266.4 11293.2 11389.4 9659.2 9678.4 9956.0 10073.4 10186.9 8276.7 10167.5 10681.7 10711.1 10769.3 9713.1 9972.5 9990.0 10199.2 10238.7 7584.6 7624.7 7719.0 7794.0 7942.3 8056.3 9516.6 9905.6 10155.9 10462.0 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | [#3] mootools.html Cycles:180 Average:5118.14 Median:5162.55 stddev:2881.62 (55.8%) stddev-sans-first:2876.19 01:28:05 INFO - PROCESS | 16587 | Values: 1405.3 1418.9 1524.2 1647.4 1701.1 6861.5 6995.6 7589.9 8073.8 8113.6 7331.7 7464.5 7540.1 7578.6 7626.9 2173.4 2215.7 2223.8 2224.4 2235.3 2162.6 2166.6 2177.6 2179.8 2190.3 2194.6 2196.8 2205.4 2209.8 2212.9 2189.6 2190.8 2192.1 2193.6 2203.9 2136.9 2141.1 2156.0 2161.4 2166.9 7791.1 7800.6 7856.1 7859.4 7875.4 4264.3 4343.2 4343.5 4348.3 4367.5 2804.8 2910.6 2911.0 2914.3 2969.7 890.7 908.1 921.9 954.4 963.1 9937.3 10289.8 10339.9 10659.6 10668.6 4198.3 4206.5 4285.2 4305.2 4323.3 9373.6 9390.3 9392.2 9405.1 9410.3 4510.3 4527.6 4540.8 4560.2 4566.2 3496.0 3896.9 4027.1 4052.1 4054.5 3647.6 3647.9 3720.4 3745.9 3752.5 1157.4 1168.8 1172.4 1173.4 1173.7 673.2 776.3 787.3 810.3 823.1 5005.5 5264.3 5328.4 5397.1 5529.0 407.1 428.4 428.8 431.6 434.4 3502.7 3510.3 3517.9 3561.3 3567.4 9164.6 9640.2 9695.8 9701.5 9736.0 9392.5 9465.5 9477.1 9482.9 9584.9 7224.8 7328.6 7344.4 7356.8 7401.4 5066.5 5258.6 5269.5 5270.4 5359.1 8943.6 8990.1 9007.9 9052.7 9088.7 8375.0 8718.8 8730.1 8957.5 8976.6 5772.5 6530.6 6580.3 6734.6 6785.5 7669.4 7674.8 7686.0 7696.3 7699.8 6751.5 6991.0 7043.1 7061.6 7166.2 6550.4 6560.4 6607.0 6762.4 6857.0 6522.0 6557.6 6618.9 6677.9 6682.6 4561.9 4612.7 4624.0 4638.0 4707.2 4792.6 4824.8 4839.5 4857.2 4972.0 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | [#4] prototype.html Cycles:180 Average:4339.07 Median:4958.95 stddev:1255.69 (25.3%) stddev-sans-first:1221.79 01:28:05 INFO - PROCESS | 16587 | Values: 285.2 287.0 290.9 298.0 301.8 4928.9 4983.9 4991.9 5006.6 5031.1 4900.6 4929.2 4950.3 4958.0 4959.9 3696.9 3776.7 3882.5 3898.5 3901.2 3900.7 3901.0 3917.1 3931.9 3937.3 3891.5 3907.3 3914.7 3923.8 3928.7 3801.0 3876.6 3893.8 3911.4 3914.1 3415.5 3421.8 3438.7 3442.3 3451.2 4753.8 4756.9 4766.4 4784.2 4816.3 4312.7 4435.0 4437.6 4449.0 4460.2 5089.4 5157.3 5180.4 5190.5 5201.6 3741.2 3746.6 3750.8 3751.9 3759.7 5451.2 5453.8 5460.5 5464.1 5492.2 3674.6 3800.3 3824.7 3832.1 3832.6 3871.0 3900.7 3912.7 3915.5 3920.8 4411.7 4451.0 4454.4 4469.7 4470.5 5070.7 5100.6 5210.7 5222.0 5256.3 1320.7 1343.2 1354.0 1356.3 1359.1 850.7 878.1 878.4 891.3 897.0 4539.3 4607.2 4614.4 4621.7 4626.6 5371.4 5374.7 5386.9 5399.0 5403.3 4462.1 4573.8 4577.2 4615.0 4625.3 2834.0 2874.8 2890.5 2896.5 2912.4 5072.1 5091.9 5102.2 5114.0 5130.7 5382.9 5476.9 5516.6 5556.9 5564.1 5102.8 5146.7 5159.4 5167.7 5175.9 5355.8 5397.9 5433.8 5439.2 5447.4 4987.0 5247.5 5259.4 5274.9 5280.6 5015.8 5049.9 5080.1 5093.9 5126.6 3860.6 3872.7 3882.3 3887.7 3902.0 5176.1 5256.3 5311.3 5356.2 5382.2 5228.9 5243.5 5253.4 5272.4 5276.4 5233.3 5245.4 5267.7 5270.4 5278.8 4858.7 5094.3 5102.6 5104.2 5118.5 4983.8 5066.0 5225.8 5230.9 5246.7 5070.8 5086.9 5093.1 5129.7 5132.3 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | [#5] yui.html Cycles:180 Average:13251.53 Median:46494.92 stddev:15321.04 (33.0%) stddev-sans-first:15334.66 01:28:05 INFO - PROCESS | 16587 | Values: 620.8 742.8 743.8 747.3 752.9 10807.4 11216.6 11757.6 11769.0 13145.1 13011.7 13598.4 13603.9 13630.9 13709.7 798.5 809.1 809.4 809.6 816.9 802.8 808.2 808.8 809.8 812.4 856.9 861.7 863.5 863.7 864.4 839.7 848.0 851.7 855.6 856.8 609.6 616.8 618.5 622.6 627.0 12388.4 12420.5 12539.4 12542.2 12561.9 12086.7 12737.1 12805.7 12920.5 13162.3 10073.3 10086.3 10191.6 10193.7 10217.4 3286.6 3331.2 3341.7 3349.8 3390.0 46456.3 46533.5 46536.5 47595.0 47689.0 9932.2 10055.6 10066.5 10208.2 10217.2 18192.4 18365.9 18368.3 18397.8 18425.4 6330.6 6337.9 6407.9 6515.2 6553.3 3587.5 3696.6 3748.2 3748.7 3805.7 2770.1 2859.1 2863.8 2866.1 2866.4 472.2 475.4 479.4 480.8 481.8 483.3 616.1 632.4 655.4 657.2 7745.3 7864.9 7920.5 7989.7 8145.1 572.5 599.1 607.2 612.7 622.7 3668.2 3843.4 3848.2 3860.8 3981.8 54317.2 54560.7 55138.2 55464.4 56570.2 49140.8 49538.5 49956.5 50476.0 50984.5 46444.3 46553.5 46866.3 47072.0 47644.5 7286.5 7487.4 7494.0 7502.7 7543.6 31243.2 31825.8 31888.0 32175.5 32248.7 37059.8 37548.0 39151.2 40652.6 40804.4 10653.1 10822.6 10903.9 11035.9 11117.4 11712.5 11872.8 12081.3 12239.0 12444.4 11025.6 11096.3 11111.7 11291.7 11426.1 11001.8 11136.1 11203.2 11219.5 11221.8 10898.8 11067.3 11232.6 11466.8 11655.7 9355.6 9577.5 9610.4 9647.9 9852.0 9703.2 9755.7 9843.9 9885.2 9927.4 01:28:05 INFO - PROCESS | 16587 | -------- Summary: end -------- 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | 01:28:05 INFO - PROCESS | 16587 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 01:28:05 INFO - PROCESS | 16587 | 01:28:06 INFO - TEST-INFO | 16587: exit 0 01:28:06 INFO - TEST-OK | dromaeo_css | took 1115601ms 01:28:06 INFO - TEST-START | kraken 01:28:06 INFO - operating with platform_type : linux_ 01:28:06 INFO - Initialising browser for kraken test... 01:28:06 INFO - TEST-INFO | started process 16826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrZVnN/profile http://localhost:45148/getInfo.html) 01:28:10 INFO - PROCESS | 16826 | 01:28:10 INFO - PROCESS | 16826 | (process:16893): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:28:11 INFO - PROCESS | 16826 | __metrics Screen width/height:1600/1200 01:28:11 INFO - PROCESS | 16826 | colorDepth:24 01:28:11 INFO - PROCESS | 16826 | Browser inner width/height: 1024/697 01:28:11 INFO - PROCESS | 16826 | __metrics 01:28:11 ERROR - PROCESS | 16826 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:28:12 INFO - TEST-INFO | 16826: exit 0 01:28:12 INFO - Browser initialized. 01:28:12 INFO - Running cycle 1/1 for kraken test... 01:28:12 INFO - TEST-INFO | started process 16944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrZVnN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:14 INFO - PROCESS | 16944 | 01:28:14 INFO - PROCESS | 16944 | (process:17004): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:28:24 INFO - PROCESS | 16944 | RSS: Main: 165675008 01:28:24 INFO - PROCESS | 16944 | 01:28:27 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45148/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:28 INFO - PROCESS | 16944 | RSS: Main: 169791488 01:28:28 INFO - PROCESS | 16944 | 01:28:31 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45148/tests/kraken/driver.html?testName=audio-dft) 01:28:31 INFO - PROCESS | 16944 | RSS: Main: 169955328 01:28:31 INFO - PROCESS | 16944 | 01:28:34 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45148/tests/kraken/driver.html?testName=audio-fft) 01:28:35 INFO - PROCESS | 16944 | RSS: Main: 164601856 01:28:35 INFO - PROCESS | 16944 | 01:28:37 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45148/tests/kraken/driver.html?testName=audio-oscillator) 01:28:38 INFO - PROCESS | 16944 | RSS: Main: 165212160 01:28:38 INFO - PROCESS | 16944 | 01:28:40 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:41 INFO - PROCESS | 16944 | RSS: Main: 165675008 01:28:41 INFO - PROCESS | 16944 | 01:28:44 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45148/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:45 INFO - PROCESS | 16944 | RSS: Main: 165330944 01:28:45 INFO - PROCESS | 16944 | 01:28:48 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45148/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:49 INFO - PROCESS | 16944 | RSS: Main: 165134336 01:28:49 INFO - PROCESS | 16944 | 01:28:52 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45148/tests/kraken/driver.html?testName=json-parse-financial) 01:28:53 INFO - PROCESS | 16944 | RSS: Main: 164876288 01:28:53 INFO - PROCESS | 16944 | 01:28:54 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:28:55 INFO - PROCESS | 16944 | RSS: Main: 165097472 01:28:55 INFO - PROCESS | 16944 | 01:28:57 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:28:58 INFO - PROCESS | 16944 | RSS: Main: 165502976 01:28:58 INFO - PROCESS | 16944 | 01:29:00 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:01 INFO - PROCESS | 16944 | RSS: Main: 166400000 01:29:01 INFO - PROCESS | 16944 | 01:29:03 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:04 INFO - PROCESS | 16944 | RSS: Main: 166080512 01:29:04 INFO - PROCESS | 16944 | 01:29:07 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:08 INFO - PROCESS | 16944 | RSS: Main: 165908480 01:29:08 INFO - PROCESS | 16944 | 01:29:09 INFO - PROCESS | 16944 | Cycle 1(1): loaded http://localhost:45148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45148/tests/kraken/driver.html?testName=ai-astar) 01:29:10 INFO - PROCESS | 16944 | RSS: Main: 168181760 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | __start_tp_report 01:29:10 INFO - PROCESS | 16944 | _x_x_mozilla_page_load 01:29:10 INFO - PROCESS | 16944 | _x_x_mozilla_page_load_details 01:29:10 INFO - PROCESS | 16944 | |i|pagename|runs| 01:29:10 INFO - PROCESS | 16944 | |0;ai-astar;114;108;116;116;115;116;115;114;116;115 01:29:10 INFO - PROCESS | 16944 | |1;audio-beat-detection;163;139;166;217;130;158;155;137;189;135 01:29:10 INFO - PROCESS | 16944 | |2;audio-dft;163;163;164;171;165;163;166;162;164;162 01:29:10 INFO - PROCESS | 16944 | |3;audio-fft;76;75;77;167;77;77;75;77;176;77 01:29:10 INFO - PROCESS | 16944 | |4;audio-oscillator;95;95;174;94;94;95;145;94;96;142 01:29:10 INFO - PROCESS | 16944 | |5;imaging-gaussian-blur;120;122;121;121;120;121;121;122;122;124 01:29:10 INFO - PROCESS | 16944 | |6;imaging-darkroom;146;148;148;147;147;149;147;147;147;147 01:29:10 INFO - PROCESS | 16944 | |7;imaging-desaturate;96;95;95;96;96;95;96;97;95;96 01:29:10 INFO - PROCESS | 16944 | |8;json-parse-financial;65;66;65;66;66;64;65;66;66;69 01:29:10 INFO - PROCESS | 16944 | |9;json-stringify-tinderbox;66;65;64;66;65;66;65;66;65;65 01:29:10 INFO - PROCESS | 16944 | |10;stanford-crypto-aes;83;82;82;81;89;91;85;85;152;83 01:29:10 INFO - PROCESS | 16944 | |11;stanford-crypto-ccm;144;140;138;132;144;137;129;135;149;132 01:29:10 INFO - PROCESS | 16944 | |12;stanford-crypto-pbkdf2;174;177;181;175;171;173;177;176;176;170 01:29:10 INFO - PROCESS | 16944 | |13;stanford-crypto-sha256-iterative;67;73;69;68;68;70;68;67;68;70 01:29:10 INFO - PROCESS | 16944 | __end_tp_report 01:29:10 INFO - PROCESS | 16944 | __start_cc_report 01:29:10 INFO - PROCESS | 16944 | _x_x_mozilla_cycle_collect,920 01:29:10 INFO - PROCESS | 16944 | __end_cc_report 01:29:10 INFO - PROCESS | 16944 | __startTimestamp1463819350203__endTimestamp 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | ------- Summary: start ------- 01:29:10 INFO - PROCESS | 16944 | Number of tests: 14 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.50 stddev:2.42 (2.1%) stddev-sans-first:2.55 01:29:10 INFO - PROCESS | 16944 | Values: 114.0 108.0 116.0 116.0 115.0 116.0 115.0 114.0 116.0 115.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:160.50 stddev:27.18 (16.9%) stddev-sans-first:28.78 01:29:10 INFO - PROCESS | 16944 | Values: 163.0 139.0 166.0 217.0 130.0 158.0 155.0 137.0 189.0 135.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.67 (1.6%) stddev-sans-first:2.79 01:29:10 INFO - PROCESS | 16944 | Values: 163.0 163.0 164.0 171.0 165.0 163.0 166.0 162.0 164.0 162.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#3] audio-fft Cycles:10 Average:95.40 Median:77.00 stddev:40.17 (52.2%) stddev-sans-first:41.99 01:29:10 INFO - PROCESS | 16944 | Values: 76.0 75.0 77.0 167.0 77.0 77.0 75.0 77.0 176.0 77.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:94.50 stddev:29.68 (31.4%) stddev-sans-first:30.80 01:29:10 INFO - PROCESS | 16944 | Values: 95.0 95.0 174.0 94.0 94.0 95.0 145.0 94.0 96.0 142.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#5] imaging-gaussian-blur Cycles:10 Average:121.40 Median:121.50 stddev:1.17 (1.0%) stddev-sans-first:1.13 01:29:10 INFO - PROCESS | 16944 | Values: 120.0 122.0 121.0 121.0 120.0 121.0 121.0 122.0 122.0 124.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 01:29:10 INFO - PROCESS | 16944 | Values: 146.0 148.0 148.0 147.0 147.0 149.0 147.0 147.0 147.0 147.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:29:10 INFO - PROCESS | 16944 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.36 01:29:10 INFO - PROCESS | 16944 | Values: 65.0 66.0 65.0 66.0 66.0 64.0 65.0 66.0 66.0 69.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 01:29:10 INFO - PROCESS | 16944 | Values: 66.0 65.0 64.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:84.00 stddev:21.57 (25.7%) stddev-sans-first:22.66 01:29:10 INFO - PROCESS | 16944 | Values: 83.0 82.0 82.0 81.0 89.0 91.0 85.0 85.0 152.0 83.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:139.00 stddev:6.32 (4.6%) stddev-sans-first:6.32 01:29:10 INFO - PROCESS | 16944 | Values: 144.0 140.0 138.0 132.0 144.0 137.0 129.0 135.0 149.0 132.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:3.20 (1.8%) stddev-sans-first:3.37 01:29:10 INFO - PROCESS | 16944 | Values: 174.0 177.0 181.0 175.0 171.0 173.0 177.0 176.0 176.0 170.0 01:29:10 INFO - PROCESS | 16944 | 01:29:10 INFO - PROCESS | 16944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:1.81 (2.6%) stddev-sans-first:1.80 01:29:10 INFO - PROCESS | 16944 | Values: 67.0 73.0 69.0 68.0 68.0 70.0 68.0 67.0 68.0 70.0 01:29:10 INFO - PROCESS | 16944 | -------- Summary: end -------- 01:29:10 INFO - PROCESS | 16944 | 01:29:11 INFO - TEST-INFO | 16944: exit 0 01:29:11 INFO - TEST-OK | kraken | took 64977ms 01:29:11 INFO - SUITE-END | took 1180s 01:29:11 INFO - Completed test suite (00:19:41) 01:29:11 INFO - javascript benchmark 01:29:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6264.7563759861205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.7362263773625, 2677.6519052523176, 2684.6107314439405, 2709.241412404525, 2709.471653027659, 4700.858974230774, 4746.691465054773, 4848.0, 4851.878703032422, 4874.317595536619, 4660.766961651921, 4675.345451636765, 4695.812167513304, 4768.380110585619, 4782.521747825216, 4356.411884395598, 4361.258586040372, 4369.890752731176, 4412.161689279043, 4519.887002824923, 4353.978230108845, 4395.9560404396025, 4456.79944402501, 4458.2866741321395, 4511.390962220091, 4340.197063543223, 4432.490263619693, 4456.866294011153, 4476.6418686505, 4479.529649386816, 4426.402435671175, 4433.202023635744, 4444.088961762864, 4478.7984540695425, 4480.731156130642, 4396.20868243716, 4397.252467080604, 4415.867523974286, 4443.955560444387, 4465.0, 4575.633949284049, 4657.091867085919, 4681.578657920803, 4721.5750582447745, 4723.031778485402, 5110.412302585176, 5138.768755406016, 5150.227465880111, 5165.018646457199, 5227.503387178212, 5208.0365132450615, 5214.739263036871, 5222.895542089137, 5229.816956406507, 5233.738313084331, 4714.080754252922, 4739.0, 4754.381930349033, 4782.234842425195, 4797.424309082932, 5238.947610523922, 5246.868828279247, 5255.842324730264, 5258.842234732964, 5291.656042357235, 4921.532454416896, 5040.697558146523, 5041.621878359138, 5043.420006699203, 5062.594992400599, 5091.261767043758, 5091.490850914953, 5100.56645185156, 5118.155504341742, 5137.794488220429, 5072.188449848007, 5082.161443361878, 5084.084864724385, 5084.745762711924, 5124.077666020077, 4973.751312434436, 5031.295618613397, 5053.216751403538, 5067.366579177603, 5072.985402919431, 4156.896077598024, 4220.704550681423, 4256.2764330063965, 4302.204092242945, 4356.6732495063, 3703.3148867459604, 3739.569949455793, 3746.4005759078964, 3752.7748335099436, 3848.3073046851837, 4328.675349348811, 4428.977855110704, 4429.15845989261, 4454.064646424287, 4486.461624605068, 5020.623453240948, 5045.091883461012, 5047.722375269322, 5113.488651134931, 5113.821016264413, 4439.1121775645, 4451.777411129496, 4460.643148548108, 4468.285074388083, 4485.753283569435, 4471.396361491157, 4534.614557762561, 4555.840545580889, 4591.609713174351, 4611.838585649553, 4771.546703063273, 4818.277258411266, 4864.051509955595, 4869.488703686062, 4895.143349913679, 5143.048536020848, 5149.304843846033, 5172.663776854492, 5177.249298851721, 5223.895522089613, 4755.977464845075, 4840.491748366371, 4863.805447782049, 4869.732164730974, 4918.0, 5095.694258344512, 5101.744912754421, 5120.4111527174855, 5129.384473863161, 5151.2788209649925, 5172.043172013189, 5190.325257716473, 5196.298499702491, 5198.610104242272, 5200.349956255468, 4836.322914792002, 4952.1581331173065, 4955.132851751001, 5010.448850626501, 5037.294778730908, 5005.949940500548, 5017.648764586444, 5024.598032157492, 5026.924596130988, 5104.183330667075, 4920.704757714549, 4927.334809800631, 4953.975230123826, 4965.553100220997, 5014.222795466709, 4922.212446008622, 4941.901161976669, 4998.6750861193905, 5019.297298378303, 5045.722485263345, 4823.421189457287, 4900.681455705368, 4902.754862256944, 4905.0189962007025, 4910.7544622768], "value": 4701.550696620717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5177135097928, 576.2192229528988, 584.5206930317141, 591.7958304384987, 609.9052201298668, 35004.299914001705, 38597.0, 38945.22109557814, 39027.414588781154, 39232.80383598081, 38697.41953870694, 39871.0, 39965.40051899224, 40092.99767505814, 40126.0, 7699.576523291216, 7724.5751483668655, 7743.148253692089, 7785.260400261995, 7821.843563128734, 7647.923520764804, 7745.3416459601, 7750.5349679019155, 7755.0, 7775.261350171724, 7749.496282741632, 7755.224477552256, 7771.494852834576, 7772.33935115513, 7806.414518911076, 7721.691132354699, 7735.303822655932, 7762.107357653857, 7766.184550622188, 7778.222177782233, 7765.184655611192, 7806.6096695165015, 7809.960950195213, 7843.411744119214, 7857.489263197874, 29278.853605731834, 36464.0, 36918.630813692056, 36921.0, 36951.445728314095, 2976.4939960206816, 3085.4754691702465, 3107.6115485564305, 3116.703913128249, 3477.23500829817, 26917.32706682329, 27316.59025114625, 27365.0, 27503.724962750315, 27901.860490697618, 3305.2563173286057, 3312.1554003729134, 3377.223238655123, 3473.0969947813496, 3482.6343233960324, 221885.0, 223322.0, 223762.0, 223967.0, 224103.87948060318, 31608.683913161032, 31936.520952185736, 31966.360672786413, 31967.52048719271, 31975.52036719451, 32704.345913081605, 34527.30945381078, 34773.13067173341, 34905.47641785375, 34959.65040349615, 12517.123801334, 12533.122681412397, 12545.31000794965, 12648.936755316348, 12723.363831808372, 9312.34813563044, 9349.111834375723, 9499.715008549754, 9499.857502137473, 9506.239500839916, 18239.544011399823, 18277.177527011052, 18287.54281142982, 18340.633187336178, 18344.816551834578, 6549.410553050248, 6820.420264277493, 6956.339147780953, 7017.89473157903, 7097.148342198969, 858.4763294390417, 920.3603495570514, 929.1637526226315, 940.022376728195, 1043.7912417516527, 27073.864630676722, 28506.572401413996, 28860.711392886224, 28893.855530722212, 29043.12870613885, 932.8246409524048, 940.5532372123187, 969.1374676537887, 1018.2057994764095, 1074.167520171873, 14843.40626374933, 15141.318640661197, 15291.311890964933, 15387.769183462256, 15506.457273995582, 386721.0, 387278.0, 391289.0, 391903.0, 392610.0, 48836.267455988185, 48937.0, 49139.262911056365, 49225.75387123113, 49548.25677614839, 1211.357980270458, 1223.1621339382552, 1234.8888600025862, 1236.097648716442, 1240.8324876141605, 26616.33459163459, 27748.44503109886, 27834.304142396602, 28050.158495245174, 28265.858670707337, 41161.38257926193, 41602.37596436116, 42035.7898210507, 42217.36673949955, 42324.78837605792, 328267.0, 333532.0, 333794.0, 334116.0, 335014.0, 24634.260972170865, 25076.373090672878, 25089.74910250947, 25110.49779004373, 25173.118940836983, 42158.78920605377, 42187.0, 42491.787541063335, 42900.0, 43199.0, 36319.09202269858, 36543.45184822177, 36816.63183368132, 36848.81575592105, 37396.2520749578, 36084.0, 36649.81675091608, 36811.63188368082, 36987.81506092452, 37085.0, 36030.8198459006, 36297.45553816748, 36486.45270320894, 36851.0, 37002.814985924895, 31054.534181986837, 32783.50824737678, 33293.33413331768, 33374.833125834215, 33599.664003359656, 24979.250622481355, 25686.0, 25716.61425078588, 26023.219303420927, 26071.608925866505], "value": 16883.108064165837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.83720244491195, 366.3533862732277, 371.0760207084359, 378.28881702399485, 380.61177598849156, 15171.468998585051, 16072.276747546359, 16753.916230418847, 16767.580810479714, 16817.0, 14268.429262829475, 15899.28453219605, 16328.346866125341, 16354.83645163548, 16495.34018639256, 4985.052839960405, 5136.563392111675, 5194.065068287707, 5200.973995130019, 5211.0, 3663.8717644882436, 5090.261912022755, 5691.08942569189, 5995.6702381369005, 6021.849453763647, 6013.1581578579035, 6019.969900150493, 6028.246469191351, 6036.215292012054, 6046.062860256668, 4918.237673160648, 5236.554892834095, 5241.9213711794355, 5338.0, 5342.866428339284, 5066.214736715815, 5105.310783044316, 5156.432792392834, 5171.689698618095, 5198.558122559587, 11830.290182589073, 12204.694882627917, 12215.694607634792, 12429.31638759868, 12773.936130319382, 1858.7955324914249, 1961.8136277053657, 2060.402483279847, 2273.886305684709, 2457.8939477235317, 8902.287816974627, 9188.494632795193, 9216.078392160798, 11354.602588909349, 11604.187706860523, 1713.0578181999974, 1721.432778495451, 1774.7426623139702, 1783.9643207135784, 1790.8209179082119, 67133.0, 67718.32281677169, 67844.0, 67894.3210567893, 69149.0, 9799.657012004545, 9957.153641940517, 10079.0, 10264.948675256725, 10426.009529094725, 13912.721745565032, 14003.299835008209, 14035.43858245679, 14041.1575305482, 14042.297885105703, 6481.935180648227, 6512.544121911421, 6578.868422631521, 6592.274849766522, 6671.132752742113, 5899.115132730125, 5934.139549765347, 5950.375210602824, 5975.880482390327, 5978.103284507271, 4252.55348188442, 4279.957200428018, 4338.848140315074, 4442.666799990014, 4485.910281794346, 1661.609521762385, 1746.9039202843712, 1841.1346667066457, 1853.1290293562004, 1875.5311172206948, 872.9039805621377, 875.4484674654926, 922.6447817590276, 945.546137853834, 968.7481254873784, 16608.6678266434, 16677.08276044805, 16872.57818554546, 16912.32350705958, 17538.123093845512, 841.381584535366, 848.9320854331762, 870.6734974384606, 923.9769005774909, 927.874736910522, 9289.581968811419, 9297.395669281475, 9307.348485606079, 9313.674021409219, 9494.050594940589, 372083.0, 375605.0, 377097.0, 381039.0, 381254.0, 71461.0, 71662.2833771666, 72989.0, 73208.26791732015, 73658.26341736621, 877.6226222724163, 883.6208993859449, 898.7438580004667, 899.6626265150569, 906.4108329585822, 14913.850861491681, 15036.699266014837, 15065.397384104514, 15270.770938436155, 15318.463853765064, 30681.693183067884, 31248.21879453032, 32307.51538726874, 32381.838090809397, 32425.189370265933, 44941.32588011117, 45139.54860451353, 45258.0, 45576.772116139204, 46055.309170361805, 6028.728707208274, 6476.31998640136, 7489.988851505195, 7655.2344765523, 7818.921810782047, 9302.813943720952, 11201.0, 11266.436678166223, 11293.153013523854, 11389.43052847371, 9659.178969787647, 9678.419294842332, 9956.0, 10073.445960472245, 10186.898131018892, 8276.710315138942, 10167.542460589144, 10681.679549613524, 10711.08955738771, 10769.299995500267, 9713.07725766051, 9972.50137493108, 9990.0, 10199.184065274909, 10238.744031399274, 7584.62076896164, 7624.656890439833, 7719.0, 7793.961030194812, 7942.324902383131, 8056.274935255855, 9516.571754271214, 9905.603775848886, 10155.89844101579, 10462.0], "value": 7922.442371645012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.2973513243378, 1418.9432422703092, 1524.1617110589173, 1647.3642172523955, 1701.064414571985, 6861.451083913287, 6995.615241161734, 7589.8861517077285, 8073.8385232295395, 8113.594320283984, 7331.706731730737, 7464.477486575942, 7540.057492813398, 7578.621068946558, 7626.923730762691, 2173.3805865328386, 2215.667649852527, 2223.844330896838, 2224.421650370899, 2235.3405745305095, 2162.6323525000707, 2166.6208413527647, 2177.6298029335053, 2179.8474106812528, 2190.288156349185, 2194.648856183011, 2196.7803219677985, 2205.40454077399, 2209.823214142865, 2212.9446763830874, 2189.551142015891, 2190.8466407351493, 2192.0683709423433, 2193.5941850757663, 2203.8787866667326, 2136.9465763355884, 2141.068635143702, 2156.0, 2161.3515945216373, 2166.9241576544905, 7791.142974272825, 7800.570968596781, 7856.057273127204, 7859.41054420915, 7875.409344299201, 4264.33902745075, 4343.1747967886, 4343.500497442803, 4348.282533381988, 4367.54140815213, 2804.803663743539, 2910.621619189492, 2911.0248066897616, 2914.3151359430517, 2969.7030296970347, 890.7149712092133, 908.1009800297724, 921.9354645174841, 954.379653225409, 963.1476143612883, 9937.304388692794, 10289.845652315222, 10339.948300258526, 10659.573617055308, 10668.573257069707, 4198.328267477189, 4206.47419072616, 4285.207236661227, 4305.182015417061, 4323.286657701507, 9373.62505499786, 9390.295727820441, 9392.154706076486, 9405.106514881076, 9410.294227932933, 4510.255807791743, 4527.637788976874, 4540.77296135192, 4560.17916774977, 4566.178087944202, 3495.9825200874343, 3896.9220615588097, 4027.093903871664, 4052.0882801370044, 4054.4729185205733, 3647.562292524914, 3647.94528082079, 3720.4233343831747, 3745.9438108428394, 3752.4746535485056, 1157.3750174905456, 1168.807146820765, 1172.384498138484, 1173.3898372846243, 1173.6537721372215, 673.2224280955504, 776.2780614029007, 787.271773609409, 810.3476701255546, 823.1357075071271, 5005.549500544968, 5264.289320941701, 5328.387235467971, 5397.055515284809, 5529.0324193266015, 407.08812260536183, 428.421946259697, 428.7822583861847, 431.5878336188932, 434.3506457845541, 3502.667246611568, 3510.315488479722, 3517.9120521986642, 3561.252137051248, 3567.4292113261754, 9164.633414663338, 9640.228781697588, 9695.757606059764, 9701.51492425376, 9736.0, 9392.483413412192, 9465.52672366379, 9477.147056764787, 9482.857757133648, 9584.856227156599, 7224.783256502208, 7328.560286382834, 7344.449166312548, 7356.816079598053, 7401.370883474965, 5066.544011039025, 5258.553022993088, 5269.525742683177, 5270.4202537721585, 5359.088954877758, 8943.642254309754, 8990.145936136056, 9007.909920900707, 9052.683156089506, 9088.727338179866, 8374.958125209336, 8718.779370888207, 8730.083341249077, 8957.507337096522, 8976.640934362813, 5772.538196944319, 6530.608163510205, 6580.276169621434, 6734.595924244561, 6785.525013249223, 7669.386449083949, 7674.808129796576, 7685.961570192337, 7696.268854458817, 7699.807504812425, 6751.493637977073, 6991.0, 7043.084399028094, 7061.646917653994, 7166.211716711262, 6550.377714117151, 6560.40956313934, 6606.966965165336, 6762.357576030269, 6856.965715171592, 6522.0, 6557.573757705924, 6618.867622647616, 6677.933220667731, 6682.599044057372, 4561.8631441055495, 4612.723236605814, 4623.953760462352, 4637.976810115928, 4707.223308154116, 4792.568668819823, 4824.807007719652, 4839.467658557485, 4857.174280372275, 4972.0], "value": 4052.1604719850197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.16873314288847, 287.0355605166641, 290.870562599643, 298.0, 301.81589230569347, 4928.926066109007, 4983.875403114924, 4991.925121123181, 5006.574441172495, 5031.144705400082, 4900.632452566054, 4929.186684197103, 4950.292149208526, 4957.975210123945, 4959.925601115986, 3696.9094117235413, 3776.6978641708733, 3882.514685664292, 3898.5321761388673, 3901.1807520420602, 3900.6879449644102, 3900.960990390088, 3917.118648304123, 3931.9213615727667, 3937.2716047531153, 3891.4941057662604, 3907.2771537265553, 3914.7063970202207, 3923.8038098095126, 3928.7249892507534, 3801.0, 3876.592957739425, 3893.785841778701, 3911.3741801311794, 3914.1388894443176, 3415.4725503127506, 3421.81180035098, 3438.7249020078334, 3442.277121804424, 3451.154467155563, 4753.809847606126, 4756.8583539950505, 4766.38037055184, 4784.186688262969, 4816.277558366238, 4312.719673221262, 4434.977825110886, 4437.602155321064, 4449.0, 4460.171329754785, 5089.440161582223, 5157.277981082651, 5180.352455943007, 5190.480951904779, 5201.557867581222, 3741.1956429367547, 3746.550413950343, 3750.774953502799, 3751.8744376686886, 3759.7180211483974, 5451.236826844205, 5453.809116680897, 5460.481254280877, 5464.12573988164, 5492.203630473599, 3674.5590529136675, 3800.277947190025, 3824.694024478035, 3832.1414114154613, 3832.616738326145, 3870.9612903871166, 3900.7269491135917, 3912.68698504119, 3915.471411359487, 3920.784356860343, 4411.735295882258, 4451.0, 4454.354118652842, 4469.687121901501, 4470.530594287618, 5070.7464626768515, 5100.642954993189, 5210.739463026909, 5221.973890130525, 5256.26412302278, 1320.7490576790378, 1343.2142196814777, 1353.966150846217, 1356.2947267420886, 1359.136948038003, 850.7362717557453, 878.0999475537625, 878.4026861734083, 891.2914233184633, 897.0446474504762, 4539.296409056601, 4607.170709272296, 4614.353990441341, 4621.70592234175, 4626.629869610423, 5371.382291036581, 5374.677519348852, 5386.946130538723, 5398.973005134949, 5403.297571315782, 4462.085272519191, 4573.810809189635, 4577.244754615518, 4614.953850461452, 4625.283081122431, 2834.0222623194963, 2874.7843911706705, 2890.508613535704, 2896.5365541513256, 2912.4466351393166, 5072.137736584789, 5091.898162036812, 5102.209157580581, 5113.974430127825, 5130.692158470503, 5382.946170538323, 5476.945230547723, 5516.613837031369, 5556.944430555724, 5564.10974244119, 5102.8214012510125, 5146.716930568779, 5159.406668233126, 5167.715775632376, 5175.922361164586, 5355.812546560852, 5397.9460205397445, 5433.809816656398, 5439.211314359475, 5447.400785913625, 4986.955348307177, 5247.501487358695, 5259.368875734936, 5274.920876186783, 5280.551153151871, 5015.799368025238, 5049.8737531562, 5080.110980578458, 5093.898122037613, 5126.615503837153, 3860.6332398422105, 3872.6832876822014, 3882.3011857865854, 3887.7278590498395, 3901.960980390273, 5176.145935920682, 5256.264123022856, 5311.336082989626, 5356.196570514298, 5382.219578161066, 5228.921566176587, 5243.528082472443, 5253.422123566328, 5272.393674727456, 5276.39321478035, 5233.293505376878, 5245.423003469692, 5267.73661316925, 5270.4202537721585, 5278.762455689426, 4858.684185527929, 5094.286799848099, 5102.591792656653, 5104.234364845154, 5118.462561431145, 4983.825566105169, 5066.0, 5225.817096401608, 5230.895382092413, 5246.685198888079, 5070.797168113234, 5086.872828179177, 5093.115547247542, 5129.692218466904, 5132.255822905732], "value": 3934.2507666463357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8199622109588, 742.8031571633517, 743.8103283662668, 747.2900744292916, 752.9435292353071, 10807.4055926924, 11216.551337946472, 11757.647270581874, 11769.0, 13145.079844410895, 13011.674708132301, 13598.388072536734, 13603.931980340109, 13630.863691363083, 13709.725805483884, 798.5448294472168, 809.1059379385782, 809.3767798794925, 809.5628360685253, 816.9264766171043, 802.83541873916, 808.2362167751477, 808.8099296665279, 809.7773112394079, 812.4110020235312, 856.9357298202628, 861.6639510590875, 863.5380071661631, 863.7495126413364, 864.3646919514152, 839.689314953465, 847.9533625650587, 851.6806197675902, 855.6149732620314, 856.7772379181396, 609.5824360313155, 616.8242051015484, 618.4681174190193, 622.5890911998105, 626.9623822570614, 12388.442520086617, 12420.503179872794, 12539.373031348487, 12542.184757990794, 12561.874381256162, 12086.697832554168, 12737.108402411835, 12805.679858003532, 12920.483180672762, 13162.315008994896, 10073.345232559934, 10086.344387614781, 10191.59233630654, 10193.74515637115, 10217.386956782542, 3286.556314897482, 3331.1505566080737, 3341.682540158681, 3349.7990120592845, 3389.9830500847584, 46456.3031554527, 46533.534664653256, 46536.5346346539, 47595.0, 47689.0, 9932.205423566098, 10055.597776088875, 10066.496675166212, 10208.183345332356, 10217.23370747182, 18192.363267285848, 18365.90817045906, 18368.265269389074, 18397.81602183961, 18425.355112570996, 6330.588511746721, 6337.904931426032, 6407.903881441782, 6515.218173819172, 6553.279139294674, 3587.461880717913, 3696.5748938872375, 3748.175401411685, 3748.681362084199, 3805.657490825839, 2770.127409865886, 2859.056511351249, 2863.828170309788, 2866.140157952606, 2866.441043996442, 472.19962164131465, 475.372508289062, 479.37681014680777, 480.82449905784136, 481.8361757002566, 483.33541380601673, 616.1312549305458, 632.3929028132952, 655.3610230025687, 657.1883723601348, 7745.302922736981, 7864.883548597293, 7920.485168464146, 7989.7203597873795, 8145.144759800254, 572.5190839694676, 599.0923750517969, 607.2318517075903, 612.7212118486167, 622.6762083716442, 3668.192997540537, 3843.404272337792, 3848.191879705237, 3860.8069596520063, 3981.761094334291, 54317.1852422214, 54560.72719636456, 55138.17292740612, 55464.445355545926, 56570.15144772832, 49140.78023744595, 49538.50461495339, 49956.500434995185, 50476.0, 50984.49015509872, 46444.30333544999, 46553.5344646556, 46866.29700554494, 47072.0, 47644.52355476401, 7286.489945703962, 7487.438442116972, 7494.0, 7502.662380192795, 7543.585102819397, 31243.218919527193, 31825.840870796423, 31888.0, 32175.51736723998, 32248.677513225506, 37059.81470092632, 37548.0, 39151.2169756609, 40652.59347406488, 40804.38793418042, 10653.104657610671, 10822.621208257673, 10903.945480272549, 11035.944820276169, 11117.388543629855, 11712.472938717949, 11872.82190767122, 12081.275123492618, 12239.0, 12444.377781110727, 11025.61410350634, 11096.278741881752, 11111.72220694489, 11291.661250162508, 11426.143039271921, 11001.779964400506, 11136.109111270916, 11203.215774896005, 11219.495122719334, 11221.775564488502, 10898.836517452402, 11067.280626759235, 11232.606858759904, 11466.77066458683, 11655.65033048976, 9355.5789989452, 9577.534667956692, 9610.423374597547, 9647.9035209647, 9851.950740246253, 9703.175230105238, 9755.658551950648, 9843.85234221473, 9885.159761420073, 9927.354721943051], "value": 6029.444217846913, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 116.0, 116.0, 115.0, 116.0, 115.0, 114.0, 116.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 139.0, 166.0, 217.0, 130.0, 158.0, 155.0, 137.0, 189.0, 135.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 171.0, 165.0, 163.0, 166.0, 162.0, 164.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 167.0, 77.0, 77.0, 75.0, 77.0, 176.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 174.0, 94.0, 94.0, 95.0, 145.0, 94.0, 96.0, 142.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 121.0, 121.0, 120.0, 121.0, 121.0, 122.0, 122.0, 124.0], "value": 121.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 64.0, 65.0, 66.0, 66.0, 69.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 81.0, 89.0, 91.0, 85.0, 85.0, 152.0, 83.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 138.0, 132.0, 144.0, 137.0, 129.0, 135.0, 149.0, 132.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 181.0, 175.0, 171.0, 173.0, 177.0, 176.0, 176.0, 170.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 69.0, 68.0, 68.0, 70.0, 68.0, 67.0, 68.0, 70.0], "value": 68.8, "unit": "score"}]}]} 01:29:11 INFO - Return code: 0 01:29:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:29:12 ERROR - # TBPL SUCCESS # 01:29:12 INFO - Running post-action listener: _resource_record_post_action 01:29:12 INFO - ##### 01:29:12 INFO - ##### Finished run-tests step (success) 01:29:12 INFO - ##### 01:29:12 INFO - Running post-run listener: _resource_record_post_run 01:29:12 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545705984; Read time: 16; Write time: 410688 01:29:12 INFO - TinderboxPrint: CPU usage
13.3% 01:29:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:29:12 INFO - TinderboxPrint: I/O write bytes / time
545,705,984 / 410,688 01:29:12 INFO - TinderboxPrint: CPU idle
8,285.4 (86.6%) 01:29:12 INFO - TinderboxPrint: CPU user
1,226.6 (12.8%) 01:29:12 INFO - TinderboxPrint: Swap in / out
0 / 0 01:29:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236781568; Read time: 0; Write time: 219376 01:29:12 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296882176; Read time: 16; Write time: 187052 01:29:12 INFO - Running post-run listener: _upload_blobber_files 01:29:12 INFO - Blob upload gear active. 01:29:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:12 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 01:29:12 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'] 01:29:12 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 01:29:13 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:29:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:29:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:13 INFO - (blobuploader) - INFO - Done attempting. 01:29:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:29:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:29:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:17 INFO - (blobuploader) - INFO - Done attempting. 01:29:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:29:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:29:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:18 INFO - (blobuploader) - INFO - Done attempting. 01:29:18 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:18 INFO - Return code: 0 01:29:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2de1219512d8552a1c42ebad622fccf14e1108d930224108d723c0ee7fb9284e838576b80a9c2a74da6532e547642e07d393ed34cba5005e10f6ac5b4f6315f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b53602d5c15e6b0b63dd6ff97d64301632fbbd52d636dd1cd370378d089d1b99193c8c5d4b6e5fc2ff92121b47e003f23cac8187d26ecc0c96c9bcf4ed259c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d474b8c2afddc3295e47e59556e603e8bf170f82757d4ca0abc3ec45d6db4d2efb053fe1d2fdae11e3f47413fb100023febd88cbf1137ab6dd3979067b07580"} 01:29:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:18 INFO - Contents: 01:29:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2de1219512d8552a1c42ebad622fccf14e1108d930224108d723c0ee7fb9284e838576b80a9c2a74da6532e547642e07d393ed34cba5005e10f6ac5b4f6315f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b53602d5c15e6b0b63dd6ff97d64301632fbbd52d636dd1cd370378d089d1b99193c8c5d4b6e5fc2ff92121b47e003f23cac8187d26ecc0c96c9bcf4ed259c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d474b8c2afddc3295e47e59556e603e8bf170f82757d4ca0abc3ec45d6db4d2efb053fe1d2fdae11e3f47413fb100023febd88cbf1137ab6dd3979067b07580"} 01:29:18 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:18 INFO - Copying logs to upload dir... 01:29:18 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.797218 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-21 01:29:17.886673) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:17.889834) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2de1219512d8552a1c42ebad622fccf14e1108d930224108d723c0ee7fb9284e838576b80a9c2a74da6532e547642e07d393ed34cba5005e10f6ac5b4f6315f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b53602d5c15e6b0b63dd6ff97d64301632fbbd52d636dd1cd370378d089d1b99193c8c5d4b6e5fc2ff92121b47e003f23cac8187d26ecc0c96c9bcf4ed259c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d474b8c2afddc3295e47e59556e603e8bf170f82757d4ca0abc3ec45d6db4d2efb053fe1d2fdae11e3f47413fb100023febd88cbf1137ab6dd3979067b07580"} build_url:https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2de1219512d8552a1c42ebad622fccf14e1108d930224108d723c0ee7fb9284e838576b80a9c2a74da6532e547642e07d393ed34cba5005e10f6ac5b4f6315f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b53602d5c15e6b0b63dd6ff97d64301632fbbd52d636dd1cd370378d089d1b99193c8c5d4b6e5fc2ff92121b47e003f23cac8187d26ecc0c96c9bcf4ed259c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d474b8c2afddc3295e47e59556e603e8bf170f82757d4ca0abc3ec45d6db4d2efb053fe1d2fdae11e3f47413fb100023febd88cbf1137ab6dd3979067b07580"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:17.914882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:17.915212) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463812842.146584-518507312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:17.997137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:29:17.997457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:29:17.997714) ========= ========= Total master_lag: 0.15 =========