builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1464436871.65 results: success (0) buildid: 20160528023013 builduid: 082deb2ce0644edcbf76091fa2c1cc6b revision: 2e2c3435f648e36080c49c46416b710e0b52d55a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.652315) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.653114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.653400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.770752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.771413) ========= 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=923d835db2ba3686ebe126b700000192-1464436278.46699-534457818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 05:01:12-- 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% 37.9M=0s 2016-05-28 05:01:12 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076562 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.863558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.866914) ========= 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=923d835db2ba3686ebe126b700000192-1464436278.46699-534457818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019679 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.922053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.922417) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e2c3435f648e36080c49c46416b710e0b52d55a --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 2e2c3435f648e36080c49c46416b710e0b52d55a --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=923d835db2ba3686ebe126b700000192-1464436278.46699-534457818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 05:01:12,890 truncating revision to first 12 chars 2016-05-28 05:01:12,890 Setting DEBUG logging. 2016-05-28 05:01:12,890 attempt 1/10 2016-05-28 05:01:12,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e2c3435f648?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 05:01:13,233 unpacking tar archive at: fx-team-2e2c3435f648/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.599547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.599826) ========= script_repo_revision: 2e2c3435f648e36080c49c46416b710e0b52d55a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.600209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.600470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.609204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-28 05:01:12.609473) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=923d835db2ba3686ebe126b700000192-1464436278.46699-534457818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:13 INFO - MultiFileLogger online at 20160528 05:01:13 in /builds/slave/test 05:01:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:01:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:13 INFO - {'append_to_log': False, 05:01:13 INFO - 'base_work_dir': '/builds/slave/test', 05:01:13 INFO - 'blob_upload_branch': 'Fx-Team', 05:01:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:13 INFO - 'branch': 'Fx-Team', 05:01:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:13 INFO - 'config_files': ('talos/linux_config.py',), 05:01:13 INFO - 'default_actions': ('clobber', 05:01:13 INFO - 'read-buildbot-config', 05:01:13 INFO - 'download-and-extract', 05:01:13 INFO - 'populate-webroot', 05:01:13 INFO - 'create-virtualenv', 05:01:13 INFO - 'install', 05:01:13 INFO - 'run-tests'), 05:01:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:13 INFO - 'download_minidump_stackwalk': True, 05:01:13 INFO - 'download_symbols': 'ondemand', 05:01:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:13 INFO - 'installer_path': 'installer.exe', 05:01:13 INFO - 'log_level': 'info', 05:01:13 INFO - 'log_name': 'talos', 05:01:13 INFO - 'log_to_console': True, 05:01:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:13 INFO - 'opt_config_files': (), 05:01:13 INFO - 'pip_index': False, 05:01:13 INFO - 'sps_profile': False, 05:01:13 INFO - 'sps_profile_interval': 0, 05:01:13 INFO - 'suite': 'dromaeojs', 05:01:13 INFO - 'system_bits': '32', 05:01:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:13 INFO - 'title': 'talos-linux64-ix-007', 05:01:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:13 INFO - 'use_talos_json': True, 05:01:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:13 INFO - 'work_dir': 'build'} 05:01:13 INFO - ##### 05:01:13 INFO - ##### Running clobber step. 05:01:13 INFO - ##### 05:01:13 INFO - Running pre-action listener: _resource_record_pre_action 05:01:13 INFO - Running main action method: clobber 05:01:13 INFO - rmtree: /builds/slave/test/build 05:01:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:14 INFO - Running post-action listener: _resource_record_post_action 05:01:14 INFO - ##### 05:01:14 INFO - ##### Finished clobber step (success) 05:01:14 INFO - ##### 05:01:14 INFO - ##### 05:01:14 INFO - ##### Running read-buildbot-config step. 05:01:14 INFO - ##### 05:01:14 INFO - Running pre-action listener: _resource_record_pre_action 05:01:14 INFO - Running main action method: read_buildbot_config 05:01:14 INFO - Using buildbot properties: 05:01:14 INFO - { 05:01:14 INFO - "project": "", 05:01:14 INFO - "product": "firefox", 05:01:14 INFO - "script_repo_revision": "production", 05:01:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:01:14 INFO - "repository": "", 05:01:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:01:14 INFO - "buildid": "20160528023013", 05:01:14 INFO - "pgo_build": "True", 05:01:14 INFO - "basedir": "/builds/slave/test", 05:01:14 INFO - "buildnumber": 1199, 05:01:14 INFO - "slavename": "talos-linux64-ix-007", 05:01:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:01:14 INFO - "platform": "ubuntu64_hw", 05:01:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:01:14 INFO - "branch": "fx-team", 05:01:14 INFO - "repo_path": "integration/fx-team", 05:01:14 INFO - "revision": "2e2c3435f648e36080c49c46416b710e0b52d55a", 05:01:14 INFO - "stage_platform": "linux64-pgo", 05:01:14 INFO - "builduid": "082deb2ce0644edcbf76091fa2c1cc6b", 05:01:14 INFO - "slavebuilddir": "test" 05:01:14 INFO - } 05:01:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:01:14 INFO - Running post-action listener: _resource_record_post_action 05:01:14 INFO - ##### 05:01:14 INFO - ##### Finished read-buildbot-config step (success) 05:01:14 INFO - ##### 05:01:14 INFO - ##### 05:01:14 INFO - ##### Running download-and-extract step. 05:01:14 INFO - ##### 05:01:14 INFO - Running pre-action listener: _resource_record_pre_action 05:01:14 INFO - Running main action method: download_and_extract 05:01:14 INFO - mkdir: /builds/slave/test/build/tests 05:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:14 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:01:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:24 INFO - Downloaded 1361 bytes. 05:01:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:24 INFO - Using the following test package requirements: 05:01:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:01:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'jsshell-linux-x86_64.zip'], 05:01:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:24 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:38 INFO - Downloaded 24410672 bytes. 05:01:38 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'] 05:01:38 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 05:01:39 INFO - Return code: 0 05:01:39 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 05:01: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')]} 05:01:39 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:41 INFO - Downloaded 24410672 bytes. 05:01: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'] 05:01: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 05:01:42 INFO - Return code: 0 05:01: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')]} 05:01:42 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:44 INFO - Downloaded 10834034 bytes. 05:01:44 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'] 05:01:44 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 05:01:45 INFO - Return code: 0 05:01: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')]} 05:01:45 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:01:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/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 05:01:46 INFO - Downloaded 58757754 bytes. 05:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:46 INFO - mkdir: /builds/slave/test/properties 05:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:46 INFO - Contents: 05:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:47 INFO - Running post-action listener: _resource_record_post_action 05:01:47 INFO - Running post-action listener: set_extra_try_arguments 05:01:47 INFO - ##### 05:01:47 INFO - ##### Finished download-and-extract step (success) 05:01:47 INFO - ##### 05:01:47 INFO - ##### 05:01:47 INFO - ##### Running populate-webroot step. 05:01:47 INFO - ##### 05:01:47 INFO - Running pre-action listener: _resource_record_pre_action 05:01:47 INFO - Running main action method: populate_webroot 05:01:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:47 INFO - '--tppagecycles', 05:01:47 INFO - '7'], 05:01:47 INFO - 'tests': ['tsvgm']}}, 05:01:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['damp', 'tps']}, 05:01:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'tests': ['damp', 'tps']}, 05:01:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['dromaeo_dom']}, 05:01:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['a11yr', 05:01:47 INFO - 'ts_paint', 05:01:47 INFO - 'tpaint', 05:01:47 INFO - 'sessionrestore', 05:01:47 INFO - 'sessionrestore_no_auto_restore', 05:01:47 INFO - 'tabpaint']}, 05:01:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:47 INFO - 'ts_paint', 05:01:47 INFO - 'tpaint', 05:01:47 INFO - 'sessionrestore', 05:01:47 INFO - 'sessionrestore_no_auto_restore', 05:01:47 INFO - 'tabpaint']}, 05:01:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:47 INFO - 'ts_paint', 05:01:47 INFO - 'tpaint', 05:01:47 INFO - 'sessionrestore', 05:01:47 INFO - 'sessionrestore_no_auto_restore', 05:01:47 INFO - 'tabpaint']}, 05:01:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:47 INFO - 'ts_paint', 05:01:47 INFO - 'tpaint', 05:01:47 INFO - 'sessionrestore', 05:01:47 INFO - 'sessionrestore_no_auto_restore', 05:01:47 INFO - 'tabpaint']}, 05:01:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['a11yr', 05:01:47 INFO - 'ts_paint', 05:01:47 INFO - 'tpaint', 05:01:47 INFO - 'sessionrestore', 05:01:47 INFO - 'sessionrestore_no_auto_restore', 05:01:47 INFO - 'tabpaint']}, 05:01:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['a11yr', 05:01:47 INFO - 'ts_paint', 05:01:47 INFO - 'tpaint', 05:01:47 INFO - 'sessionrestore', 05:01:47 INFO - 'sessionrestore_no_auto_restore', 05:01:47 INFO - 'tabpaint']}, 05:01:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['tsvgx', 05:01:47 INFO - 'tsvgr_opacity', 05:01:47 INFO - 'tart', 05:01:47 INFO - 'tscrollx', 05:01:47 INFO - 'cart']}, 05:01:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:47 INFO - 'tsvgr_opacity', 05:01:47 INFO - 'tart', 05:01:47 INFO - 'tscrollx', 05:01:47 INFO - 'cart']}, 05:01:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'talos_options': ['--disable-e10s'], 05:01:47 INFO - 'tests': ['tp5o']}, 05:01:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'tests': ['tp5o']}, 05:01:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'talos_options': ['--disable-e10s', 05:01:47 INFO - '--xperf_path', 05:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:47 INFO - 'tests': ['tp5n']}, 05:01:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:47 INFO - 'talos_options': ['--xperf_path', 05:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:47 INFO - 'tests': ['tp5n']}}, 05:01:47 INFO - 'talos.zip': {'path': '', 05:01:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:47 INFO - Running post-action listener: _resource_record_post_action 05:01:47 INFO - ##### 05:01:47 INFO - ##### Finished populate-webroot step (success) 05:01:47 INFO - ##### 05:01:47 INFO - ##### 05:01:47 INFO - ##### Running create-virtualenv step. 05:01:47 INFO - ##### 05:01:47 INFO - Running pre-action listener: _resource_record_pre_action 05:01:47 INFO - Running main action method: create_virtualenv 05:01:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:47 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 05:01:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:47 INFO - Using real prefix '/usr' 05:01:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:49 INFO - Installing pip.................done. 05:01:49 INFO - Return code: 0 05:01:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:01:49 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')]} 05:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:49 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')]} 05:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:49 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:01:49 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 05:01:49 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 05:01:49 INFO - Using env: {'DISPLAY': ':0', 05:01:49 INFO - 'HOME': '/home/cltbld', 05:01:49 INFO - 'LANG': 'en_US.UTF-8', 05:01:49 INFO - 'LANGUAGE': 'en_US:en', 05:01:49 INFO - 'LOGNAME': 'cltbld', 05:01:49 INFO - 'MAIL': '/var/mail/cltbld', 05:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:49 INFO - 'MOZ_NO_REMOTE': '1', 05:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:49 INFO - 'NO_EM_RESTART': '1', 05:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:49 INFO - 'PWD': '/builds/slave/test', 05:01:49 INFO - 'SHELL': '/bin/bash', 05:01:49 INFO - 'SHLVL': '1', 05:01:49 INFO - 'TERM': 'linux', 05:01:49 INFO - 'TMOUT': '86400', 05:01:49 INFO - 'USER': 'cltbld', 05:01:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:49 INFO - '_': '/tools/buildbot/bin/python'} 05:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:50 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 05:01:50 INFO - Cleaning up... 05:01:50 INFO - Return code: 0 05:01:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:01:50 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')]} 05:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:50 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')]} 05:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:50 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:01:50 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 05:01:50 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 05:01:50 INFO - Using env: {'DISPLAY': ':0', 05:01:50 INFO - 'HOME': '/home/cltbld', 05:01:50 INFO - 'LANG': 'en_US.UTF-8', 05:01:50 INFO - 'LANGUAGE': 'en_US:en', 05:01:50 INFO - 'LOGNAME': 'cltbld', 05:01:50 INFO - 'MAIL': '/var/mail/cltbld', 05:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:50 INFO - 'MOZ_NO_REMOTE': '1', 05:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:50 INFO - 'NO_EM_RESTART': '1', 05:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:50 INFO - 'PWD': '/builds/slave/test', 05:01:50 INFO - 'SHELL': '/bin/bash', 05:01:50 INFO - 'SHLVL': '1', 05:01:50 INFO - 'TERM': 'linux', 05:01:50 INFO - 'TMOUT': '86400', 05:01:50 INFO - 'USER': 'cltbld', 05:01:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:50 INFO - '_': '/tools/buildbot/bin/python'} 05:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:50 INFO - Downloading/unpacking psutil>=3.1.1 05:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:52 INFO - Installing collected packages: psutil 05:01:52 INFO - Running setup.py install for psutil 05:01:52 INFO - building 'psutil._psutil_linux' extension 05:01:52 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 05:01:52 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 05:01:52 INFO - building 'psutil._psutil_posix' extension 05:01:52 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 05:01:52 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 05:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:52 INFO - Successfully installed psutil 05:01:52 INFO - Cleaning up... 05:01:52 INFO - Return code: 0 05:01:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:01:52 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')]} 05:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:52 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')]} 05:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:52 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:01:52 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 05:01:52 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 05:01:52 INFO - Using env: {'DISPLAY': ':0', 05:01:52 INFO - 'HOME': '/home/cltbld', 05:01:52 INFO - 'LANG': 'en_US.UTF-8', 05:01:52 INFO - 'LANGUAGE': 'en_US:en', 05:01:52 INFO - 'LOGNAME': 'cltbld', 05:01:52 INFO - 'MAIL': '/var/mail/cltbld', 05:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:52 INFO - 'MOZ_NO_REMOTE': '1', 05:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:52 INFO - 'NO_EM_RESTART': '1', 05:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:52 INFO - 'PWD': '/builds/slave/test', 05:01:52 INFO - 'SHELL': '/bin/bash', 05:01:52 INFO - 'SHLVL': '1', 05:01:52 INFO - 'TERM': 'linux', 05:01:52 INFO - 'TMOUT': '86400', 05:01:52 INFO - 'USER': 'cltbld', 05:01:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:52 INFO - '_': '/tools/buildbot/bin/python'} 05:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:01:54 INFO - Installing collected packages: mozsystemmonitor 05:01:54 INFO - Running setup.py install for mozsystemmonitor 05:01:55 INFO - Successfully installed mozsystemmonitor 05:01:55 INFO - Cleaning up... 05:01:55 INFO - Return code: 0 05:01:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:01:55 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')]} 05:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:55 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')]} 05:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:55 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:01:55 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 05:01:55 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 05:01:55 INFO - Using env: {'DISPLAY': ':0', 05:01:55 INFO - 'HOME': '/home/cltbld', 05:01:55 INFO - 'LANG': 'en_US.UTF-8', 05:01:55 INFO - 'LANGUAGE': 'en_US:en', 05:01:55 INFO - 'LOGNAME': 'cltbld', 05:01:55 INFO - 'MAIL': '/var/mail/cltbld', 05:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:55 INFO - 'MOZ_NO_REMOTE': '1', 05:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:55 INFO - 'NO_EM_RESTART': '1', 05:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:55 INFO - 'PWD': '/builds/slave/test', 05:01:55 INFO - 'SHELL': '/bin/bash', 05:01:55 INFO - 'SHLVL': '1', 05:01:55 INFO - 'TERM': 'linux', 05:01:55 INFO - 'TMOUT': '86400', 05:01:55 INFO - 'USER': 'cltbld', 05:01:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:55 INFO - '_': '/tools/buildbot/bin/python'} 05:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:01:55 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 05:01:55 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 05:01:55 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 05:01:55 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 05:01:55 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 05:01:55 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 05:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:01:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:57 INFO - Downloading docopt-0.6.1.tar.gz 05:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:57 INFO - Running setup.py install for blobuploader 05:01:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:01:58 INFO - Running setup.py install for requests 05:01:58 INFO - Running setup.py install for docopt 05:01:58 INFO - Successfully installed blobuploader requests docopt 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:58 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:01:58 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 05:01:58 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 05:01:58 INFO - Using env: {'DISPLAY': ':0', 05:01:58 INFO - 'HOME': '/home/cltbld', 05:01:58 INFO - 'LANG': 'en_US.UTF-8', 05:01:58 INFO - 'LANGUAGE': 'en_US:en', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MAIL': '/var/mail/cltbld', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SHLVL': '1', 05:01:58 INFO - 'TERM': 'linux', 05:01:58 INFO - 'TMOUT': '86400', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - '_': '/tools/buildbot/bin/python'} 05:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:58 INFO - Running setup.py (path:/tmp/pip-irlJhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:58 INFO - Running setup.py (path:/tmp/pip-aoqZvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:58 INFO - Running setup.py (path:/tmp/pip-yYlvLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:58 INFO - Running setup.py (path:/tmp/pip-RK3U24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:59 INFO - Running setup.py (path:/tmp/pip-FlADwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:59 INFO - Running setup.py (path:/tmp/pip-BQB7KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:59 INFO - Running setup.py (path:/tmp/pip-TroCVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:59 INFO - Running setup.py (path:/tmp/pip-x_B2b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:59 INFO - Running setup.py (path:/tmp/pip-Ywhg65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:59 INFO - Running setup.py (path:/tmp/pip-dpuU52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:59 INFO - Running setup.py (path:/tmp/pip-6VO1fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:59 INFO - Running setup.py (path:/tmp/pip-qi8nqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:59 INFO - Running setup.py (path:/tmp/pip-x7kARP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:59 INFO - Running setup.py (path:/tmp/pip-SlxKZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:59 INFO - Running setup.py (path:/tmp/pip-BYnXnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:59 INFO - Running setup.py (path:/tmp/pip-z6gZrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:59 INFO - Running setup.py (path:/tmp/pip-fKOD1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:59 INFO - Running setup.py install for manifestparser 05:02:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Running setup.py install for mozcrash 05:02:00 INFO - Running setup.py install for mozdebug 05:02:00 INFO - Running setup.py install for mozdevice 05:02:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Running setup.py install for mozfile 05:02:00 INFO - Running setup.py install for mozhttpd 05:02:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Running setup.py install for mozinfo 05:02:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Running setup.py install for mozInstall 05:02:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:00 INFO - Running setup.py install for mozleak 05:02:00 INFO - Running setup.py install for mozlog 05:02:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Running setup.py install for moznetwork 05:02:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Running setup.py install for mozprocess 05:02:01 INFO - Running setup.py install for mozprofile 05:02:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Running setup.py install for mozrunner 05:02:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Running setup.py install for mozscreenshot 05:02:01 INFO - Running setup.py install for moztest 05:02:01 INFO - Running setup.py install for mozversion 05:02:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:01 INFO - Cleaning up... 05:02:01 INFO - Return code: 0 05:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:02:01 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 05:02:01 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 05:02:01 INFO - Using env: {'DISPLAY': ':0', 05:02:01 INFO - 'HOME': '/home/cltbld', 05:02:01 INFO - 'LANG': 'en_US.UTF-8', 05:02:01 INFO - 'LANGUAGE': 'en_US:en', 05:02:01 INFO - 'LOGNAME': 'cltbld', 05:02:01 INFO - 'MAIL': '/var/mail/cltbld', 05:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:01 INFO - 'MOZ_NO_REMOTE': '1', 05:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:01 INFO - 'NO_EM_RESTART': '1', 05:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:01 INFO - 'PWD': '/builds/slave/test', 05:02:01 INFO - 'SHELL': '/bin/bash', 05:02:01 INFO - 'SHLVL': '1', 05:02:01 INFO - 'TERM': 'linux', 05:02:01 INFO - 'TMOUT': '86400', 05:02:01 INFO - 'USER': 'cltbld', 05:02:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:01 INFO - '_': '/tools/buildbot/bin/python'} 05:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:01 INFO - Running setup.py (path:/tmp/pip-TdHRz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:02 INFO - Running setup.py (path:/tmp/pip-qDcbNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:02 INFO - Running setup.py (path:/tmp/pip-9deE1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:02 INFO - Running setup.py (path:/tmp/pip-FZi4FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:02 INFO - Running setup.py (path:/tmp/pip-YZ0UVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:02 INFO - Running setup.py (path:/tmp/pip-699iGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:02 INFO - Running setup.py (path:/tmp/pip-FLbeO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:02 INFO - Running setup.py (path:/tmp/pip-GVzsb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:02 INFO - Running setup.py (path:/tmp/pip-nxts6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:02 INFO - Running setup.py (path:/tmp/pip-4KYEQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:02 INFO - Running setup.py (path:/tmp/pip-EVM_RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:02 INFO - Running setup.py (path:/tmp/pip-BCYr6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:02 INFO - Running setup.py (path:/tmp/pip-cLay0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:02 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)) 05:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:02 INFO - Running setup.py (path:/tmp/pip-vyAbWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:03 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)) 05:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:03 INFO - Running setup.py (path:/tmp/pip-CtDLky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:03 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)) 05:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:03 INFO - Running setup.py (path:/tmp/pip-wEzoiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:03 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)) 05:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:03 INFO - Running setup.py (path:/tmp/pip-7eFp32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:03 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)) 05:02:03 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)) 05:02:03 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)) 05:02:03 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)) 05:02:03 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)) 05:02:03 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)) 05:02:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:05 INFO - Downloading blessings-1.6.tar.gz 05:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:05 INFO - Installing collected packages: blessings 05:02:05 INFO - Running setup.py install for blessings 05:02:05 INFO - Successfully installed blessings 05:02:05 INFO - Cleaning up... 05:02:05 INFO - Return code: 0 05:02:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:05 INFO - Reading from file tmpfile_stdout 05:02:05 INFO - Current package versions: 05:02:05 INFO - argparse == 1.2.1 05:02:05 INFO - blessings == 1.6 05:02:05 INFO - blobuploader == 1.2.4 05:02:05 INFO - docopt == 0.6.1 05:02:05 INFO - manifestparser == 1.1 05:02:05 INFO - mozInstall == 1.12 05:02:05 INFO - mozcrash == 0.17 05:02:05 INFO - mozdebug == 0.1 05:02:05 INFO - mozdevice == 0.48 05:02:05 INFO - mozfile == 1.2 05:02:05 INFO - mozhttpd == 0.7 05:02:05 INFO - mozinfo == 0.9 05:02:05 INFO - mozleak == 0.1 05:02:05 INFO - mozlog == 3.2 05:02:05 INFO - moznetwork == 0.27 05:02:05 INFO - mozprocess == 0.22 05:02:05 INFO - mozprofile == 0.28 05:02:05 INFO - mozrunner == 6.11 05:02:05 INFO - mozscreenshot == 0.1 05:02:05 INFO - mozsystemmonitor == 0.3 05:02:05 INFO - moztest == 0.7 05:02:05 INFO - mozversion == 1.4 05:02:05 INFO - psutil == 3.1.1 05:02:05 INFO - requests == 1.2.3 05:02:05 INFO - wsgiref == 0.1.2 05:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:05 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 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:02:05 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 05:02:05 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 05:02:05 INFO - Using env: {'DISPLAY': ':0', 05:02:05 INFO - 'HOME': '/home/cltbld', 05:02:05 INFO - 'LANG': 'en_US.UTF-8', 05:02:05 INFO - 'LANGUAGE': 'en_US:en', 05:02:05 INFO - 'LOGNAME': 'cltbld', 05:02:05 INFO - 'MAIL': '/var/mail/cltbld', 05:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:05 INFO - 'MOZ_NO_REMOTE': '1', 05:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:05 INFO - 'NO_EM_RESTART': '1', 05:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:05 INFO - 'PWD': '/builds/slave/test', 05:02:05 INFO - 'SHELL': '/bin/bash', 05:02:05 INFO - 'SHLVL': '1', 05:02:05 INFO - 'TERM': 'linux', 05:02:05 INFO - 'TMOUT': '86400', 05:02:05 INFO - 'USER': 'cltbld', 05:02:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:05 INFO - '_': '/tools/buildbot/bin/python'} 05:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 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)) 05:02:05 INFO - Cleaning up... 05:02:05 INFO - Return code: 0 05:02:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:02:05 INFO - Using env: {'DISPLAY': ':0', 05:02:05 INFO - 'HOME': '/home/cltbld', 05:02:05 INFO - 'LANG': 'en_US.UTF-8', 05:02:05 INFO - 'LANGUAGE': 'en_US:en', 05:02:05 INFO - 'LOGNAME': 'cltbld', 05:02:05 INFO - 'MAIL': '/var/mail/cltbld', 05:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:05 INFO - 'MOZ_NO_REMOTE': '1', 05:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:05 INFO - 'NO_EM_RESTART': '1', 05:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:05 INFO - 'PWD': '/builds/slave/test', 05:02:05 INFO - 'SHELL': '/bin/bash', 05:02:05 INFO - 'SHLVL': '1', 05:02:05 INFO - 'TERM': 'linux', 05:02:05 INFO - 'TMOUT': '86400', 05:02:05 INFO - 'USER': 'cltbld', 05:02:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:05 INFO - '_': '/tools/buildbot/bin/python'} 05:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:06 INFO - Downloading/unpacking jsonschema 05:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:08 INFO - warning: no files found matching '*.txt' 05:02:08 INFO - no previously-included directories found matching 'build' 05:02:08 INFO - no previously-included directories found matching 'dist' 05:02:08 INFO - no previously-included directories found matching '.git*' 05:02:08 INFO - Installing collected packages: jsonschema, functools32 05:02:08 INFO - Running setup.py install for functools32 05:02:08 INFO - warning: no files found matching '*.txt' 05:02:08 INFO - no previously-included directories found matching 'build' 05:02:08 INFO - no previously-included directories found matching 'dist' 05:02:08 INFO - no previously-included directories found matching '.git*' 05:02:08 INFO - Successfully installed jsonschema functools32 05:02:08 INFO - Cleaning up... 05:02:08 INFO - Return code: 0 05:02:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05f771f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b608e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, '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': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', '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 05:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:02:08 INFO - Using env: {'DISPLAY': ':0', 05:02:08 INFO - 'HOME': '/home/cltbld', 05:02:08 INFO - 'LANG': 'en_US.UTF-8', 05:02:08 INFO - 'LANGUAGE': 'en_US:en', 05:02:08 INFO - 'LOGNAME': 'cltbld', 05:02:08 INFO - 'MAIL': '/var/mail/cltbld', 05:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:08 INFO - 'MOZ_NO_REMOTE': '1', 05:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:08 INFO - 'NO_EM_RESTART': '1', 05:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:08 INFO - 'PWD': '/builds/slave/test', 05:02:08 INFO - 'SHELL': '/bin/bash', 05:02:08 INFO - 'SHLVL': '1', 05:02:08 INFO - 'TERM': 'linux', 05:02:08 INFO - 'TMOUT': '86400', 05:02:08 INFO - 'USER': 'cltbld', 05:02:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:08 INFO - '_': '/tools/buildbot/bin/python'} 05:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:08 INFO - Downloading/unpacking flake8 05:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:02:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:02:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:11 INFO - no previously-included directories found matching 'docs/_build' 05:02:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:02:11 INFO - Running setup.py install for pep8 05:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:11 INFO - no previously-included directories found matching 'docs/_build' 05:02:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:02:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:02:11 INFO - Cleaning up... 05:02:11 INFO - Return code: 0 05:02:11 INFO - Running post-action listener: _resource_record_post_action 05:02:11 INFO - Running post-action listener: _start_resource_monitoring 05:02:11 INFO - Starting resource monitoring. 05:02:11 INFO - ##### 05:02:11 INFO - ##### Finished create-virtualenv step (success) 05:02:11 INFO - ##### 05:02:11 INFO - ##### 05:02:11 INFO - ##### Running install step. 05:02:11 INFO - ##### 05:02:11 INFO - Running pre-action listener: _resource_record_pre_action 05:02:11 INFO - Running main action method: install 05:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:11 INFO - Reading from file tmpfile_stdout 05:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:11 INFO - Reading from file tmpfile_stdout 05:02:11 INFO - Output received: 05:02:11 INFO - Usage: mozinstall [options] installer 05:02:11 INFO - Options: 05:02:11 INFO - -h, --help show this help message and exit 05:02:11 INFO - -d DEST, --destination=DEST 05:02:11 INFO - Directory to install application into. [default: 05:02:11 INFO - "/builds/slave/test"] 05:02:11 INFO - --app=APP Application being installed. [default: firefox] 05:02:11 INFO - mkdir: /builds/slave/test/build/application 05:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:02:28 INFO - Reading from file tmpfile_stdout 05:02:28 INFO - Output received: 05:02:28 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:28 INFO - Running post-action listener: _resource_record_post_action 05:02:28 INFO - ##### 05:02:28 INFO - ##### Finished install step (success) 05:02:28 INFO - ##### 05:02:28 INFO - ##### 05:02:28 INFO - ##### Running run-tests step. 05:02:28 INFO - ##### 05:02:28 INFO - Running pre-action listener: _resource_record_pre_action 05:02:28 INFO - Running main action method: run_tests 05:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:28 INFO - Python 2.7.3 05:02:28 INFO - Return code: 0 05:02:28 INFO - grabbing minidump binary from tooltool 05:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:28 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 0x2befb20>, '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 0x2bf0a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf0eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:28 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 05:02:28 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 05:02:28 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 05:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:28 INFO - Return code: 0 05:02:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:02:29 INFO - Return code: 0 05:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:02:29 INFO - Using env: {'DISPLAY': ':0', 05:02:29 INFO - 'HOME': '/home/cltbld', 05:02:29 INFO - 'LANG': 'en_US.UTF-8', 05:02:29 INFO - 'LANGUAGE': 'en_US:en', 05:02:29 INFO - 'LOGNAME': 'cltbld', 05:02:29 INFO - 'MAIL': '/var/mail/cltbld', 05:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:29 INFO - 'MOZ_NO_REMOTE': '1', 05:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:29 INFO - 'NO_EM_RESTART': '1', 05:02:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:29 INFO - 'PWD': '/builds/slave/test', 05:02:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:29 INFO - 'SHELL': '/bin/bash', 05:02:29 INFO - 'SHLVL': '1', 05:02:29 INFO - 'TERM': 'linux', 05:02:29 INFO - 'TMOUT': '86400', 05:02:29 INFO - 'USER': 'cltbld', 05:02:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1464436278.46699-534457818', 05:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:29 INFO - '_': '/tools/buildbot/bin/python'} 05:02:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:02:29 INFO - mozversion application_buildid: 20160528023013 05:02:29 INFO - mozversion application_changeset: 2e2c3435f648e36080c49c46416b710e0b52d55a 05:02:29 INFO - mozversion application_display_name: Nightly 05:02:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:29 INFO - mozversion application_name: Firefox 05:02:29 INFO - mozversion application_remotingname: firefox 05:02:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:02:29 INFO - mozversion application_vendor: Mozilla 05:02:29 INFO - mozversion application_version: 49.0a1 05:02:29 INFO - mozversion platform_buildid: 20160528023013 05:02:29 INFO - mozversion platform_changeset: 2e2c3435f648e36080c49c46416b710e0b52d55a 05:02:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:02:29 INFO - mozversion platform_version: 49.0a1 05:02:29 INFO - using testdate: 1464436949 05:02:29 INFO - actual date: 1464436949 05:02:29 INFO - starting webserver on 'localhost:34077' 05:02:29 INFO - SUITE-START | Running 2 tests 05:02:29 INFO - TEST-START | dromaeo_css 05:02:29 INFO - operating with platform_type : linux_ 05:02:29 INFO - Initialising browser for dromaeo_css test... 05:02:29 INFO - TEST-INFO | started process 22780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQGQpk/profile http://localhost:34077/getInfo.html) 05:02:33 INFO - PROCESS | 22780 | __metrics Screen width/height:1600/1200 05:02:33 INFO - PROCESS | 22780 | colorDepth:24 05:02:33 INFO - PROCESS | 22780 | Browser inner width/height: 1024/697 05:02:33 INFO - PROCESS | 22780 | __metrics 05:02:34 ERROR - PROCESS | 22780 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:35 INFO - TEST-INFO | 22780: exit 0 05:02:35 INFO - Browser initialized. 05:02:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:35 INFO - TEST-INFO | started process 22861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQGQpk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:47 INFO - PROCESS | 22861 | RSS: Main: 155799552 05:02:47 INFO - PROCESS | 22861 | 05:03:38 INFO - PROCESS | 22861 | 1464437018159 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] 05:05:46 INFO - PROCESS | 22861 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34077/tests/dromaeo/cssquery-ext.html) 05:05:47 INFO - PROCESS | 22861 | RSS: Main: 254341120 05:05:47 INFO - PROCESS | 22861 | 05:08:49 INFO - PROCESS | 22861 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-ext.html (next: http://localhost:34077/tests/dromaeo/cssquery-jquery.html) 05:08:50 INFO - PROCESS | 22861 | RSS: Main: 243978240 05:08:50 INFO - PROCESS | 22861 | 05:11:52 INFO - PROCESS | 22861 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34077/tests/dromaeo/cssquery-mootools.html) 05:11:52 INFO - PROCESS | 22861 | RSS: Main: 240504832 05:11:52 INFO - PROCESS | 22861 | 05:14:54 INFO - PROCESS | 22861 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34077/tests/dromaeo/cssquery-prototype.html) 05:14:55 INFO - PROCESS | 22861 | RSS: Main: 239980544 05:14:55 INFO - PROCESS | 22861 | 05:17:57 INFO - PROCESS | 22861 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34077/tests/dromaeo/cssquery-yui.html) 05:17:58 INFO - PROCESS | 22861 | RSS: Main: 207159296 05:17:58 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-yui.html (next: http://localhost:34077/tests/dromaeo/cssquery-dojo.html) 05:21:01 INFO - PROCESS | 22861 | RSS: Main: 268636160 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | __start_tp_report 05:21:01 INFO - PROCESS | 22861 | _x_x_mozilla_page_load 05:21:01 INFO - PROCESS | 22861 | _x_x_mozilla_page_load_details 05:21:01 INFO - PROCESS | 22861 | |i|pagename|runs| 05:21:01 INFO - PROCESS | 22861 | |0;dojo.html;3147.354792267585;3150.4644210484216;3165.7783955123145;3193;3211.7270032047277;5258;5351.063563876316;5352.705601191933;5451.754671039803;5456.754446049922;5316.043112239795;5322.92015619766;5328.520433161015;5338.306020217376;5380.811671591495;4783.880402989918;4868.707877527359;4879.341288926003;4886.413630364361;5116.155834287357;4996.475370086125;5042.344495215617;5072.442031376546;5076.36545431821;5120.487951204868;4758.45277793053;4834.154023045953;4878.585320247766;4882.584980276681;4923.433805112422;4812.951870481285;4836.298736683161;4848.466668666444;4903.117438861003;4960.826371076995;4893.926591101136;4896.436909755388;4906.239532872411;4907.1657818171;4908.852734417973;5212.192110222922;5295.761690723926;5361.035013697533;5422.593305502103;5440.455954404528;5820.534357251409;5859.648421094748;5886.852828679274;5892.322382925932;5897.8820423591715;5580.832575022756;5778.913316300259;5788.102844059177;5795.942040579583;5850.385709500526;5341.03861304965;5374.7043912584795;5387.380451248117;5476.205950137208;5480.177973303957;5985.940140598538;5991.55063370249;5999.370066143079;6000.0999850022845;6008.849778755479;5485.6434331768305;5657.349404818498;5753.654780713171;5759.308882934075;5772.076467765138;5782.7686892523825;5835.416458354131;5891.293044834647;5892.057270836645;5892.734826932799;5769.740361683735;5794.449527294901;5797;5805.8548536286935;5811.157382179645;5541.085720856095;5709;5770.076787713946;5797.913031304533;5808;4427.535108813592;4439.156560253541;4445.488768791565;4482.305242687388;4484.955150448519;3953.5651078381356;3956.7032472564674;3959.6436320731273;3992.500937382827;4004.419359192959;5310.3627564691715;5356.1697936819855;5444.537214336826;5466.781328746805;5477.397486276506;5786.392428795;5801.796937107181;5811.593188476851;5823.301203855564;5855.3266374367495;5506.531944784658;5517.089680202802;5517.586181036439;5518.944810551923;5521.309836270466;4764.237721964469;4913.385826771653;4922.803087876517;4933.629977751683;4944.554990050912;5995.160677505153;5995.280566332068;6006.159137720722;6008.969955150196;6016.067509536029;5766.221560089334;5773.971130144322;5778.393268706725;5781.971090144522;5782.392848750821;5903.527717782481;5970.850728731816;6019.398060193946;6023.27720673522;6074.848128796815;5681.602287839812;5725.742341594555;5729.942700573108;5731.541476681772;5731.942680573141;5602.831915042555;5821.825345239649;5836.649801011953;5838.532917366685;5839.620424672553;5609.018421776092;5616.69108199053;5664.49019588239;5699.572532060195;5700.315962084576;5641.661500309994;5690.174924635988;5697.886042279214;5698.2592263005545;5700.458456446631;5421.972890135524;5514.91727624078;5604.6356986797355;5607.41122182165;5610.663360198401;5699.116636921284;5802.47777700009;5811.476967072984;5812.128180772749;5819.098039803837;5593.972030139986;5640.294963129609;5645.830625081254;5649.7740090397565;5679.801206957736 05:21:01 INFO - PROCESS | 22861 | |1;ext.html;593.1281016905151;613.4938675592637;633.2527617411454;642.290269252476;650.3041745332495;29956.850215748917;32458.837705811467;32579.51130733035;45796.542034579645;46663.766681166635;44911.326330105076;45182.54817451825;45475.545244547546;45492;45681.31478027824;8675.08911564286;8858.424202426822;8862.556872156398;8868.778280542974;8870.467771933705;7928.80177995549;8749.081346458594;10355.534000969974;10608.893911060868;10617.73455663607;10709.25035247533;10784.838227426595;10788.298760580537;10790.78418431631;10794.838077428845;7791.571463569501;10617.57529698815;10690.62582809598;10695.037446629802;10726.570937162503;10427.270091093627;10913;10914.836277455845;10917.672469825919;10928.180386470967;41684.58315416868;42221;42244.788776055924;42249.1550168998;42319.788401058104;3494.973800125271;3514.1917359007316;3541.8229088545727;3552.5559305086863;3695.63043695631;30464.54303185454;33086;33337.49993750072;33339.499907501406;33394;4327.653787696977;4367.497737760134;4377.4528183977;4393.780310984438;4511.548845115462;363210;366092;366444.9999999973;366568.9999999973;366708;60738;61575.692121539105;61607.38392616106;61679.07481387783;61788.69105654443;65319.34680653133;65407;65801.67099164473;66177.66911165413;66213.33786662071;16779.244933978;17032.48902532926;17034.659306814043;17037.233324500427;17044.829551704323;10718.785624287471;10732.94633526843;10733.463326833627;10733.83899241512;10869.45652717361;17734.95081591111;19611.509712257306;19808.40574782759;19817.504562386057;19848.60302793936;6973.721051157897;7234.710611575478;7370.410367170613;7384.59384733834;7415.85168296631;1024.2727663358949;1079.2930630437077;1093.6992327110108;1165.2600598619938;1215.2040413528975;33089.834550827574;33449;33492.66507334944;33526;33953.32093358119;1018.23123541727;1048.8741351037772;1060.2260349944584;1062.7236918401272;1091.93994330311;17093.23080461382;17463.30146794114;17521.386751463637;17656;17692.557686057695;528174;529785;529793;529908;530888;59249;59559.40440595625;59850.80298394008;59857.415684274696;59879;1341.6578772413168;1351.196038357176;1392.6587985943509;1427.6716355238354;1434.3545404567778;31108.533371998987;32238.35523289568;32402.83798580992;32476;33038.83480582582;51804;51845.22232166445;52047.47952520426;52092.479075208765;52269.7386513065;424361;425867;426131;426316;426347;23202;23843.761562384156;27628.447431051667;28104.156875293775;28685;43895.56104439042;47814;48134;48918.51081489139;49023.50976490189;39874.40188397234;40901.59098408978;41447.792761036;41709.79145104255;41787.58212417837;39639.2072158561;39701.20597587974;39991.80004099961;40520.594794051685;40649.593504065764;40365.79817100896;41380.79309603433;41774.1645167101;41988.58011419847;42152.36771448369;35305.47041794426;36563.26873462569;36711.63288367082;36912.44631330586;37539.81230093832;28245.43509129847;28250.576241355986;28296.85851570729;28410.715892840806;28548.286292842844 05:21:01 INFO - PROCESS | 22861 | |2;jquery.html;361.2017441454384;367.59197291006996;371.9140110876242;373.0915221435804;388.9611038896109;17829.55426114346;19549.315773947877;19583.118759655816;19723.21107155712;20001.899990500027;17748;18657.16042778075;19285.710714339297;19432.125554350052;19487.902560487215;5318.202269659543;5342.759575819078;5496.697681627509;5536.778528858841;5573.303337082864;5411.972940135293;5434.239206511092;5448.591355648323;5451.236826844245;5494.5054945054935;5411.107167317388;5445.83662490126;5454.563634909217;5456.072467680484;5457.508824205821;5277.736113194325;5389.353277606712;5415.972920135414;5420.295361603005;5454.781808727646;3619.8552057917914;4848.927266091011;4933.80264789408;4943.777530011158;4944.604431645495;20924.372268831958;21123.15507379703;21560.245391411383;21584.352469425943;21807.45481362963;2304.4584522637165;2409.590369637166;2524.5708229600828;2779.1106845809145;3078.4766589679807;14499.347529361205;14535.418583256656;14536.418543258256;14608.196549189897;15041.398344066225;1918.1176658736997;1934.4390126863193;1955.599102184049;1991.5220347116588;2019.545602239499;52218.7389063056;71053.644731776;76714.23285767183;78336.60831695805;79041.60479197625;10305.381677099398;10454.11140053104;10642.946785266178;10728;10819.242653014213;14852.405903763945;14915.850841491447;14935.17856517902;14948.252587370587;14964.176970266522;7995.480293780885;8115.959420202861;8143.267105960374;8252.20398616643;8314.41799074059;7862.685492580347;7870.763877083697;7914.169012253746;7996.800079998046;8037.799055023671;6636.082469157622;6734.8989765153565;6744.516206434577;6765.424938880152;6773.45812335012;1789.5257756694486;1892.3187652445383;1899.7150427435995;1915.8754680945972;1920.5198700324918;880.8942926848691;963.3641796414473;1086.7174534621056;1103.25530267071;1124.083871644607;19177.232910683415;19689.901550492155;19826.306079287446;19876.70184947227;20327.796722032886;1010.8534262532039;1021.4841505039907;1033.4109557552274;1045.9633912813015;1047.6490375724065;10982.670519884416;11712.648620541397;11712.765744685228;11721.531138754524;11745.236559623598;457263;477637;478899;481739;505558;79429;81020;81480;82632;84728.15271847325;1026.0867827633413;1043.1706793099352;1043.8277684182026;1061.766411389493;1062.0812996757904;17699;17714.468565943043;18163.727544087113;18194.636107278046;18378.081095945417;37062.814685926394;39765.005874852206;41476.377854332815;42131;44204.77897610491;57336;57776.71111644415;58523.70738146282;60249;61437;7990.560519171501;8326.333893288644;8357.749267521984;8364.790880228044;8445.619947102272;9145.405548639583;13508.39212235432;13741.732614118559;13943.721125577229;14260.572182834532;10708.30396024256;10868.782624347627;11848.881511184778;12021.09841761854;12477.313747743961;11282.94358528235;11626.360550169484;11668;11748.177627565989;12055.51777928873;11732.354720490455;11785.587504437304;12263.26420414778;12363.62909112728;12364.876351236373;8305.127961563949;8404.831903362021;8430.15698430152;8669.133086691532;8898.644054238017;8498.107698691549;10734.785304293715;10927.945360273148;11006.889931100586;11612.400155951682 05:21:01 INFO - PROCESS | 22861 | |3;mootools.html;1170.4849866058928;1326.4760419634244;1435.9999999999998;1489.404238304678;1872.6441976024555;8723.607437665305;9081.954590227047;9133.634654613825;9345.532723363838;9358.485283309416;9062.592183351748;9230.769230769234;9255.907440925588;9267.026962168977;9269.953650231757;1998.620262150194;2056.3008577083788;2237.1498830444407;2240.831937604682;2269.943251418711;2257.3905045637666;2269.126386341254;2270.863748175115;2273.8521996070203;2273.954520909581;2311.6185829338137;2313.063209400196;2314.3982564533258;2335.74306826249;2344.9648255276184;1909.2458478900826;2172.2722887832597;2233.6426171812595;2244.831637627168;2282.087165133943;2229.67669687896;2230.921917732888;2245.8427910046303;2249.876256805875;2253.1212826997485;9081.182693557612;9083.909160908372;9127.680531181377;9139.360244782867;9139.45163290198;4941.085899108676;5043.899122017576;5055.570276526463;5067.670601410897;5072.923906141411;3027.7275045246033;3161.8893338733033;3209.0854106579513;3212.9678703212903;3272.5091236314506;1060.3213943076437;1073.2272763610188;1084.7146131833724;1096.1011970184452;1129.3393364881554;13006.479740810357;13053;13053.804192937114;13057.934710326388;13060.542880999119;4196.832126714898;4307.698461107755;4393.604575588212;4395.384646149478;4397.846075387346;10708.571657133783;10733.946330268454;10757.56969721218;10757.623483178051;10760.300580462244;5157.484251574812;5166.070107380708;5168.2764412982215;5169.663971841818;5170.508801663836;4099.139180772071;4700.811967521261;4805.5915247204375;4848.272759086165;4909.680870743462;3761.078535758702;3872.341701910682;3876.476675648808;3900.921981560353;3972.1459886124044;1194.964151075469;1198.8681245063035;1200.9759804803855;1240.2930329711978;1240.8386909701862;994.8408254679216;1028.069597014688;1046.984295235572;1048.4757621189406;1050.564015933379;6340.778072767524;6353.3329000455215;6419.614823110628;6446.258680251737;6502.370138733794;403.58833989331305;403.9050823056579;410.6817216657055;442.6348262683299;458.35829838226084;4303.203907277101;4477.910441791146;4481.641468682497;4503.099380123923;4515.5484451554585;11124.721881952853;11462.885371146182;11497.712557186138;11531.596394126165;11553.13351498641;11351.091912646969;11406.258593191416;11406.714832129097;11421.200515963803;11455.427228638535;7998.280154785981;8203.261706446448;8208.015038195455;8223.177682231848;8537.060923298432;6088.908666369919;6275.592086514362;6286.685665716787;6289.779857704958;6438.710258038306;10583.36499809983;10593.89406105929;10860.67417977462;10910.290831095954;10925.781484370427;10689.09142722846;10992.17558683086;11000.22998390105;11046.447677616248;11121.110311175249;7796.84406311882;8256.174382561696;8398.286145677686;8520.446170998865;8950.820983580423;8767.605457754544;8790.956045219733;8837.734867953972;8843.07147749477;8851.734447966572;7685.923140768521;7851.4503984722805;7903.486273392211;7964.880526791987;8007.719729809429;7646.541207527566;7750.651220695195;7808;7924.762257132295;8026.317762989977;7153.2131465537705;7254.347108760237;7325.670344834602;7339.486235963432;7344.96327518359;5557.472040156179;5589.441055894541;5610.943890561042;5653.604247702621;5669.801556945487;5356.491133342326;5393.325834270716;5492.148716948879;5618.775248989995;5640.041192997118 05:21:01 INFO - PROCESS | 22861 | |4;prototype.html;310.93314937288477;311.8253777884385;315.15695514498725;317.0931136948326;318.18227156208536;5260.447652996433;5310.6017048721405;5342.813001544947;5347.144456886904;5349.251104845324;5267.28891599634;5296.867578310535;5299.629025968184;5308.787648494065;5341.679499230039;3965.8215380307956;4006.599340065999;4037.4751282333254;4056.553779084313;4074.8166332515107;4103.932977425861;4121.278776214165;4128.463299771026;4130.524989626201;4148.605882441163;3992.141689536749;4048.9190216195657;4051.210014047262;4075.2257071156387;4110.979445102786;4002.4196491508715;4016.397540368968;4068.1863627274665;4072.348424252135;4096.877093687194;3519.5248641433336;3519.560054993126;3525.1715846775987;3558.2527669189503;3558.3417067842533;5030.170021946375;5034.320366750479;5055.9241611375855;5060.304797892711;5060.46865079165;4482.170798402306;4586.4266966629175;4590.517995610479;4602.240630295997;4695.3661255730385;5514.420985796473;5525.309336332958;5551.417845913895;5553.944460555424;5561.582881283879;3942.448057271984;3953.881383558498;3954.3277642800795;3956.8812935611977;3964.1477082427127;5539.695316757577;5768.42315768424;5797.898399304161;5803;5817.360090390053;3997.6402123809;4004.4994375703036;4005.2590270799415;4017.738846974937;4049.453323801308;4088.795560221977;4092.7544347339253;4095.877123686294;4103.343465045578;4132.586741325904;4689.116193541016;4724.196886529298;4739.976300118477;4740.478547359788;4743.715377077387;5359.22291267764;5634.520810843216;5650.180723795027;5655.208270842086;5669.177969194444;1383.4604504243352;1397.5318268380004;1397.9515363477392;1398.727248186594;1404.1434724817852;868.3400615532241;878.6573236437795;880.6961598248594;890.283321925856;901.544719916438;5046.6719663221775;5246.213068039825;5277.944411117792;5394.514493695587;5455.61810673257;5657.660540367591;5765.365809760923;5781.364049954502;5800.9419905800405;5843.766249349978;5428.375736790241;5434.021876062347;5434.782608695687;5437.510624043855;5443.550402318972;2878.992352676532;3042.239440139965;3043.421749867518;3044.3302473455806;3051.7406020488065;5936.970315148396;5958.735680441405;5983.19226904371;6018.608790428608;6089.8477538061015;5642.492175704207;5730.3410107838135;5814.215080964016;5877.941220587825;5926.851828704317;5905.379935106838;5911.9113213301835;5965.4631083203585;5970.253718285215;5978.1929439525975;5689;5702.543796496353;5731.398203188772;5745.937001654707;5747.166660834239;5440.292761940922;5624.437556244343;5637.774489020393;5679.716014199356;5683.2895888014;5952.255968003999;5979.671118088547;5996.010658241341;6002.05899109442;6015.368386319548;3746.756460830037;3985.8405663773124;4000.7999600020466;4016.779077150668;4032.91934161321;5729.455701708331;5744.913826292525;5751.568632352674;5761.164631128379;5768;5561.332640083216;5612.130119831432;5652.604317697722;5661.830145095653;5677.687727175045;5465.672059676433;5480;5575.944240557543;5602.2717046783655;5615.399611110814;5469.581511555278;5474.233607295061;5514.255575497417;5523.6409633373705;5561.63849349791;5399.7300134993875;5640.251522028185;5645.576581756302;5656.632318899258;5694.601377903507;5428.538574221236;5449.7275136243825;5489.231507589021;5514.531264842533;5535.557155427637 05:21:01 INFO - PROCESS | 22861 | |5;yui.html;779.306417288613;809.1301850510703;825.3727167352812;827.5489858027374;843.7215718812796;14359.64100897478;14858.108513489198;14881.18153501557;15063.322150503227;15102.244887755623;13249.801252981213;13891.305434728274;13913.443462261497;14208.147511149338;14259.71480570388;508.29093414686673;776.7747353267546;781.4959351218475;783.1346362269695;792.7819849541364;780.8438312337555;780.9570473623949;781.03932163439;781.0861292288037;801.791534201109;830.5265998380926;831.7296878514477;831.8045259364075;832.142892820393;832.317499650287;574.3050908400819;822.2024636102971;830.796454868558;833.5415521463201;852.6972924611736;612.1674522649193;612.6783438694677;613.4785432382483;613.628754603463;615.4030590327375;14378.640533986629;14386.064905781195;14399.78400323996;14406.279686015658;14409.351579178961;12919.67700807478;13208.471661133543;13307.20156790586;13359.599212023655;13516.932415337958;12292.815607765891;12450.875491245153;12499.937500312531;12649.43077561512;12882.098253122285;4383.802728877208;4429.313456414261;4481.663875209372;4623.0522742837975;4624.861254162381;58316.708416457644;59598.70200649012;59617;60188.699056504876;60264.39735602632;10794.488771571987;10811.783764324828;10915;10984.340939543654;11096.1123110151;18663.72004419935;18860.339888103852;18874.716879246822;18878.811211887707;18958;7611.238876112345;7878.566678832719;7968.641411136513;7973.0830954439825;8048.59757012147;4682.836100736458;4692.225782745809;4696.788644511005;4808.519148085234;4887.877803054952;3084.30603114302;3133.529970504397;3143;3146.197719581538;3166.5725127107544;589.4341432225112;590.9202257695242;591.257971246092;591.5474661883662;596.83885350955;549.4587830986475;552.5110277404445;648.9286178520359;710.8898120791285;711.8539151965435;8886.4668119913;9604.90395096054;9699.272554558436;9719.271054670928;9725.319227653996;657.5528640524394;674.4132604633902;678.6369292428527;684.4763755726773;704.9506534542533;4514.616257618073;4520.954790452053;4549.886252843706;4566.589006989387;4627.421572303462;65548.67225663936;68729.31270687329;69080.43735845087;69837;70229.2977070233;60833.695831520556;60955;61994.070088948705;62230.37769622246;62308.376916230256;54579.72710136424;54986.45013549893;55247.72376138174;55399.44600554024;56407.43592564104;8764.40565939264;8800.38397312182;8831.514266715392;8921.15249051339;9081.636734530544;37342.253154937294;37852;37938.810305949395;37975.430368543944;38438.42342364923;45810.54189458196;46337.53662463332;46728.29907551457;48012;51965;12544.184627999151;12556.309402982559;12721.87278127244;12727.363631818187;12787.680307992374;13227.603171904859;13489.730205395641;13631.795523066963;14235.786463202852;14706.411743530567;13356.131851429625;13693.452261909411;13761.31193440344;13812.1022133561;13937.860621393656;13032.413541390471;13450.190991919553;13469.39387727535;13623.18260904349;13633.250171240677;12926.159799612995;13089.672758181121;13314.46742130304;13358.732825343634;13863.237521936391;10724.946375268073;10859.728506787393;11221.66335009951;11259.831102533304;11448.255863368855;10903.890961090288;11090.481249441684;11192.328460292409;11346.659600212008;11362.488688008894 05:21:01 INFO - PROCESS | 22861 | __end_tp_report 05:21:01 INFO - PROCESS | 22861 | __start_cc_report 05:21:01 INFO - PROCESS | 22861 | _x_x_mozilla_cycle_collect,805 05:21:01 INFO - PROCESS | 22861 | __end_cc_report 05:21:01 INFO - PROCESS | 22861 | __startTimestamp1464438061487__endTimestamp 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | ------- Summary: start ------- 05:21:01 INFO - PROCESS | 22861 | Number of tests: 6 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | [#0] dojo.html Cycles:165 Average:5382.32 Median:5604.64 stddev:614.00 (11.0%) stddev-sans-first:590.32 05:21:01 INFO - PROCESS | 22861 | Values: 3147.4 3150.5 3165.8 3193.0 3211.7 5258.0 5351.1 5352.7 5451.8 5456.8 5316.0 5322.9 5328.5 5338.3 5380.8 4783.9 4868.7 4879.3 4886.4 5116.2 4996.5 5042.3 5072.4 5076.4 5120.5 4758.5 4834.2 4878.6 4882.6 4923.4 4813.0 4836.3 4848.5 4903.1 4960.8 4893.9 4896.4 4906.2 4907.2 4908.9 5212.2 5295.8 5361.0 5422.6 5440.5 5820.5 5859.6 5886.9 5892.3 5897.9 5580.8 5778.9 5788.1 5795.9 5850.4 5341.0 5374.7 5387.4 5476.2 5480.2 5985.9 5991.6 5999.4 6000.1 6008.8 5485.6 5657.3 5753.7 5759.3 5772.1 5782.8 5835.4 5891.3 5892.1 5892.7 5769.7 5794.4 5797.0 5805.9 5811.2 5541.1 5709.0 5770.1 5797.9 5808.0 4427.5 4439.2 4445.5 4482.3 4485.0 3953.6 3956.7 3959.6 3992.5 4004.4 5310.4 5356.2 5444.5 5466.8 5477.4 5786.4 5801.8 5811.6 5823.3 5855.3 5506.5 5517.1 5517.6 5518.9 5521.3 4764.2 4913.4 4922.8 4933.6 4944.6 5995.2 5995.3 6006.2 6009.0 6016.1 5766.2 5774.0 5778.4 5782.0 5782.4 5903.5 5970.9 6019.4 6023.3 6074.8 5681.6 5725.7 5729.9 5731.5 5731.9 5602.8 5821.8 5836.6 5838.5 5839.6 5609.0 5616.7 5664.5 5699.6 5700.3 5641.7 5690.2 5697.9 5698.3 5700.5 5422.0 5514.9 5604.6 5607.4 5610.7 5699.1 5802.5 5811.5 5812.1 5819.1 5594.0 5640.3 5645.8 5649.8 5679.8 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | [#1] ext.html Cycles:180 Average:60541.87 Median:201709.82 stddev:118000.50 (58.5%) stddev-sans-first:118245.68 05:21:01 INFO - PROCESS | 22861 | Values: 593.1 613.5 633.3 642.3 650.3 29956.9 32458.8 32579.5 45796.5 46663.8 44911.3 45182.5 45475.5 45492.0 45681.3 8675.1 8858.4 8862.6 8868.8 8870.5 7928.8 8749.1 10355.5 10608.9 10617.7 10709.3 10784.8 10788.3 10790.8 10794.8 7791.6 10617.6 10690.6 10695.0 10726.6 10427.3 10913.0 10914.8 10917.7 10928.2 41684.6 42221.0 42244.8 42249.2 42319.8 3495.0 3514.2 3541.8 3552.6 3695.6 30464.5 33086.0 33337.5 33339.5 33394.0 4327.7 4367.5 4377.5 4393.8 4511.5 363210.0 366092.0 366445.0 366569.0 366708.0 60738.0 61575.7 61607.4 61679.1 61788.7 65319.3 65407.0 65801.7 66177.7 66213.3 16779.2 17032.5 17034.7 17037.2 17044.8 10718.8 10732.9 10733.5 10733.8 10869.5 17735.0 19611.5 19808.4 19817.5 19848.6 6973.7 7234.7 7370.4 7384.6 7415.9 1024.3 1079.3 1093.7 1165.3 1215.2 33089.8 33449.0 33492.7 33526.0 33953.3 1018.2 1048.9 1060.2 1062.7 1091.9 17093.2 17463.3 17521.4 17656.0 17692.6 528174.0 529785.0 529793.0 529908.0 530888.0 59249.0 59559.4 59850.8 59857.4 59879.0 1341.7 1351.2 1392.7 1427.7 1434.4 31108.5 32238.4 32402.8 32476.0 33038.8 51804.0 51845.2 52047.5 52092.5 52269.7 424361.0 425867.0 426131.0 426316.0 426347.0 23202.0 23843.8 27628.4 28104.2 28685.0 43895.6 47814.0 48134.0 48918.5 49023.5 39874.4 40901.6 41447.8 41709.8 41787.6 39639.2 39701.2 39991.8 40520.6 40649.6 40365.8 41380.8 41774.2 41988.6 42152.4 35305.5 36563.3 36711.6 36912.4 37539.8 28245.4 28250.6 28296.9 28410.7 28548.3 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | [#2] jquery.html Cycles:180 Average:28266.66 Median:12055.96 stddev:78912.54 (654.6%) stddev-sans-first:79106.09 05:21:01 INFO - PROCESS | 22861 | Values: 361.2 367.6 371.9 373.1 389.0 17829.6 19549.3 19583.1 19723.2 20001.9 17748.0 18657.2 19285.7 19432.1 19487.9 5318.2 5342.8 5496.7 5536.8 5573.3 5412.0 5434.2 5448.6 5451.2 5494.5 5411.1 5445.8 5454.6 5456.1 5457.5 5277.7 5389.4 5416.0 5420.3 5454.8 3619.9 4848.9 4933.8 4943.8 4944.6 20924.4 21123.2 21560.2 21584.4 21807.5 2304.5 2409.6 2524.6 2779.1 3078.5 14499.3 14535.4 14536.4 14608.2 15041.4 1918.1 1934.4 1955.6 1991.5 2019.5 52218.7 71053.6 76714.2 78336.6 79041.6 10305.4 10454.1 10642.9 10728.0 10819.2 14852.4 14915.9 14935.2 14948.3 14964.2 7995.5 8116.0 8143.3 8252.2 8314.4 7862.7 7870.8 7914.2 7996.8 8037.8 6636.1 6734.9 6744.5 6765.4 6773.5 1789.5 1892.3 1899.7 1915.9 1920.5 880.9 963.4 1086.7 1103.3 1124.1 19177.2 19689.9 19826.3 19876.7 20327.8 1010.9 1021.5 1033.4 1046.0 1047.6 10982.7 11712.6 11712.8 11721.5 11745.2 457263.0 477637.0 478899.0 481739.0 505558.0 79429.0 81020.0 81480.0 82632.0 84728.2 1026.1 1043.2 1043.8 1061.8 1062.1 17699.0 17714.5 18163.7 18194.6 18378.1 37062.8 39765.0 41476.4 42131.0 44204.8 57336.0 57776.7 58523.7 60249.0 61437.0 7990.6 8326.3 8357.7 8364.8 8445.6 9145.4 13508.4 13741.7 13943.7 14260.6 10708.3 10868.8 11848.9 12021.1 12477.3 11282.9 11626.4 11668.0 11748.2 12055.5 11732.4 11785.6 12263.3 12363.6 12364.9 8305.1 8404.8 8430.2 8669.1 8898.6 8498.1 10734.8 10927.9 11006.9 11612.4 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | [#3] mootools.html Cycles:180 Average:5977.32 Median:4350.65 stddev:3553.28 (81.7%) stddev-sans-first:3544.89 05:21:01 INFO - PROCESS | 22861 | Values: 1170.5 1326.5 1436.0 1489.4 1872.6 8723.6 9082.0 9133.6 9345.5 9358.5 9062.6 9230.8 9255.9 9267.0 9270.0 1998.6 2056.3 2237.1 2240.8 2269.9 2257.4 2269.1 2270.9 2273.9 2274.0 2311.6 2313.1 2314.4 2335.7 2345.0 1909.2 2172.3 2233.6 2244.8 2282.1 2229.7 2230.9 2245.8 2249.9 2253.1 9081.2 9083.9 9127.7 9139.4 9139.5 4941.1 5043.9 5055.6 5067.7 5072.9 3027.7 3161.9 3209.1 3213.0 3272.5 1060.3 1073.2 1084.7 1096.1 1129.3 13006.5 13053.0 13053.8 13057.9 13060.5 4196.8 4307.7 4393.6 4395.4 4397.8 10708.6 10733.9 10757.6 10757.6 10760.3 5157.5 5166.1 5168.3 5169.7 5170.5 4099.1 4700.8 4805.6 4848.3 4909.7 3761.1 3872.3 3876.5 3900.9 3972.1 1195.0 1198.9 1201.0 1240.3 1240.8 994.8 1028.1 1047.0 1048.5 1050.6 6340.8 6353.3 6419.6 6446.3 6502.4 403.6 403.9 410.7 442.6 458.4 4303.2 4477.9 4481.6 4503.1 4515.5 11124.7 11462.9 11497.7 11531.6 11553.1 11351.1 11406.3 11406.7 11421.2 11455.4 7998.3 8203.3 8208.0 8223.2 8537.1 6088.9 6275.6 6286.7 6289.8 6438.7 10583.4 10593.9 10860.7 10910.3 10925.8 10689.1 10992.2 11000.2 11046.4 11121.1 7796.8 8256.2 8398.3 8520.4 8950.8 8767.6 8791.0 8837.7 8843.1 8851.7 7685.9 7851.5 7903.5 7964.9 8007.7 7646.5 7750.7 7808.0 7924.8 8026.3 7153.2 7254.3 7325.7 7339.5 7345.0 5557.5 5589.4 5610.9 5653.6 5669.8 5356.5 5393.3 5492.1 5618.8 5640.0 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | [#4] prototype.html Cycles:180 Average:4677.62 Median:5414.05 stddev:1406.74 (26.0%) stddev-sans-first:1371.97 05:21:01 INFO - PROCESS | 22861 | Values: 310.9 311.8 315.2 317.1 318.2 5260.4 5310.6 5342.8 5347.1 5349.3 5267.3 5296.9 5299.6 5308.8 5341.7 3965.8 4006.6 4037.5 4056.6 4074.8 4103.9 4121.3 4128.5 4130.5 4148.6 3992.1 4048.9 4051.2 4075.2 4111.0 4002.4 4016.4 4068.2 4072.3 4096.9 3519.5 3519.6 3525.2 3558.3 3558.3 5030.2 5034.3 5055.9 5060.3 5060.5 4482.2 4586.4 4590.5 4602.2 4695.4 5514.4 5525.3 5551.4 5553.9 5561.6 3942.4 3953.9 3954.3 3956.9 3964.1 5539.7 5768.4 5797.9 5803.0 5817.4 3997.6 4004.5 4005.3 4017.7 4049.5 4088.8 4092.8 4095.9 4103.3 4132.6 4689.1 4724.2 4740.0 4740.5 4743.7 5359.2 5634.5 5650.2 5655.2 5669.2 1383.5 1397.5 1398.0 1398.7 1404.1 868.3 878.7 880.7 890.3 901.5 5046.7 5246.2 5277.9 5394.5 5455.6 5657.7 5765.4 5781.4 5800.9 5843.8 5428.4 5434.0 5434.8 5437.5 5443.6 2879.0 3042.2 3043.4 3044.3 3051.7 5937.0 5958.7 5983.2 6018.6 6089.8 5642.5 5730.3 5814.2 5877.9 5926.9 5905.4 5911.9 5965.5 5970.3 5978.2 5689.0 5702.5 5731.4 5745.9 5747.2 5440.3 5624.4 5637.8 5679.7 5683.3 5952.3 5979.7 5996.0 6002.1 6015.4 3746.8 3985.8 4000.8 4016.8 4032.9 5729.5 5744.9 5751.6 5761.2 5768.0 5561.3 5612.1 5652.6 5661.8 5677.7 5465.7 5480.0 5575.9 5602.3 5615.4 5469.6 5474.2 5514.3 5523.6 5561.6 5399.7 5640.3 5645.6 5656.6 5694.6 5428.5 5449.7 5489.2 5514.5 5535.6 05:21:01 INFO - PROCESS | 22861 | 05:21:01 INFO - PROCESS | 22861 | [#5] yui.html Cycles:180 Average:15796.72 Median:25482.48 stddev:18882.66 (74.1%) stddev-sans-first:18901.95 05:21:01 INFO - PROCESS | 22861 | Values: 779.3 809.1 825.4 827.5 843.7 14359.6 14858.1 14881.2 15063.3 15102.2 13249.8 13891.3 13913.4 14208.1 14259.7 508.3 776.8 781.5 783.1 792.8 780.8 781.0 781.0 781.1 801.8 830.5 831.7 831.8 832.1 832.3 574.3 822.2 830.8 833.5 852.7 612.2 612.7 613.5 613.6 615.4 14378.6 14386.1 14399.8 14406.3 14409.4 12919.7 13208.5 13307.2 13359.6 13516.9 12292.8 12450.9 12499.9 12649.4 12882.1 4383.8 4429.3 4481.7 4623.1 4624.9 58316.7 59598.7 59617.0 60188.7 60264.4 10794.5 10811.8 10915.0 10984.3 11096.1 18663.7 18860.3 18874.7 18878.8 18958.0 7611.2 7878.6 7968.6 7973.1 8048.6 4682.8 4692.2 4696.8 4808.5 4887.9 3084.3 3133.5 3143.0 3146.2 3166.6 589.4 590.9 591.3 591.5 596.8 549.5 552.5 648.9 710.9 711.9 8886.5 9604.9 9699.3 9719.3 9725.3 657.6 674.4 678.6 684.5 705.0 4514.6 4521.0 4549.9 4566.6 4627.4 65548.7 68729.3 69080.4 69837.0 70229.3 60833.7 60955.0 61994.1 62230.4 62308.4 54579.7 54986.5 55247.7 55399.4 56407.4 8764.4 8800.4 8831.5 8921.2 9081.6 37342.3 37852.0 37938.8 37975.4 38438.4 45810.5 46337.5 46728.3 48012.0 51965.0 12544.2 12556.3 12721.9 12727.4 12787.7 13227.6 13489.7 13631.8 14235.8 14706.4 13356.1 13693.5 13761.3 13812.1 13937.9 13032.4 13450.2 13469.4 13623.2 13633.3 12926.2 13089.7 13314.5 13358.7 13863.2 10724.9 10859.7 11221.7 11259.8 11448.3 10903.9 11090.5 11192.3 11346.7 11362.5 05:21:01 INFO - PROCESS | 22861 | -------- Summary: end -------- 05:21:01 INFO - PROCESS | 22861 | 05:21:02 INFO - TEST-INFO | 22861: exit 0 05:21:02 INFO - TEST-OK | dromaeo_css | took 1112514ms 05:21:02 INFO - TEST-START | kraken 05:21:02 INFO - operating with platform_type : linux_ 05:21:02 INFO - Initialising browser for kraken test... 05:21:02 INFO - TEST-INFO | started process 23044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdiVClb/profile http://localhost:34077/getInfo.html) 05:21:05 INFO - PROCESS | 23044 | __metrics Screen width/height:1600/1200 05:21:05 INFO - PROCESS | 23044 | colorDepth:24 05:21:05 INFO - PROCESS | 23044 | Browser inner width/height: 1024/697 05:21:05 INFO - PROCESS | 23044 | __metrics 05:21:06 ERROR - PROCESS | 23044 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:21:07 INFO - TEST-INFO | 23044: exit 0 05:21:07 INFO - Browser initialized. 05:21:07 INFO - Running cycle 1/1 for kraken test... 05:21:07 INFO - TEST-INFO | started process 23128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdiVClb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:19 INFO - PROCESS | 23128 | RSS: Main: 155844608 05:21:19 INFO - PROCESS | 23128 | 05:21:22 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:22 INFO - PROCESS | 23128 | RSS: Main: 214315008 05:21:22 INFO - PROCESS | 23128 | 05:21:25 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-dft) 05:21:26 INFO - PROCESS | 23128 | RSS: Main: 198139904 05:21:26 INFO - PROCESS | 23128 | 05:21:29 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-fft) 05:21:29 INFO - PROCESS | 23128 | RSS: Main: 268578816 05:21:29 INFO - PROCESS | 23128 | 05:21:31 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-oscillator) 05:21:32 INFO - PROCESS | 23128 | RSS: Main: 179290112 05:21:32 INFO - PROCESS | 23128 | 05:21:34 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:35 INFO - PROCESS | 23128 | RSS: Main: 183341056 05:21:35 INFO - PROCESS | 23128 | 05:21:38 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34077/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:38 INFO - PROCESS | 23128 | RSS: Main: 217939968 05:21:38 INFO - PROCESS | 23128 | 05:21:42 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34077/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:42 INFO - PROCESS | 23128 | RSS: Main: 220164096 05:21:42 INFO - PROCESS | 23128 | 05:21:45 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34077/tests/kraken/driver.html?testName=json-parse-financial) 05:21:46 INFO - PROCESS | 23128 | RSS: Main: 219901952 05:21:46 INFO - PROCESS | 23128 | 05:21:47 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:48 INFO - PROCESS | 23128 | RSS: Main: 205914112 05:21:48 INFO - PROCESS | 23128 | 05:21:50 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:21:50 INFO - PROCESS | 23128 | RSS: Main: 209113088 05:21:50 INFO - PROCESS | 23128 | 05:21:52 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:21:53 INFO - PROCESS | 23128 | RSS: Main: 216784896 05:21:53 INFO - PROCESS | 23128 | 05:21:56 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:56 INFO - PROCESS | 23128 | RSS: Main: 223637504 05:21:56 INFO - PROCESS | 23128 | 05:21:59 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:00 INFO - PROCESS | 23128 | RSS: Main: 224272384 05:22:00 INFO - PROCESS | 23128 | 05:22:01 INFO - PROCESS | 23128 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34077/tests/kraken/driver.html?testName=ai-astar) 05:22:01 INFO - PROCESS | 23128 | RSS: Main: 266690560 05:22:01 INFO - PROCESS | 23128 | 05:22:01 INFO - PROCESS | 23128 | __start_tp_report 05:22:01 INFO - PROCESS | 23128 | _x_x_mozilla_page_load 05:22:02 INFO - PROCESS | 23128 | _x_x_mozilla_page_load_details 05:22:02 INFO - PROCESS | 23128 | |i|pagename|runs| 05:22:02 INFO - PROCESS | 23128 | |0;ai-astar;111;107;110;111;110;111;109;110;110;110 05:22:02 INFO - PROCESS | 23128 | |1;audio-beat-detection;156;124;132;181;135;155;151;126;182;131 05:22:02 INFO - PROCESS | 23128 | |2;audio-dft;161;160;162;161;160;162;161;161;160;162 05:22:02 INFO - PROCESS | 23128 | |3;audio-fft;73;74;74;116;76;76;74;75;99;74 05:22:02 INFO - PROCESS | 23128 | |4;audio-oscillator;83;83;112;82;82;84;121;83;84;120 05:22:02 INFO - PROCESS | 23128 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;116 05:22:02 INFO - PROCESS | 23128 | |6;imaging-darkroom;147;145;145;146;146;146;147;146;145;145 05:22:02 INFO - PROCESS | 23128 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 05:22:02 INFO - PROCESS | 23128 | |8;json-parse-financial;53;54;54;54;57;55;53;54;53;55 05:22:02 INFO - PROCESS | 23128 | |9;json-stringify-tinderbox;61;62;61;61;62;61;65;61;61;62 05:22:02 INFO - PROCESS | 23128 | |10;stanford-crypto-aes;83;79;79;78;80;79;80;81;113;82 05:22:02 INFO - PROCESS | 23128 | |11;stanford-crypto-ccm;128;120;134;121;121;120;121;121;136;129 05:22:02 INFO - PROCESS | 23128 | |12;stanford-crypto-pbkdf2;159;160;160;160;160;162;166;166;162;162 05:22:02 INFO - PROCESS | 23128 | |13;stanford-crypto-sha256-iterative;62;63;66;63;61;63;62;63;65;60 05:22:02 INFO - PROCESS | 23128 | __end_tp_report 05:22:02 INFO - PROCESS | 23128 | __start_cc_report 05:22:02 INFO - PROCESS | 23128 | _x_x_mozilla_cycle_collect,1652 05:22:02 INFO - PROCESS | 23128 | __end_cc_report 05:22:02 INFO - PROCESS | 23128 | __startTimestamp1464438121997__endTimestamp 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | ------- Summary: start ------- 05:22:02 INFO - PROCESS | 23128 | Number of tests: 14 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:1.20 05:22:02 INFO - PROCESS | 23128 | Values: 111.0 107.0 110.0 111.0 110.0 111.0 109.0 110.0 110.0 110.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.00 stddev:21.44 (14.0%) stddev-sans-first:22.51 05:22:02 INFO - PROCESS | 23128 | Values: 156.0 124.0 132.0 181.0 135.0 155.0 151.0 126.0 182.0 131.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 05:22:02 INFO - PROCESS | 23128 | Values: 161.0 160.0 162.0 161.0 160.0 162.0 161.0 161.0 160.0 162.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:14.51 (19.5%) stddev-sans-first:15.09 05:22:02 INFO - PROCESS | 23128 | Values: 73.0 74.0 74.0 116.0 76.0 76.0 74.0 75.0 99.0 74.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.00 stddev:16.92 (20.4%) stddev-sans-first:17.52 05:22:02 INFO - PROCESS | 23128 | Values: 83.0 83.0 112.0 82.0 82.0 84.0 121.0 83.0 84.0 120.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:22:02 INFO - PROCESS | 23128 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 05:22:02 INFO - PROCESS | 23128 | Values: 147.0 145.0 145.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:22:02 INFO - PROCESS | 23128 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.22 05:22:02 INFO - PROCESS | 23128 | Values: 53.0 54.0 54.0 54.0 57.0 55.0 53.0 54.0 53.0 55.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.50 stddev:1.25 (2.0%) stddev-sans-first:1.30 05:22:02 INFO - PROCESS | 23128 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 65.0 61.0 61.0 62.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:80.00 stddev:10.51 (13.1%) stddev-sans-first:11.15 05:22:02 INFO - PROCESS | 23128 | Values: 83.0 79.0 79.0 78.0 80.0 79.0 80.0 81.0 113.0 82.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:124.50 stddev:6.15 (4.9%) stddev-sans-first:6.44 05:22:02 INFO - PROCESS | 23128 | Values: 128.0 120.0 134.0 121.0 121.0 120.0 121.0 121.0 136.0 129.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:2.50 (1.5%) stddev-sans-first:2.45 05:22:02 INFO - PROCESS | 23128 | Values: 159.0 160.0 160.0 160.0 160.0 162.0 166.0 166.0 162.0 162.0 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - PROCESS | 23128 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.83 05:22:02 INFO - PROCESS | 23128 | Values: 62.0 63.0 66.0 63.0 61.0 63.0 62.0 63.0 65.0 60.0 05:22:02 INFO - PROCESS | 23128 | -------- Summary: end -------- 05:22:02 INFO - PROCESS | 23128 | 05:22:02 INFO - TEST-INFO | 23128: exit 0 05:22:02 INFO - TEST-OK | kraken | took 60791ms 05:22:02 INFO - SUITE-END | took 1173s 05:22:03 INFO - Completed test suite (00:19:33) 05:22:03 INFO - javascript benchmark 05:22:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.354792267585, 3150.4644210484216, 3165.7783955123145, 3193.0, 3211.7270032047277, 5258.0, 5351.063563876316, 5352.705601191933, 5451.754671039803, 5456.754446049922, 5316.043112239795, 5322.92015619766, 5328.520433161015, 5338.306020217376, 5380.811671591495, 4783.880402989918, 4868.707877527359, 4879.341288926003, 4886.413630364361, 5116.155834287357, 4996.475370086125, 5042.344495215617, 5072.442031376546, 5076.36545431821, 5120.487951204868, 4758.45277793053, 4834.154023045953, 4878.585320247766, 4882.584980276681, 4923.433805112422, 4812.951870481285, 4836.298736683161, 4848.466668666444, 4903.117438861003, 4960.826371076995, 4893.926591101136, 4896.436909755388, 4906.239532872411, 4907.1657818171, 4908.852734417973, 5212.192110222922, 5295.761690723926, 5361.035013697533, 5422.593305502103, 5440.455954404528, 5820.534357251409, 5859.648421094748, 5886.852828679274, 5892.322382925932, 5897.8820423591715, 5580.832575022756, 5778.913316300259, 5788.102844059177, 5795.942040579583, 5850.385709500526, 5341.03861304965, 5374.7043912584795, 5387.380451248117, 5476.205950137208, 5480.177973303957, 5985.940140598538, 5991.55063370249, 5999.370066143079, 6000.0999850022845, 6008.849778755479, 5485.6434331768305, 5657.349404818498, 5753.654780713171, 5759.308882934075, 5772.076467765138, 5782.7686892523825, 5835.416458354131, 5891.293044834647, 5892.057270836645, 5892.734826932799, 5769.740361683735, 5794.449527294901, 5797.0, 5805.8548536286935, 5811.157382179645, 5541.085720856095, 5709.0, 5770.076787713946, 5797.913031304533, 5808.0, 4427.535108813592, 4439.156560253541, 4445.488768791565, 4482.305242687388, 4484.955150448519, 3953.5651078381356, 3956.7032472564674, 3959.6436320731273, 3992.500937382827, 4004.419359192959, 5310.3627564691715, 5356.1697936819855, 5444.537214336826, 5466.781328746805, 5477.397486276506, 5786.392428795, 5801.796937107181, 5811.593188476851, 5823.301203855564, 5855.3266374367495, 5506.531944784658, 5517.089680202802, 5517.586181036439, 5518.944810551923, 5521.309836270466, 4764.237721964469, 4913.385826771653, 4922.803087876517, 4933.629977751683, 4944.554990050912, 5995.160677505153, 5995.280566332068, 6006.159137720722, 6008.969955150196, 6016.067509536029, 5766.221560089334, 5773.971130144322, 5778.393268706725, 5781.971090144522, 5782.392848750821, 5903.527717782481, 5970.850728731816, 6019.398060193946, 6023.27720673522, 6074.848128796815, 5681.602287839812, 5725.742341594555, 5729.942700573108, 5731.541476681772, 5731.942680573141, 5602.831915042555, 5821.825345239649, 5836.649801011953, 5838.532917366685, 5839.620424672553, 5609.018421776092, 5616.69108199053, 5664.49019588239, 5699.572532060195, 5700.315962084576, 5641.661500309994, 5690.174924635988, 5697.886042279214, 5698.2592263005545, 5700.458456446631, 5421.972890135524, 5514.91727624078, 5604.6356986797355, 5607.41122182165, 5610.663360198401, 5699.116636921284, 5802.47777700009, 5811.476967072984, 5812.128180772749, 5819.098039803837, 5593.972030139986, 5640.294963129609, 5645.830625081254, 5649.7740090397565, 5679.801206957736], "value": 5341.193128223505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.1281016905151, 613.4938675592637, 633.2527617411454, 642.290269252476, 650.3041745332495, 29956.850215748917, 32458.837705811467, 32579.51130733035, 45796.542034579645, 46663.766681166635, 44911.326330105076, 45182.54817451825, 45475.545244547546, 45492.0, 45681.31478027824, 8675.08911564286, 8858.424202426822, 8862.556872156398, 8868.778280542974, 8870.467771933705, 7928.80177995549, 8749.081346458594, 10355.534000969974, 10608.893911060868, 10617.73455663607, 10709.25035247533, 10784.838227426595, 10788.298760580537, 10790.78418431631, 10794.838077428845, 7791.571463569501, 10617.57529698815, 10690.62582809598, 10695.037446629802, 10726.570937162503, 10427.270091093627, 10913.0, 10914.836277455845, 10917.672469825919, 10928.180386470967, 41684.58315416868, 42221.0, 42244.788776055924, 42249.1550168998, 42319.788401058104, 3494.973800125271, 3514.1917359007316, 3541.8229088545727, 3552.5559305086863, 3695.63043695631, 30464.54303185454, 33086.0, 33337.49993750072, 33339.499907501406, 33394.0, 4327.653787696977, 4367.497737760134, 4377.4528183977, 4393.780310984438, 4511.548845115462, 363210.0, 366092.0, 366444.9999999973, 366568.9999999973, 366708.0, 60738.0, 61575.692121539105, 61607.38392616106, 61679.07481387783, 61788.69105654443, 65319.34680653133, 65407.0, 65801.67099164473, 66177.66911165413, 66213.33786662071, 16779.244933978, 17032.48902532926, 17034.659306814043, 17037.233324500427, 17044.829551704323, 10718.785624287471, 10732.94633526843, 10733.463326833627, 10733.83899241512, 10869.45652717361, 17734.95081591111, 19611.509712257306, 19808.40574782759, 19817.504562386057, 19848.60302793936, 6973.721051157897, 7234.710611575478, 7370.410367170613, 7384.59384733834, 7415.85168296631, 1024.2727663358949, 1079.2930630437077, 1093.6992327110108, 1165.2600598619938, 1215.2040413528975, 33089.834550827574, 33449.0, 33492.66507334944, 33526.0, 33953.32093358119, 1018.23123541727, 1048.8741351037772, 1060.2260349944584, 1062.7236918401272, 1091.93994330311, 17093.23080461382, 17463.30146794114, 17521.386751463637, 17656.0, 17692.557686057695, 528174.0, 529785.0, 529793.0, 529908.0, 530888.0, 59249.0, 59559.40440595625, 59850.80298394008, 59857.415684274696, 59879.0, 1341.6578772413168, 1351.196038357176, 1392.6587985943509, 1427.6716355238354, 1434.3545404567778, 31108.533371998987, 32238.35523289568, 32402.83798580992, 32476.0, 33038.83480582582, 51804.0, 51845.22232166445, 52047.47952520426, 52092.479075208765, 52269.7386513065, 424361.0, 425867.0, 426131.0, 426316.0, 426347.0, 23202.0, 23843.761562384156, 27628.447431051667, 28104.156875293775, 28685.0, 43895.56104439042, 47814.0, 48134.0, 48918.51081489139, 49023.50976490189, 39874.40188397234, 40901.59098408978, 41447.792761036, 41709.79145104255, 41787.58212417837, 39639.2072158561, 39701.20597587974, 39991.80004099961, 40520.594794051685, 40649.593504065764, 40365.79817100896, 41380.79309603433, 41774.1645167101, 41988.58011419847, 42152.36771448369, 35305.47041794426, 36563.26873462569, 36711.63288367082, 36912.44631330586, 37539.81230093832, 28245.43509129847, 28250.576241355986, 28296.85851570729, 28410.715892840806, 28548.286292842844], "value": 20509.37298789823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.2017441454384, 367.59197291006996, 371.9140110876242, 373.0915221435804, 388.9611038896109, 17829.55426114346, 19549.315773947877, 19583.118759655816, 19723.21107155712, 20001.899990500027, 17748.0, 18657.16042778075, 19285.710714339297, 19432.125554350052, 19487.902560487215, 5318.202269659543, 5342.759575819078, 5496.697681627509, 5536.778528858841, 5573.303337082864, 5411.972940135293, 5434.239206511092, 5448.591355648323, 5451.236826844245, 5494.5054945054935, 5411.107167317388, 5445.83662490126, 5454.563634909217, 5456.072467680484, 5457.508824205821, 5277.736113194325, 5389.353277606712, 5415.972920135414, 5420.295361603005, 5454.781808727646, 3619.8552057917914, 4848.927266091011, 4933.80264789408, 4943.777530011158, 4944.604431645495, 20924.372268831958, 21123.15507379703, 21560.245391411383, 21584.352469425943, 21807.45481362963, 2304.4584522637165, 2409.590369637166, 2524.5708229600828, 2779.1106845809145, 3078.4766589679807, 14499.347529361205, 14535.418583256656, 14536.418543258256, 14608.196549189897, 15041.398344066225, 1918.1176658736997, 1934.4390126863193, 1955.599102184049, 1991.5220347116588, 2019.545602239499, 52218.7389063056, 71053.644731776, 76714.23285767183, 78336.60831695805, 79041.60479197625, 10305.381677099398, 10454.11140053104, 10642.946785266178, 10728.0, 10819.242653014213, 14852.405903763945, 14915.850841491447, 14935.17856517902, 14948.252587370587, 14964.176970266522, 7995.480293780885, 8115.959420202861, 8143.267105960374, 8252.20398616643, 8314.41799074059, 7862.685492580347, 7870.763877083697, 7914.169012253746, 7996.800079998046, 8037.799055023671, 6636.082469157622, 6734.8989765153565, 6744.516206434577, 6765.424938880152, 6773.45812335012, 1789.5257756694486, 1892.3187652445383, 1899.7150427435995, 1915.8754680945972, 1920.5198700324918, 880.8942926848691, 963.3641796414473, 1086.7174534621056, 1103.25530267071, 1124.083871644607, 19177.232910683415, 19689.901550492155, 19826.306079287446, 19876.70184947227, 20327.796722032886, 1010.8534262532039, 1021.4841505039907, 1033.4109557552274, 1045.9633912813015, 1047.6490375724065, 10982.670519884416, 11712.648620541397, 11712.765744685228, 11721.531138754524, 11745.236559623598, 457263.0, 477637.0, 478899.0, 481739.0, 505558.0, 79429.0, 81020.0, 81480.0, 82632.0, 84728.15271847325, 1026.0867827633413, 1043.1706793099352, 1043.8277684182026, 1061.766411389493, 1062.0812996757904, 17699.0, 17714.468565943043, 18163.727544087113, 18194.636107278046, 18378.081095945417, 37062.814685926394, 39765.005874852206, 41476.377854332815, 42131.0, 44204.77897610491, 57336.0, 57776.71111644415, 58523.70738146282, 60249.0, 61437.0, 7990.560519171501, 8326.333893288644, 8357.749267521984, 8364.790880228044, 8445.619947102272, 9145.405548639583, 13508.39212235432, 13741.732614118559, 13943.721125577229, 14260.572182834532, 10708.30396024256, 10868.782624347627, 11848.881511184778, 12021.09841761854, 12477.313747743961, 11282.94358528235, 11626.360550169484, 11668.0, 11748.177627565989, 12055.51777928873, 11732.354720490455, 11785.587504437304, 12263.26420414778, 12363.62909112728, 12364.876351236373, 8305.127961563949, 8404.831903362021, 8430.15698430152, 8669.133086691532, 8898.644054238017, 8498.107698691549, 10734.785304293715, 10927.945360273148, 11006.889931100586, 11612.400155951682], "value": 9238.05090362489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1170.4849866058928, 1326.4760419634244, 1435.9999999999998, 1489.404238304678, 1872.6441976024555, 8723.607437665305, 9081.954590227047, 9133.634654613825, 9345.532723363838, 9358.485283309416, 9062.592183351748, 9230.769230769234, 9255.907440925588, 9267.026962168977, 9269.953650231757, 1998.620262150194, 2056.3008577083788, 2237.1498830444407, 2240.831937604682, 2269.943251418711, 2257.3905045637666, 2269.126386341254, 2270.863748175115, 2273.8521996070203, 2273.954520909581, 2311.6185829338137, 2313.063209400196, 2314.3982564533258, 2335.74306826249, 2344.9648255276184, 1909.2458478900826, 2172.2722887832597, 2233.6426171812595, 2244.831637627168, 2282.087165133943, 2229.67669687896, 2230.921917732888, 2245.8427910046303, 2249.876256805875, 2253.1212826997485, 9081.182693557612, 9083.909160908372, 9127.680531181377, 9139.360244782867, 9139.45163290198, 4941.085899108676, 5043.899122017576, 5055.570276526463, 5067.670601410897, 5072.923906141411, 3027.7275045246033, 3161.8893338733033, 3209.0854106579513, 3212.9678703212903, 3272.5091236314506, 1060.3213943076437, 1073.2272763610188, 1084.7146131833724, 1096.1011970184452, 1129.3393364881554, 13006.479740810357, 13053.0, 13053.804192937114, 13057.934710326388, 13060.542880999119, 4196.832126714898, 4307.698461107755, 4393.604575588212, 4395.384646149478, 4397.846075387346, 10708.571657133783, 10733.946330268454, 10757.56969721218, 10757.623483178051, 10760.300580462244, 5157.484251574812, 5166.070107380708, 5168.2764412982215, 5169.663971841818, 5170.508801663836, 4099.139180772071, 4700.811967521261, 4805.5915247204375, 4848.272759086165, 4909.680870743462, 3761.078535758702, 3872.341701910682, 3876.476675648808, 3900.921981560353, 3972.1459886124044, 1194.964151075469, 1198.8681245063035, 1200.9759804803855, 1240.2930329711978, 1240.8386909701862, 994.8408254679216, 1028.069597014688, 1046.984295235572, 1048.4757621189406, 1050.564015933379, 6340.778072767524, 6353.3329000455215, 6419.614823110628, 6446.258680251737, 6502.370138733794, 403.58833989331305, 403.9050823056579, 410.6817216657055, 442.6348262683299, 458.35829838226084, 4303.203907277101, 4477.910441791146, 4481.641468682497, 4503.099380123923, 4515.5484451554585, 11124.721881952853, 11462.885371146182, 11497.712557186138, 11531.596394126165, 11553.13351498641, 11351.091912646969, 11406.258593191416, 11406.714832129097, 11421.200515963803, 11455.427228638535, 7998.280154785981, 8203.261706446448, 8208.015038195455, 8223.177682231848, 8537.060923298432, 6088.908666369919, 6275.592086514362, 6286.685665716787, 6289.779857704958, 6438.710258038306, 10583.36499809983, 10593.89406105929, 10860.67417977462, 10910.290831095954, 10925.781484370427, 10689.09142722846, 10992.17558683086, 11000.22998390105, 11046.447677616248, 11121.110311175249, 7796.84406311882, 8256.174382561696, 8398.286145677686, 8520.446170998865, 8950.820983580423, 8767.605457754544, 8790.956045219733, 8837.734867953972, 8843.07147749477, 8851.734447966572, 7685.923140768521, 7851.4503984722805, 7903.486273392211, 7964.880526791987, 8007.719729809429, 7646.541207527566, 7750.651220695195, 7808.0, 7924.762257132295, 8026.317762989977, 7153.2131465537705, 7254.347108760237, 7325.670344834602, 7339.486235963432, 7344.96327518359, 5557.472040156179, 5589.441055894541, 5610.943890561042, 5653.604247702621, 5669.801556945487, 5356.491133342326, 5393.325834270716, 5492.148716948879, 5618.775248989995, 5640.041192997118], "value": 4607.646697715257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.93314937288477, 311.8253777884385, 315.15695514498725, 317.0931136948326, 318.18227156208536, 5260.447652996433, 5310.6017048721405, 5342.813001544947, 5347.144456886904, 5349.251104845324, 5267.28891599634, 5296.867578310535, 5299.629025968184, 5308.787648494065, 5341.679499230039, 3965.8215380307956, 4006.599340065999, 4037.4751282333254, 4056.553779084313, 4074.8166332515107, 4103.932977425861, 4121.278776214165, 4128.463299771026, 4130.524989626201, 4148.605882441163, 3992.141689536749, 4048.9190216195657, 4051.210014047262, 4075.2257071156387, 4110.979445102786, 4002.4196491508715, 4016.397540368968, 4068.1863627274665, 4072.348424252135, 4096.877093687194, 3519.5248641433336, 3519.560054993126, 3525.1715846775987, 3558.2527669189503, 3558.3417067842533, 5030.170021946375, 5034.320366750479, 5055.9241611375855, 5060.304797892711, 5060.46865079165, 4482.170798402306, 4586.4266966629175, 4590.517995610479, 4602.240630295997, 4695.3661255730385, 5514.420985796473, 5525.309336332958, 5551.417845913895, 5553.944460555424, 5561.582881283879, 3942.448057271984, 3953.881383558498, 3954.3277642800795, 3956.8812935611977, 3964.1477082427127, 5539.695316757577, 5768.42315768424, 5797.898399304161, 5803.0, 5817.360090390053, 3997.6402123809, 4004.4994375703036, 4005.2590270799415, 4017.738846974937, 4049.453323801308, 4088.795560221977, 4092.7544347339253, 4095.877123686294, 4103.343465045578, 4132.586741325904, 4689.116193541016, 4724.196886529298, 4739.976300118477, 4740.478547359788, 4743.715377077387, 5359.22291267764, 5634.520810843216, 5650.180723795027, 5655.208270842086, 5669.177969194444, 1383.4604504243352, 1397.5318268380004, 1397.9515363477392, 1398.727248186594, 1404.1434724817852, 868.3400615532241, 878.6573236437795, 880.6961598248594, 890.283321925856, 901.544719916438, 5046.6719663221775, 5246.213068039825, 5277.944411117792, 5394.514493695587, 5455.61810673257, 5657.660540367591, 5765.365809760923, 5781.364049954502, 5800.9419905800405, 5843.766249349978, 5428.375736790241, 5434.021876062347, 5434.782608695687, 5437.510624043855, 5443.550402318972, 2878.992352676532, 3042.239440139965, 3043.421749867518, 3044.3302473455806, 3051.7406020488065, 5936.970315148396, 5958.735680441405, 5983.19226904371, 6018.608790428608, 6089.8477538061015, 5642.492175704207, 5730.3410107838135, 5814.215080964016, 5877.941220587825, 5926.851828704317, 5905.379935106838, 5911.9113213301835, 5965.4631083203585, 5970.253718285215, 5978.1929439525975, 5689.0, 5702.543796496353, 5731.398203188772, 5745.937001654707, 5747.166660834239, 5440.292761940922, 5624.437556244343, 5637.774489020393, 5679.716014199356, 5683.2895888014, 5952.255968003999, 5979.671118088547, 5996.010658241341, 6002.05899109442, 6015.368386319548, 3746.756460830037, 3985.8405663773124, 4000.7999600020466, 4016.779077150668, 4032.91934161321, 5729.455701708331, 5744.913826292525, 5751.568632352674, 5761.164631128379, 5768.0, 5561.332640083216, 5612.130119831432, 5652.604317697722, 5661.830145095653, 5677.687727175045, 5465.672059676433, 5480.0, 5575.944240557543, 5602.2717046783655, 5615.399611110814, 5469.581511555278, 5474.233607295061, 5514.255575497417, 5523.6409633373705, 5561.63849349791, 5399.7300134993875, 5640.251522028185, 5645.576581756302, 5656.632318899258, 5694.601377903507, 5428.538574221236, 5449.7275136243825, 5489.231507589021, 5514.531264842533, 5535.557155427637], "value": 4219.409253117455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.306417288613, 809.1301850510703, 825.3727167352812, 827.5489858027374, 843.7215718812796, 14359.64100897478, 14858.108513489198, 14881.18153501557, 15063.322150503227, 15102.244887755623, 13249.801252981213, 13891.305434728274, 13913.443462261497, 14208.147511149338, 14259.71480570388, 508.29093414686673, 776.7747353267546, 781.4959351218475, 783.1346362269695, 792.7819849541364, 780.8438312337555, 780.9570473623949, 781.03932163439, 781.0861292288037, 801.791534201109, 830.5265998380926, 831.7296878514477, 831.8045259364075, 832.142892820393, 832.317499650287, 574.3050908400819, 822.2024636102971, 830.796454868558, 833.5415521463201, 852.6972924611736, 612.1674522649193, 612.6783438694677, 613.4785432382483, 613.628754603463, 615.4030590327375, 14378.640533986629, 14386.064905781195, 14399.78400323996, 14406.279686015658, 14409.351579178961, 12919.67700807478, 13208.471661133543, 13307.20156790586, 13359.599212023655, 13516.932415337958, 12292.815607765891, 12450.875491245153, 12499.937500312531, 12649.43077561512, 12882.098253122285, 4383.802728877208, 4429.313456414261, 4481.663875209372, 4623.0522742837975, 4624.861254162381, 58316.708416457644, 59598.70200649012, 59617.0, 60188.699056504876, 60264.39735602632, 10794.488771571987, 10811.783764324828, 10915.0, 10984.340939543654, 11096.1123110151, 18663.72004419935, 18860.339888103852, 18874.716879246822, 18878.811211887707, 18958.0, 7611.238876112345, 7878.566678832719, 7968.641411136513, 7973.0830954439825, 8048.59757012147, 4682.836100736458, 4692.225782745809, 4696.788644511005, 4808.519148085234, 4887.877803054952, 3084.30603114302, 3133.529970504397, 3143.0, 3146.197719581538, 3166.5725127107544, 589.4341432225112, 590.9202257695242, 591.257971246092, 591.5474661883662, 596.83885350955, 549.4587830986475, 552.5110277404445, 648.9286178520359, 710.8898120791285, 711.8539151965435, 8886.4668119913, 9604.90395096054, 9699.272554558436, 9719.271054670928, 9725.319227653996, 657.5528640524394, 674.4132604633902, 678.6369292428527, 684.4763755726773, 704.9506534542533, 4514.616257618073, 4520.954790452053, 4549.886252843706, 4566.589006989387, 4627.421572303462, 65548.67225663936, 68729.31270687329, 69080.43735845087, 69837.0, 70229.2977070233, 60833.695831520556, 60955.0, 61994.070088948705, 62230.37769622246, 62308.376916230256, 54579.72710136424, 54986.45013549893, 55247.72376138174, 55399.44600554024, 56407.43592564104, 8764.40565939264, 8800.38397312182, 8831.514266715392, 8921.15249051339, 9081.636734530544, 37342.253154937294, 37852.0, 37938.810305949395, 37975.430368543944, 38438.42342364923, 45810.54189458196, 46337.53662463332, 46728.29907551457, 48012.0, 51965.0, 12544.184627999151, 12556.309402982559, 12721.87278127244, 12727.363631818187, 12787.680307992374, 13227.603171904859, 13489.730205395641, 13631.795523066963, 14235.786463202852, 14706.411743530567, 13356.131851429625, 13693.452261909411, 13761.31193440344, 13812.1022133561, 13937.860621393656, 13032.413541390471, 13450.190991919553, 13469.39387727535, 13623.18260904349, 13633.250171240677, 12926.159799612995, 13089.672758181121, 13314.46742130304, 13358.732825343634, 13863.237521936391, 10724.946375268073, 10859.728506787393, 11221.66335009951, 11259.831102533304, 11448.255863368855, 10903.890961090288, 11090.481249441684, 11192.328460292409, 11346.659600212008, 11362.488688008894], "value": 6870.856847625242, "unit": "score"}], "name": "dromaeo_css", "value": 7164.069898436413, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 132.0, 181.0, 135.0, 155.0, 151.0, 126.0, 182.0, 131.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 116.0, 76.0, 76.0, 74.0, 75.0, 99.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 82.0, 82.0, 84.0, 121.0, 83.0, 84.0, 120.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 57.0, 55.0, 53.0, 54.0, 53.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 65.0, 61.0, 61.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 79.0, 78.0, 80.0, 79.0, 80.0, 81.0, 113.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 134.0, 121.0, 121.0, 120.0, 121.0, 121.0, 136.0, 129.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 160.0, 160.0, 162.0, 166.0, 166.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 66.0, 63.0, 61.0, 63.0, 62.0, 63.0, 65.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1499.0, "alertThreshold": 2.0}]} 05:22:03 INFO - Return code: 0 05:22:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:03 ERROR - # TBPL SUCCESS # 05:22:03 INFO - Running post-action listener: _resource_record_post_action 05:22:03 INFO - ##### 05:22:03 INFO - ##### Finished run-tests step (success) 05:22:03 INFO - ##### 05:22:03 INFO - Running post-run listener: _resource_record_post_run 05:22:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541835264; Read time: 168; Write time: 453900 05:22:03 INFO - TinderboxPrint: CPU usage
13.1% 05:22:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 168 05:22:03 INFO - TinderboxPrint: I/O write bytes / time
541,835,264 / 453,900 05:22:03 INFO - TinderboxPrint: CPU idle
8,258.2 (86.9%) 05:22:03 INFO - TinderboxPrint: CPU user
1,204.5 (12.7%) 05:22:03 INFO - TinderboxPrint: Swap in / out
0 / 0 05:22:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 247189504; Read time: 168; Write time: 228172 05:22:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294469632; Read time: 0; Write time: 225708 05:22:03 INFO - Running post-run listener: _upload_blobber_files 05:22:03 INFO - Blob upload gear active. 05:22:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:03 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 05:22:03 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:22:03 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:22:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:05 INFO - (blobuploader) - INFO - Done attempting. 05:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:12 INFO - (blobuploader) - INFO - Done attempting. 05:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:15 INFO - (blobuploader) - INFO - Done attempting. 05:22:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:15 INFO - Return code: 0 05:22:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb941047fe9d2c31dbdaf9b505ed91316768078feebc98852920c89b266acdbbb2a7e822eb1ac46e04be61b199d7839a7a5c231143f51d41ff1b1e36fc9b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3daf494a921768b196d751ba9a41ac0fbb045abd48d455c1ad76797dd20933b6427017ee72f4c7b5fc28c1d41dafedb1f1d0b673aebcd2760d75f50c728c098f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a22e9a47dfa18c3928540028fdc67d3c46cb372520e29fcd17c547d99b025251b21febfdf9ab2cfed8a843e83dee443a68bd9b7c97936fb680d1964001418d0c"} 05:22:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:15 INFO - Contents: 05:22:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb941047fe9d2c31dbdaf9b505ed91316768078feebc98852920c89b266acdbbb2a7e822eb1ac46e04be61b199d7839a7a5c231143f51d41ff1b1e36fc9b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3daf494a921768b196d751ba9a41ac0fbb045abd48d455c1ad76797dd20933b6427017ee72f4c7b5fc28c1d41dafedb1f1d0b673aebcd2760d75f50c728c098f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a22e9a47dfa18c3928540028fdc67d3c46cb372520e29fcd17c547d99b025251b21febfdf9ab2cfed8a843e83dee443a68bd9b7c97936fb680d1964001418d0c"} 05:22:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:15 INFO - Copying logs to upload dir... 05:22:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.334118 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-28 05:22:14.951923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 05:22:14.955110) ========= 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=923d835db2ba3686ebe126b700000192-1464436278.46699-534457818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb941047fe9d2c31dbdaf9b505ed91316768078feebc98852920c89b266acdbbb2a7e822eb1ac46e04be61b199d7839a7a5c231143f51d41ff1b1e36fc9b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3daf494a921768b196d751ba9a41ac0fbb045abd48d455c1ad76797dd20933b6427017ee72f4c7b5fc28c1d41dafedb1f1d0b673aebcd2760d75f50c728c098f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a22e9a47dfa18c3928540028fdc67d3c46cb372520e29fcd17c547d99b025251b21febfdf9ab2cfed8a843e83dee443a68bd9b7c97936fb680d1964001418d0c"} build_url:https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb941047fe9d2c31dbdaf9b505ed91316768078feebc98852920c89b266acdbbb2a7e822eb1ac46e04be61b199d7839a7a5c231143f51d41ff1b1e36fc9b66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3daf494a921768b196d751ba9a41ac0fbb045abd48d455c1ad76797dd20933b6427017ee72f4c7b5fc28c1d41dafedb1f1d0b673aebcd2760d75f50c728c098f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a22e9a47dfa18c3928540028fdc67d3c46cb372520e29fcd17c547d99b025251b21febfdf9ab2cfed8a843e83dee443a68bd9b7c97936fb680d1964001418d0c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 05:22:14.979621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:22:14.979915) ========= 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=923d835db2ba3686ebe126b700000192-1464436278.46699-534457818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:22:15.065531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:22:15.065849) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:22:15.066133) ========= ========= Total master_lag: 0.17 =========