builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1464956230.16 results: success (0) buildid: 20160603023020 builduid: 69a086ceb4f44375b01bf2ee7a00e85c revision: 10371d73bb08fa730e311885433bd147bf2a3576 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.155648) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.156046) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.156576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.214067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.214334) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 05:17:11-- 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% 113M=0s 2016-06-03 05:17:11 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.310484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.310790) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019972 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:10.371945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 05:17:10.372251) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 10371d73bb08fa730e311885433bd147bf2a3576 --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 10371d73bb08fa730e311885433bd147bf2a3576 --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=9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 05:17:11,308 truncating revision to first 12 chars 2016-06-03 05:17:11,309 Setting DEBUG logging. 2016-06-03 05:17:11,309 attempt 1/10 2016-06-03 05:17:11,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/10371d73bb08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 05:17:12,510 unpacking tar archive at: fx-team-10371d73bb08/testing/mozharness/ program finished with exit code 0 elapsedTime=1.542657 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 05:17:11.944619) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:11.944969) ========= script_repo_revision: 10371d73bb08fa730e311885433bd147bf2a3576 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:11.945424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:11.945756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 05:17:11.957462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-03 05:17:11.957800) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:12 INFO - MultiFileLogger online at 20160603 05:17:12 in /builds/slave/test 05:17:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:17:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:12 INFO - {'append_to_log': False, 05:17:12 INFO - 'base_work_dir': '/builds/slave/test', 05:17:12 INFO - 'blob_upload_branch': 'Fx-Team', 05:17:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:12 INFO - 'branch': 'Fx-Team', 05:17:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:12 INFO - 'config_files': ('talos/linux_config.py',), 05:17:12 INFO - 'default_actions': ('clobber', 05:17:12 INFO - 'read-buildbot-config', 05:17:12 INFO - 'download-and-extract', 05:17:12 INFO - 'populate-webroot', 05:17:12 INFO - 'create-virtualenv', 05:17:12 INFO - 'install', 05:17:12 INFO - 'run-tests'), 05:17:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:12 INFO - 'download_minidump_stackwalk': True, 05:17:12 INFO - 'download_symbols': 'ondemand', 05:17:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:12 INFO - 'installer_path': 'installer.exe', 05:17:12 INFO - 'log_level': 'info', 05:17:12 INFO - 'log_name': 'talos', 05:17:12 INFO - 'log_to_console': True, 05:17:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:12 INFO - 'opt_config_files': (), 05:17:12 INFO - 'pip_index': False, 05:17:12 INFO - 'sps_profile': False, 05:17:12 INFO - 'sps_profile_interval': 0, 05:17:12 INFO - 'suite': 'dromaeojs-e10s', 05:17:12 INFO - 'system_bits': '32', 05:17:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:12 INFO - 'title': 'talos-linux64-ix-040', 05:17:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:12 INFO - 'use_talos_json': True, 05:17:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:12 INFO - 'work_dir': 'build'} 05:17:12 INFO - ##### 05:17:12 INFO - ##### Running clobber step. 05:17:12 INFO - ##### 05:17:12 INFO - Running pre-action listener: _resource_record_pre_action 05:17:12 INFO - Running main action method: clobber 05:17:12 INFO - rmtree: /builds/slave/test/build 05:17:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:13 INFO - Running post-action listener: _resource_record_post_action 05:17:13 INFO - ##### 05:17:13 INFO - ##### Finished clobber step (success) 05:17:13 INFO - ##### 05:17:13 INFO - ##### 05:17:13 INFO - ##### Running read-buildbot-config step. 05:17:13 INFO - ##### 05:17:13 INFO - Running pre-action listener: _resource_record_pre_action 05:17:13 INFO - Running main action method: read_buildbot_config 05:17:13 INFO - Using buildbot properties: 05:17:13 INFO - { 05:17:13 INFO - "project": "", 05:17:13 INFO - "product": "firefox", 05:17:13 INFO - "script_repo_revision": "production", 05:17:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:17:13 INFO - "repository": "", 05:17:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:17:13 INFO - "buildid": "20160603023020", 05:17:13 INFO - "pgo_build": "True", 05:17:13 INFO - "basedir": "/builds/slave/test", 05:17:13 INFO - "buildnumber": 804, 05:17:13 INFO - "slavename": "talos-linux64-ix-040", 05:17:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:17:13 INFO - "platform": "ubuntu64_hw", 05:17:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:17:13 INFO - "branch": "fx-team", 05:17:13 INFO - "repo_path": "integration/fx-team", 05:17:13 INFO - "revision": "10371d73bb08fa730e311885433bd147bf2a3576", 05:17:13 INFO - "stage_platform": "linux64-pgo", 05:17:13 INFO - "builduid": "69a086ceb4f44375b01bf2ee7a00e85c", 05:17:13 INFO - "slavebuilddir": "test" 05:17:13 INFO - } 05:17:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:17:13 INFO - Running post-action listener: _resource_record_post_action 05:17:13 INFO - ##### 05:17:13 INFO - ##### Finished read-buildbot-config step (success) 05:17:13 INFO - ##### 05:17:13 INFO - ##### 05:17:13 INFO - ##### Running download-and-extract step. 05:17:13 INFO - ##### 05:17:13 INFO - Running pre-action listener: _resource_record_pre_action 05:17:13 INFO - Running main action method: download_and_extract 05:17:13 INFO - mkdir: /builds/slave/test/build/tests 05:17:13 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:17:13 INFO - https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:24 INFO - Downloaded 1361 bytes. 05:17:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:17:24 INFO - Using the following test package requirements: 05:17:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:17:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:17:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:17:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'jsshell-linux-x86_64.zip'], 05:17:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:17:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:17:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:17:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:17:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:17:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:17:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:17: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:17:24 INFO - https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:34 INFO - Downloaded 24439715 bytes. 05:17:34 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:17:34 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:17:35 INFO - Return code: 0 05:17:35 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:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:35 INFO - https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:37 INFO - Downloaded 24439715 bytes. 05:17:37 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:17:37 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:17:39 INFO - Return code: 0 05:17: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:17:39 INFO - https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:40 INFO - Downloaded 10834055 bytes. 05:17:40 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:17:40 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:17:40 INFO - Return code: 0 05:17:40 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:17:40 INFO - https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:17:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPc1uvKcRi2-jtllvljI2Q/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:17:42 INFO - Downloaded 59048775 bytes. 05:17:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:42 INFO - mkdir: /builds/slave/test/properties 05:17:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:42 INFO - Contents: 05:17:42 INFO - build_url:https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:17:42 INFO - Running post-action listener: _resource_record_post_action 05:17:42 INFO - Running post-action listener: set_extra_try_arguments 05:17:42 INFO - ##### 05:17:42 INFO - ##### Finished download-and-extract step (success) 05:17:42 INFO - ##### 05:17:42 INFO - ##### 05:17:42 INFO - ##### Running populate-webroot step. 05:17:42 INFO - ##### 05:17:42 INFO - Running pre-action listener: _resource_record_pre_action 05:17:42 INFO - Running main action method: populate_webroot 05:17:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:42 INFO - '--tppagecycles', 05:17:42 INFO - '7'], 05:17:42 INFO - 'tests': ['tsvgm']}}, 05:17:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:42 INFO - 'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:42 INFO - 'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['damp', 'tps']}, 05:17:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:42 INFO - 'tests': ['damp', 'tps']}, 05:17:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['dromaeo_dom']}, 05:17:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['a11yr', 05:17:42 INFO - 'ts_paint', 05:17:42 INFO - 'tpaint', 05:17:42 INFO - 'sessionrestore', 05:17:42 INFO - 'sessionrestore_no_auto_restore', 05:17:42 INFO - 'tabpaint']}, 05:17:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:42 INFO - 'ts_paint', 05:17:42 INFO - 'tpaint', 05:17:42 INFO - 'sessionrestore', 05:17:42 INFO - 'sessionrestore_no_auto_restore', 05:17:42 INFO - 'tabpaint']}, 05:17:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:42 INFO - 'ts_paint', 05:17:42 INFO - 'tpaint', 05:17:42 INFO - 'sessionrestore', 05:17:42 INFO - 'sessionrestore_no_auto_restore', 05:17:42 INFO - 'tabpaint']}, 05:17:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:42 INFO - 'ts_paint', 05:17:42 INFO - 'tpaint', 05:17:42 INFO - 'sessionrestore', 05:17:42 INFO - 'sessionrestore_no_auto_restore', 05:17:42 INFO - 'tabpaint']}, 05:17:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['a11yr', 05:17:42 INFO - 'ts_paint', 05:17:42 INFO - 'tpaint', 05:17:42 INFO - 'sessionrestore', 05:17:42 INFO - 'sessionrestore_no_auto_restore', 05:17:42 INFO - 'tabpaint']}, 05:17:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['a11yr', 05:17:42 INFO - 'ts_paint', 05:17:42 INFO - 'tpaint', 05:17:42 INFO - 'sessionrestore', 05:17:42 INFO - 'sessionrestore_no_auto_restore', 05:17:42 INFO - 'tabpaint']}, 05:17:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:42 INFO - 'tests': ['tsvgx', 05:17:42 INFO - 'tsvgr_opacity', 05:17:42 INFO - 'tart', 05:17:42 INFO - 'tscrollx', 05:17:42 INFO - 'cart']}, 05:17:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:43 INFO - 'tsvgr_opacity', 05:17:43 INFO - 'tart', 05:17:43 INFO - 'tscrollx', 05:17:43 INFO - 'cart']}, 05:17:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:43 INFO - 'talos_options': ['--disable-e10s'], 05:17:43 INFO - 'tests': ['tp5o']}, 05:17:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:43 INFO - 'tests': ['tp5o']}, 05:17:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:43 INFO - 'talos_options': ['--disable-e10s', 05:17:43 INFO - '--xperf_path', 05:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:43 INFO - 'tests': ['tp5n']}, 05:17:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:43 INFO - 'talos_options': ['--xperf_path', 05:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:43 INFO - 'tests': ['tp5n']}}, 05:17:43 INFO - 'talos.zip': {'path': '', 05:17:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:43 INFO - Running post-action listener: _resource_record_post_action 05:17:43 INFO - ##### 05:17:43 INFO - ##### Finished populate-webroot step (success) 05:17:43 INFO - ##### 05:17:43 INFO - ##### 05:17:43 INFO - ##### Running create-virtualenv step. 05:17:43 INFO - ##### 05:17:43 INFO - Running pre-action listener: _resource_record_pre_action 05:17:43 INFO - Running main action method: create_virtualenv 05:17:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:43 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:17:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:43 INFO - Using real prefix '/usr' 05:17:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:45 INFO - Installing pip.................done. 05:17:45 INFO - Return code: 0 05:17:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17: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:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:17:45 INFO - Using env: {'DISPLAY': ':0', 05:17:45 INFO - 'HOME': '/home/cltbld', 05:17:45 INFO - 'LANG': 'en_US.UTF-8', 05:17:45 INFO - 'LANGUAGE': 'en_US:en', 05:17:45 INFO - 'LOGNAME': 'cltbld', 05:17:45 INFO - 'MAIL': '/var/mail/cltbld', 05:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:45 INFO - 'MOZ_NO_REMOTE': '1', 05:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:45 INFO - 'NO_EM_RESTART': '1', 05:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:45 INFO - 'PWD': '/builds/slave/test', 05:17:45 INFO - 'SHELL': '/bin/bash', 05:17:45 INFO - 'SHLVL': '1', 05:17:45 INFO - 'TERM': 'linux', 05:17:45 INFO - 'TMOUT': '86400', 05:17:45 INFO - 'USER': 'cltbld', 05:17:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:45 INFO - '_': '/tools/buildbot/bin/python'} 05:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:45 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:17:45 INFO - Cleaning up... 05:17:45 INFO - Return code: 0 05:17:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17: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:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:17:45 INFO - Using env: {'DISPLAY': ':0', 05:17:45 INFO - 'HOME': '/home/cltbld', 05:17:45 INFO - 'LANG': 'en_US.UTF-8', 05:17:45 INFO - 'LANGUAGE': 'en_US:en', 05:17:45 INFO - 'LOGNAME': 'cltbld', 05:17:45 INFO - 'MAIL': '/var/mail/cltbld', 05:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:45 INFO - 'MOZ_NO_REMOTE': '1', 05:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:45 INFO - 'NO_EM_RESTART': '1', 05:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:45 INFO - 'PWD': '/builds/slave/test', 05:17:45 INFO - 'SHELL': '/bin/bash', 05:17:45 INFO - 'SHLVL': '1', 05:17:45 INFO - 'TERM': 'linux', 05:17:45 INFO - 'TMOUT': '86400', 05:17:45 INFO - 'USER': 'cltbld', 05:17:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:45 INFO - '_': '/tools/buildbot/bin/python'} 05:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:46 INFO - Downloading/unpacking psutil>=3.1.1 05:17:46 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:17:46 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:17:46 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:17:46 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:17:46 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:17:46 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:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:48 INFO - Installing collected packages: psutil 05:17:48 INFO - Running setup.py install for psutil 05:17:48 INFO - building 'psutil._psutil_linux' extension 05:17:48 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:17:48 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:17:48 INFO - building 'psutil._psutil_posix' extension 05:17:48 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:17:48 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:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:48 INFO - Successfully installed psutil 05:17:48 INFO - Cleaning up... 05:17:48 INFO - Return code: 0 05:17:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17:48 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:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:48 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:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:48 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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:17:48 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:17:48 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:17:48 INFO - Using env: {'DISPLAY': ':0', 05:17:48 INFO - 'HOME': '/home/cltbld', 05:17:48 INFO - 'LANG': 'en_US.UTF-8', 05:17:48 INFO - 'LANGUAGE': 'en_US:en', 05:17:48 INFO - 'LOGNAME': 'cltbld', 05:17:48 INFO - 'MAIL': '/var/mail/cltbld', 05:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:48 INFO - 'MOZ_NO_REMOTE': '1', 05:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:48 INFO - 'NO_EM_RESTART': '1', 05:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:48 INFO - 'PWD': '/builds/slave/test', 05:17:48 INFO - 'SHELL': '/bin/bash', 05:17:48 INFO - 'SHLVL': '1', 05:17:48 INFO - 'TERM': 'linux', 05:17:48 INFO - 'TMOUT': '86400', 05:17:48 INFO - 'USER': 'cltbld', 05:17:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:48 INFO - '_': '/tools/buildbot/bin/python'} 05:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:51 INFO - Installing collected packages: mozsystemmonitor 05:17:51 INFO - Running setup.py install for mozsystemmonitor 05:17:51 INFO - Successfully installed mozsystemmonitor 05:17:51 INFO - Cleaning up... 05:17:51 INFO - Return code: 0 05:17:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:17:51 INFO - Using env: {'DISPLAY': ':0', 05:17:51 INFO - 'HOME': '/home/cltbld', 05:17:51 INFO - 'LANG': 'en_US.UTF-8', 05:17:51 INFO - 'LANGUAGE': 'en_US:en', 05:17:51 INFO - 'LOGNAME': 'cltbld', 05:17:51 INFO - 'MAIL': '/var/mail/cltbld', 05:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:51 INFO - 'MOZ_NO_REMOTE': '1', 05:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:51 INFO - 'NO_EM_RESTART': '1', 05:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:51 INFO - 'PWD': '/builds/slave/test', 05:17:51 INFO - 'SHELL': '/bin/bash', 05:17:51 INFO - 'SHLVL': '1', 05:17:51 INFO - 'TERM': 'linux', 05:17:51 INFO - 'TMOUT': '86400', 05:17:51 INFO - 'USER': 'cltbld', 05:17:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:51 INFO - '_': '/tools/buildbot/bin/python'} 05:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:17: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:17: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:17: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:17: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:17: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:17: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:17:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:54 INFO - Downloading docopt-0.6.1.tar.gz 05:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:54 INFO - Running setup.py install for blobuploader 05:17:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:55 INFO - Running setup.py install for requests 05:17:55 INFO - Running setup.py install for docopt 05:17:55 INFO - Successfully installed blobuploader requests docopt 05:17:55 INFO - Cleaning up... 05:17:55 INFO - Return code: 0 05:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:55 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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:17:55 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:17:55 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:17:55 INFO - Using env: {'DISPLAY': ':0', 05:17:55 INFO - 'HOME': '/home/cltbld', 05:17:55 INFO - 'LANG': 'en_US.UTF-8', 05:17:55 INFO - 'LANGUAGE': 'en_US:en', 05:17:55 INFO - 'LOGNAME': 'cltbld', 05:17:55 INFO - 'MAIL': '/var/mail/cltbld', 05:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:55 INFO - 'MOZ_NO_REMOTE': '1', 05:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:55 INFO - 'NO_EM_RESTART': '1', 05:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:55 INFO - 'PWD': '/builds/slave/test', 05:17:55 INFO - 'SHELL': '/bin/bash', 05:17:55 INFO - 'SHLVL': '1', 05:17:55 INFO - 'TERM': 'linux', 05:17:55 INFO - 'TMOUT': '86400', 05:17:55 INFO - 'USER': 'cltbld', 05:17:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:55 INFO - '_': '/tools/buildbot/bin/python'} 05:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:55 INFO - Running setup.py (path:/tmp/pip-wK08EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:55 INFO - Running setup.py (path:/tmp/pip-_RXgiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:55 INFO - Running setup.py (path:/tmp/pip-OMcFzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:55 INFO - Running setup.py (path:/tmp/pip-Sxeyma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:56 INFO - Running setup.py (path:/tmp/pip-weBwyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:56 INFO - Running setup.py (path:/tmp/pip-O05DLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:56 INFO - Running setup.py (path:/tmp/pip-WQmti5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:56 INFO - Running setup.py (path:/tmp/pip-jMQCXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:56 INFO - Running setup.py (path:/tmp/pip-3zzFmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:56 INFO - Running setup.py (path:/tmp/pip-u9wISZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:56 INFO - Running setup.py (path:/tmp/pip-P54J8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:56 INFO - Running setup.py (path:/tmp/pip-UJFctK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:56 INFO - Running setup.py (path:/tmp/pip-0Dli6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:56 INFO - Running setup.py (path:/tmp/pip-9c9FLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:56 INFO - Running setup.py (path:/tmp/pip-Hh07sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:56 INFO - Running setup.py (path:/tmp/pip-X5hTxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:56 INFO - Running setup.py (path:/tmp/pip-BDz8lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:56 INFO - Running setup.py install for manifestparser 05:17:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Running setup.py install for mozcrash 05:17:57 INFO - Running setup.py install for mozdebug 05:17:57 INFO - Running setup.py install for mozdevice 05:17:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Running setup.py install for mozfile 05:17:57 INFO - Running setup.py install for mozhttpd 05:17:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Running setup.py install for mozinfo 05:17:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Running setup.py install for mozInstall 05:17:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:57 INFO - Running setup.py install for mozleak 05:17:57 INFO - Running setup.py install for mozlog 05:17:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Running setup.py install for moznetwork 05:17:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Running setup.py install for mozprocess 05:17:58 INFO - Running setup.py install for mozprofile 05:17:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Running setup.py install for mozrunner 05:17:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Running setup.py install for mozscreenshot 05:17:58 INFO - Running setup.py install for moztest 05:17:58 INFO - Running setup.py install for mozversion 05:17:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:58 INFO - Cleaning up... 05:17:58 INFO - Return code: 0 05:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:58 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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:17:58 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:17:58 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:17:58 INFO - Using env: {'DISPLAY': ':0', 05:17:58 INFO - 'HOME': '/home/cltbld', 05:17:58 INFO - 'LANG': 'en_US.UTF-8', 05:17:58 INFO - 'LANGUAGE': 'en_US:en', 05:17:58 INFO - 'LOGNAME': 'cltbld', 05:17:58 INFO - 'MAIL': '/var/mail/cltbld', 05:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:58 INFO - 'MOZ_NO_REMOTE': '1', 05:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:58 INFO - 'NO_EM_RESTART': '1', 05:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:58 INFO - 'PWD': '/builds/slave/test', 05:17:58 INFO - 'SHELL': '/bin/bash', 05:17:58 INFO - 'SHLVL': '1', 05:17:58 INFO - 'TERM': 'linux', 05:17:58 INFO - 'TMOUT': '86400', 05:17:58 INFO - 'USER': 'cltbld', 05:17:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:58 INFO - '_': '/tools/buildbot/bin/python'} 05:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:58 INFO - Running setup.py (path:/tmp/pip-egapXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:59 INFO - Running setup.py (path:/tmp/pip-VKZNqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:59 INFO - Running setup.py (path:/tmp/pip-YYQTj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:59 INFO - Running setup.py (path:/tmp/pip-qje69A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:59 INFO - Running setup.py (path:/tmp/pip-DN_e2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:59 INFO - Running setup.py (path:/tmp/pip-sigYmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:59 INFO - Running setup.py (path:/tmp/pip-24AIWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:59 INFO - Running setup.py (path:/tmp/pip-rtHlK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:59 INFO - Running setup.py (path:/tmp/pip-VcT7f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:59 INFO - Running setup.py (path:/tmp/pip-o0vi4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:59 INFO - Running setup.py (path:/tmp/pip-IpfuqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:59 INFO - Running setup.py (path:/tmp/pip-diSJzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:59 INFO - Running setup.py (path:/tmp/pip-8GgWhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:59 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:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:59 INFO - Running setup.py (path:/tmp/pip-E627Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:00 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:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:00 INFO - Running setup.py (path:/tmp/pip-7YDF_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:00 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:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:00 INFO - Running setup.py (path:/tmp/pip-vPxDye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:00 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:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:00 INFO - Running setup.py (path:/tmp/pip-jrqiir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:02 INFO - Downloading blessings-1.6.tar.gz 05:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:02 INFO - Installing collected packages: blessings 05:18:02 INFO - Running setup.py install for blessings 05:18:02 INFO - Successfully installed blessings 05:18:02 INFO - Cleaning up... 05:18:02 INFO - Return code: 0 05:18:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:02 INFO - Reading from file tmpfile_stdout 05:18:02 INFO - Current package versions: 05:18:02 INFO - argparse == 1.2.1 05:18:02 INFO - blessings == 1.6 05:18:02 INFO - blobuploader == 1.2.4 05:18:02 INFO - docopt == 0.6.1 05:18:02 INFO - manifestparser == 1.1 05:18:02 INFO - mozInstall == 1.12 05:18:02 INFO - mozcrash == 0.17 05:18:02 INFO - mozdebug == 0.1 05:18:02 INFO - mozdevice == 0.48 05:18:02 INFO - mozfile == 1.2 05:18:02 INFO - mozhttpd == 0.7 05:18:02 INFO - mozinfo == 0.9 05:18:02 INFO - mozleak == 0.1 05:18:02 INFO - mozlog == 3.2 05:18:02 INFO - moznetwork == 0.27 05:18:02 INFO - mozprocess == 0.22 05:18:02 INFO - mozprofile == 0.28 05:18:02 INFO - mozrunner == 6.11 05:18:02 INFO - mozscreenshot == 0.1 05:18:02 INFO - mozsystemmonitor == 0.3 05:18:02 INFO - moztest == 0.7 05:18:02 INFO - mozversion == 1.4 05:18:02 INFO - psutil == 3.1.1 05:18:02 INFO - requests == 1.2.3 05:18:02 INFO - wsgiref == 0.1.2 05:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:02 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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:18:02 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:18:02 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:18:02 INFO - Using env: {'DISPLAY': ':0', 05:18:02 INFO - 'HOME': '/home/cltbld', 05:18:02 INFO - 'LANG': 'en_US.UTF-8', 05:18:02 INFO - 'LANGUAGE': 'en_US:en', 05:18:02 INFO - 'LOGNAME': 'cltbld', 05:18:02 INFO - 'MAIL': '/var/mail/cltbld', 05:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:02 INFO - 'MOZ_NO_REMOTE': '1', 05:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:02 INFO - 'NO_EM_RESTART': '1', 05:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:02 INFO - 'PWD': '/builds/slave/test', 05:18:02 INFO - 'SHELL': '/bin/bash', 05:18:02 INFO - 'SHLVL': '1', 05:18:02 INFO - 'TERM': 'linux', 05:18:02 INFO - 'TMOUT': '86400', 05:18:02 INFO - 'USER': 'cltbld', 05:18:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:02 INFO - '_': '/tools/buildbot/bin/python'} 05:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 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:18:02 INFO - Cleaning up... 05:18:02 INFO - Return code: 0 05:18:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:02 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 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:18:02 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:18:02 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:18:02 INFO - Using env: {'DISPLAY': ':0', 05:18:02 INFO - 'HOME': '/home/cltbld', 05:18:02 INFO - 'LANG': 'en_US.UTF-8', 05:18:02 INFO - 'LANGUAGE': 'en_US:en', 05:18:02 INFO - 'LOGNAME': 'cltbld', 05:18:02 INFO - 'MAIL': '/var/mail/cltbld', 05:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:02 INFO - 'MOZ_NO_REMOTE': '1', 05:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:02 INFO - 'NO_EM_RESTART': '1', 05:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:02 INFO - 'PWD': '/builds/slave/test', 05:18:02 INFO - 'SHELL': '/bin/bash', 05:18:02 INFO - 'SHLVL': '1', 05:18:02 INFO - 'TERM': 'linux', 05:18:02 INFO - 'TMOUT': '86400', 05:18:02 INFO - 'USER': 'cltbld', 05:18:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:02 INFO - '_': '/tools/buildbot/bin/python'} 05:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:03 INFO - Downloading/unpacking jsonschema 05:18: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:18: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:18: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:18: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:18: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:18: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:18:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:04 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:05 INFO - warning: no files found matching '*.txt' 05:18:05 INFO - no previously-included directories found matching 'build' 05:18:05 INFO - no previously-included directories found matching 'dist' 05:18:05 INFO - no previously-included directories found matching '.git*' 05:18:05 INFO - Installing collected packages: jsonschema, functools32 05:18:05 INFO - Running setup.py install for functools32 05:18:05 INFO - warning: no files found matching '*.txt' 05:18:05 INFO - no previously-included directories found matching 'build' 05:18:05 INFO - no previously-included directories found matching 'dist' 05:18:05 INFO - no previously-included directories found matching '.git*' 05:18:05 INFO - Successfully installed jsonschema functools32 05:18:05 INFO - Cleaning up... 05:18:05 INFO - Return code: 0 05:18:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:18: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:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e9d22df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', '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:18: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', 'flake8'] in /builds/slave/test/build 05:18: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 flake8 05:18:05 INFO - Using env: {'DISPLAY': ':0', 05:18:05 INFO - 'HOME': '/home/cltbld', 05:18:05 INFO - 'LANG': 'en_US.UTF-8', 05:18:05 INFO - 'LANGUAGE': 'en_US:en', 05:18:05 INFO - 'LOGNAME': 'cltbld', 05:18:05 INFO - 'MAIL': '/var/mail/cltbld', 05:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:05 INFO - 'MOZ_NO_REMOTE': '1', 05:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:05 INFO - 'NO_EM_RESTART': '1', 05:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:05 INFO - 'PWD': '/builds/slave/test', 05:18:05 INFO - 'SHELL': '/bin/bash', 05:18:05 INFO - 'SHLVL': '1', 05:18:05 INFO - 'TERM': 'linux', 05:18:05 INFO - 'TMOUT': '86400', 05:18:05 INFO - 'USER': 'cltbld', 05:18:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:05 INFO - '_': '/tools/buildbot/bin/python'} 05:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:05 INFO - Downloading/unpacking flake8 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:08 INFO - no previously-included directories found matching 'docs/_build' 05:18:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:08 INFO - Running setup.py install for pep8 05:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:08 INFO - no previously-included directories found matching 'docs/_build' 05:18:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:18:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:08 INFO - Cleaning up... 05:18:08 INFO - Return code: 0 05:18:08 INFO - Running post-action listener: _resource_record_post_action 05:18:08 INFO - Running post-action listener: _start_resource_monitoring 05:18:08 INFO - Starting resource monitoring. 05:18:08 INFO - ##### 05:18:08 INFO - ##### Finished create-virtualenv step (success) 05:18:08 INFO - ##### 05:18:08 INFO - ##### 05:18:08 INFO - ##### Running install step. 05:18:08 INFO - ##### 05:18:08 INFO - Running pre-action listener: _resource_record_pre_action 05:18:08 INFO - Running main action method: install 05:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:08 INFO - Reading from file tmpfile_stdout 05:18:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:08 INFO - Reading from file tmpfile_stdout 05:18:08 INFO - Output received: 05:18:08 INFO - Usage: mozinstall [options] installer 05:18:08 INFO - Options: 05:18:08 INFO - -h, --help show this help message and exit 05:18:08 INFO - -d DEST, --destination=DEST 05:18:08 INFO - Directory to install application into. [default: 05:18:08 INFO - "/builds/slave/test"] 05:18:08 INFO - --app=APP Application being installed. [default: firefox] 05:18:08 INFO - mkdir: /builds/slave/test/build/application 05:18:08 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:18:08 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:18:25 INFO - Reading from file tmpfile_stdout 05:18:25 INFO - Output received: 05:18:25 INFO - /builds/slave/test/build/application/firefox/firefox 05:18:25 INFO - Running post-action listener: _resource_record_post_action 05:18:25 INFO - ##### 05:18:25 INFO - ##### Finished install step (success) 05:18:25 INFO - ##### 05:18:25 INFO - ##### 05:18:25 INFO - ##### Running run-tests step. 05:18:25 INFO - ##### 05:18:25 INFO - Running pre-action listener: _resource_record_pre_action 05:18:25 INFO - Running main action method: run_tests 05:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:25 INFO - Python 2.7.3 05:18:25 INFO - Return code: 0 05:18:25 INFO - grabbing minidump binary from tooltool 05:18:25 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:18:25 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 0xeaab20>, '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 0xeaba20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeabeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:25 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:18:25 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:18:25 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:18:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:25 INFO - Return code: 0 05:18:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:18:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:18:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:18:26 INFO - Return code: 0 05:18:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:18:26 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:18:26 INFO - Using env: {'DISPLAY': ':0', 05:18:26 INFO - 'HOME': '/home/cltbld', 05:18:26 INFO - 'LANG': 'en_US.UTF-8', 05:18:26 INFO - 'LANGUAGE': 'en_US:en', 05:18:26 INFO - 'LOGNAME': 'cltbld', 05:18:26 INFO - 'MAIL': '/var/mail/cltbld', 05:18:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:26 INFO - 'MOZ_NO_REMOTE': '1', 05:18:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:26 INFO - 'NO_EM_RESTART': '1', 05:18:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:26 INFO - 'PWD': '/builds/slave/test', 05:18:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:26 INFO - 'SHELL': '/bin/bash', 05:18:26 INFO - 'SHLVL': '1', 05:18:26 INFO - 'TERM': 'linux', 05:18:26 INFO - 'TMOUT': '86400', 05:18:26 INFO - 'USER': 'cltbld', 05:18:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491', 05:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:26 INFO - '_': '/tools/buildbot/bin/python'} 05:18:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:18:26 INFO - mozversion application_buildid: 20160603023020 05:18:26 INFO - mozversion application_changeset: 10371d73bb08fa730e311885433bd147bf2a3576 05:18:26 INFO - mozversion application_display_name: Nightly 05:18:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:26 INFO - mozversion application_name: Firefox 05:18:26 INFO - mozversion application_remotingname: firefox 05:18:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:18:26 INFO - mozversion application_vendor: Mozilla 05:18:26 INFO - mozversion application_version: 49.0a1 05:18:26 INFO - mozversion platform_buildid: 20160603023020 05:18:26 INFO - mozversion platform_changeset: 10371d73bb08fa730e311885433bd147bf2a3576 05:18:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:18:26 INFO - mozversion platform_version: 49.0a1 05:18:26 INFO - using testdate: 1464956306 05:18:26 INFO - actual date: 1464956306 05:18:26 INFO - starting webserver on 'localhost:56135' 05:18:26 INFO - SUITE-START | Running 2 tests 05:18:26 INFO - TEST-START | dromaeo_css 05:18:26 INFO - operating with platform_type : linux_ 05:18:26 INFO - Initialising browser for dromaeo_css test... 05:18:26 INFO - TEST-INFO | started process 30404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfei5m/profile http://localhost:56135/getInfo.html) 05:18:31 INFO - PROCESS | 30404 | __metrics Screen width/height:1600/1200 05:18:31 INFO - PROCESS | 30404 | colorDepth:24 05:18:31 INFO - PROCESS | 30404 | Browser inner width/height: 1024/697 05:18:31 INFO - PROCESS | 30404 | __metrics 05:18:32 ERROR - PROCESS | 30404 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:18:32 INFO - TEST-INFO | 30404: exit 0 05:18:32 INFO - Browser initialized. 05:18:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:32 INFO - TEST-INFO | started process 30525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfei5m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:44 INFO - PROCESS | 30525 | RSS: Main: 167424000 05:18:44 INFO - PROCESS | 30525 | 05:19:34 INFO - PROCESS | 30525 | 1464956374362 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:21:41 INFO - PROCESS | 30525 | Cycle 1(1): loaded http://localhost:56135/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56135/tests/dromaeo/cssquery-ext.html) 05:21:42 INFO - PROCESS | 30525 | RSS: Main: 170721280 05:21:42 INFO - PROCESS | 30525 | 05:24:44 INFO - PROCESS | 30525 | Cycle 1(1): loaded http://localhost:56135/tests/dromaeo/cssquery-ext.html (next: http://localhost:56135/tests/dromaeo/cssquery-jquery.html) 05:24:45 INFO - PROCESS | 30525 | RSS: Main: 170618880 05:24:45 INFO - PROCESS | 30525 | 05:27:47 INFO - PROCESS | 30525 | Cycle 1(1): loaded http://localhost:56135/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56135/tests/dromaeo/cssquery-mootools.html) 05:27:47 INFO - PROCESS | 30525 | RSS: Main: 171991040 05:27:47 INFO - PROCESS | 30525 | 05:30:49 INFO - PROCESS | 30525 | Cycle 1(1): loaded http://localhost:56135/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56135/tests/dromaeo/cssquery-prototype.html) 05:30:50 INFO - PROCESS | 30525 | RSS: Main: 168800256 05:30:50 INFO - PROCESS | 30525 | 05:33:52 INFO - PROCESS | 30525 | Cycle 1(1): loaded http://localhost:56135/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56135/tests/dromaeo/cssquery-yui.html) 05:33:53 INFO - PROCESS | 30525 | RSS: Main: 170958848 05:33:53 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | Cycle 1(1): loaded http://localhost:56135/tests/dromaeo/cssquery-yui.html (next: http://localhost:56135/tests/dromaeo/cssquery-dojo.html) 05:36:55 INFO - PROCESS | 30525 | RSS: Main: 171995136 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | __start_tp_report 05:36:55 INFO - PROCESS | 30525 | _x_x_mozilla_page_load 05:36:55 INFO - PROCESS | 30525 | _x_x_mozilla_page_load_details 05:36:55 INFO - PROCESS | 30525 | |i|pagename|runs| 05:36:55 INFO - PROCESS | 30525 | |0;dojo.html;3044.649865265495;3046.2232130806647;3069.202007478055;3070.247789291624;3072.585200997865;5227.503387178222;5240.109181439155;5280.471952804718;5284.180951952444;5332.680039197651;5317.8936421271555;5328.094223981922;5370.624056316059;5409.24270602115;5425.864353391167;4837.201861692825;4893.608511319086;4998.7250701211415;5068.5438310552045;5090.618203634724;618.7677765602333;4977.104121258172;4995;4996.075725990685;5036.84889453317;4881.219004959189;4897.975510122445;4906.877328066791;4921.089598424303;4940;4880.243562247857;4920.975395123001;4938.555530002317;4943.9258411123865;5009.373828271466;4858.951410485885;4860.3195552622665;4862.7568621569135;4870.464248932614;4920.089783390084;5257.894842103175;5336.759845806909;5361.51746342831;5368.382635996872;5420.457954204588;5642.830715078554;5662.801801936913;5804.100364443518;5813.09896965971;5826.446487583715;5679.914801277984;5732.971335143297;5757.165211044375;5774.133879918046;5800.0719884818645;5362.65142765719;5376.838694839161;5382.434844341327;5383.892322153574;5393.865153371158;5841.269841269841;5874.765009399662;5894.882102358015;5928.258967629046;5947.494462970696;5672.858178545487;5685.005124103265;5689.9146512802345;5703.201551782754;5707.143928410772;5666.603337766399;5777;5794.565407594448;5802.506786923074;5807.925533776265;5708.400617935057;5736.5123964462655;5752.654840709571;5783.334916484574;5784.016717158009;5549.72251387429;5655.604107712421;5675.80134695292;5715.085586306171;5720.370759216483;4302.698811083257;4375.562443755663;4383.553486894971;4391.956080439219;4432.756198409054;3914.784686842194;3921.9215615687526;3966.960330396717;3968.7817170055346;4003.779792111462;5615.831525054255;5624.71876406178;5626.212330273765;5632.408597097246;5633.380328163898;5613.915791263134;5728.971355143281;5862.5896187267335;5925.851853703605;5938.465538101592;5468.91796623051;5498.422665620133;5528.834134975958;5533.142362933671;5580.609357344947;4998.800047998039;5000.899802043545;5012.774425150804;5025.422076461181;5043.218301163325;5756.30924289088;5871.266091738533;5873.58884878063;5963.701814909324;5991.281046274475;5613.298337707786;5649.350324712711;5683.119116536944;5693.743781529758;5735.7418916148035;5852.122181672613;5865.178874957424;5874.794382196774;5877.823665290048;5885.588008839341;5610.9158362623775;5614.550835933034;5616.354119276172;5619.185218143428;5632.887342253214;5757.913631295618;5805.187273781589;5840.240768700041;5860.794872179454;5905.527557795452;5664.688442135722;5710.428957104256;5717.742701578522;5743.971280143573;5756.280464941882;5518.448155184449;5587.860303492445;5610.607257491936;5706.28671416073;5721.628094173865;5418.566514678895;5544.667319960815;5552.333719953632;5553.194786755817;5566.137248726453;5647.632903861236;5744.224529688438;5746.339170995222;5749.54003679713;5755.050416681201;5402.135658294654;5474.644148130359;5575.832725018256;5586.916196256978;5595.300587426572 05:36:55 INFO - PROCESS | 30525 | |1;ext.html;580.509469498274;616.1712496691949;620.5594028239949;639.4245179338594;642.9003504456808;32179.67820321796;35626;41677.37483937736;42345.57654423455;42516.574834251645;44921.101577968424;45038.774806125926;45264;45421.318680219825;45500.814942954006;8749.825003499926;8872.955635221815;8878.378513504058;8880.467171969702;8926.598303076345;8823.602937867812;8948.8657670135;8963.731088067369;8993.145651163162;8994.055624159468;8893.510856902867;8924.955375223115;8949.731508054736;8965.23795477382;9007.324450666194;8867.55662216893;8886.889138857643;8917.42036767608;8919.732408027738;8920.643174273022;8836.734897953073;8910.465372077697;8921;8923.330750193696;8958.37291389603;40802.79598602017;41059.1788164238;41232;41397;41438.1712365751;3540.982305012762;3660.798656073915;3697.8890633281044;3820.541535015788;4382.53983331752;32277.51583726246;32282.677173228203;32552.674473255436;32603.51094733581;33613.83193084043;4379.64962802975;4406.581374769392;4428;4463.531329210418;4648.74431906245;335245;335725;336369;337114;337590;33438.83280583582;55999.440005600234;56064.71967640136;56441.43558564444;56461;34175.31649366999;36064;36286.27427451436;36287;36332.455013174294;15504.612384690246;15555.22223888801;15579.532614021597;15728.370865165494;15775.211239438211;13127.934360328138;13229.933850330686;13240.20558766477;13248.801267980987;13261.933690331487;8213.79465513355;8238.588070596446;8302.54336011513;8399.748007559783;8409.41134120618;3179.2528755742383;3207.8075315481146;3279.7868138570916;3284.3759685659647;3313.784604000732;1015.5227043289642;1057;1179.687382843547;1208.9697757555955;1243.0925424440209;32367.51448728271;32735.345293094004;32796.3440731184;33199;33304.33391332208;1100.1199040767353;1105.9170562207867;1116.7040734205443;1170.9355985420714;1183.408295852074;16783.30067581079;17050.82949170517;17124.14379281056;17213.483595492155;17436;446333;448719;450919;451149;453797;55464.72267638636;56927.715361423754;56956.71521642448;56973;57308.42691573114;1351.0010369306765;1382.357203900171;1397.5667543061684;1411.0597927849208;1413.434626149528;29962.400751985275;30946.53580196344;30981.225469363446;31121.377572448877;32059.839700801345;49776.25335619896;50022.24966625576;50143.498565013884;50192;50299.24551131663;403194;403994;404884;405534;407518;27224.591631125153;27237.319067023484;27801.721982780724;27810.86094569514;29268;47983.40124490747;48056.5194348066;48169;48217.75891120522;49840.75079624579;39907.2018559633;39961.80019099886;40785;41691.7915410421;41822;40466.79766601148;40768.3884741735;40782;40835.79582102071;41690;40029.59970400259;40390.19219615532;41257;41268.79365603153;44572.10855782931;34060.82969585136;37691.41931516502;37835.62164378321;38487;38721.41917871178;28750;29117.417651647273;29141;29396.559051613815;29504.40991180207 05:36:55 INFO - PROCESS | 30525 | |2;jquery.html;393.91136994176316;398.5994075953666;399.56846605665885;402.20965802198674;428.86276391554696;14792.334344954475;18106.637867242647;19002.23991040357;19708.113134908926;19723.309684161057;18996.810031899677;19319.517012074706;19405.32081377152;19624.90187549064;19713.71860829049;5362.65142765721;5588.022096133181;5675.489205971462;5678.034734095214;5770.826875193751;5617.269754931853;5634.577406694514;5644.068728659787;5655.1517272409055;5660.745266462998;5543.528800052;5726.856828579277;5780.942190578104;5882.176495290662;5895.498882594985;5763.106718458645;5786.942130578725;5794.6812925289305;5811.302643682743;5868.4424979626865;5526.336839579276;5609.467100625434;5627.184058311522;5654.236678048452;5659.094544872801;12551;12593.559225427067;12622.305773182472;13014.284214368206;13017.674558136028;2194.8902554872193;2235.910563577455;2245.820334373246;2277.202978957368;2415.3840770603383;9867.802643947081;9898.752531186707;10059.849102263472;10473.947630261877;10514.631987880464;1831.6794560951914;1925.9614807703767;1931.5460866696314;1957.109515170594;1976.4959935216427;73555;74036.62981685057;75828;76554.23445765527;77099.61450192826;10799.190060745475;10979.725506862393;11025.393603351733;11377.203595748219;11600;11290.717732056764;11917.165798394202;11967.521299147937;15170.848291517164;15288.847111528965;6173.84565385869;6357.696672182192;7055.2944705529035;7692.230776922263;7724.0731112266885;7566.962165189138;7685.193054729285;7724.420668449889;8253.380996425292;8390.622421991025;3987.441758153861;4074.2869997750868;4077.6330130288416;4162.063535704442;4251.234777740036;1803.3507937142617;1944.397236856579;2010.2059686423781;2028.1785876719953;2034.5523984723336;967.4243824924159;979.6962941488162;990.7424069741919;993.8757655293089;1047.4343854318583;18773.530661733294;18849.151788169565;19475.80524194768;19799.505012374804;19806.306779262657;975.3465178330536;1023.5598692562121;1023.8310678738073;1034.6533911139702;1049.2969710294121;10590.841137382946;10950;10988.670339889815;11072.335659860435;11094.667159985212;440117;442172;452544;456369;458460;96995;98957;99690.5015474918;100731.49634251781;105459;995.1193194023197;1001.7445551384351;1016.1464369929442;1028.6348346336943;1036.6889933020063;17203.764757520006;17326.65346693034;17488.82511174923;17558.385456509473;17659.911700441415;32086.67913320837;38443.80778096092;38879.80560097181;40928.62773092912;42300;54335;55283.44716552783;55440.44559554514;55905;56533;8264.842921991047;8268.958655206685;8270.37972152079;8334.291585215324;8412.747617571482;9779.511024448606;12874.16317939331;13013.544525941546;13394.598162055154;13646.658833528843;9515.429074255568;10322.432266225429;11918.106142039554;12005;12244.897959183716;7037.507374483737;7953.642086106255;11687.649370518899;11983.460744266355;11999.40002999864;8470.703525376583;12175.695607609881;12261.325627090238;12303.56937507183;12311.19977201479;7366.263373662591;7566.6973321068745;7625.351845093229;7866.174051724486;8791.736247912573;11177.832332514856;11787.764244714886;11839.526418943145;11922.940385298018;12043.939780301042 05:36:55 INFO - PROCESS | 30525 | |3;mootools.html;1482.5255918106204;1524.4359586952828;1661.1860188507635;1808.276689324271;1819.7634307540027;7654.923450765491;8224.83550328993;8250.257476827084;8770.780730481742;8835.028146903835;8267.421280510367;8604.612792424341;8628.09405012474;8660;8671.78594996701;2350.153944579954;2395.8921848516857;2401.3756423329887;2402.4834660547976;2411.770881766229;2369.869657168855;2375.133076427109;2394.8084153267782;2401.411654144737;2406.3743426709007;2353.1646265575732;2370.988145059281;2372.9406764830846;2385.71371435428;2395.712514498263;2332.3935776698013;2339.0526836631193;2343.8828058597173;2364.373441038126;2369.2773704020183;2334.8482348647285;2348.6495265222566;2370;2376.845505042184;2378.452955820154;8594.527300998443;8615.698450554262;8649.697260595849;8658.956705216497;8662.566871656392;5082.593392528625;5205.401378841444;5237.79048838046;5253.86865328366;5272.736363181864;3346.330733853215;3347.196672798535;3418.282160746246;3438.6561343865665;3479.5824501059783;1090.6618948126027;1091.0834898685143;1118.5637601335486;1124.162498938288;1124.4602590756401;11754.588589399416;11765.470553825098;11837.467313970892;11858.229215100904;11888.167828252026;4554.316852472156;4594.931076033862;4703.459102203222;4705.058988202373;4706.717596944194;9973.80052398948;9983.351082179635;9999.550020249106;10025.19798416125;10072.244581656258;5240.4759524047295;5314.9901518712095;5322.33470816148;5335.093034184198;5341.412444631087;4264.530901600821;4612.5156858530045;4725.9366642505165;4798.760061996886;4914.557689807934;3843.2904802114444;3918.2359439909515;3996.660283875845;4036.8385264589087;4072.9592704073175;1194.6714653470365;1204.0247399606346;1222.1383924333325;1232.186756740547;1246.3456685240321;916.5417291354323;957.760559860035;979.1885309201758;1046.8691413573304;1065.898739619735;5937.762489500458;6083.574149809471;6127.142200091991;6152.784652537229;6286.842828929313;902.9187373136449;975.327024353194;982.7641366072091;984.4044353166374;1003.2124782046059;4176.665866730655;4273.743575385487;4287.957120428819;4353.325234588644;4405.647548196137;10356.482175891175;10527.21045921559;10555.208359373079;10595.523201455953;10622.044016038593;10396.376217426978;10412.739681508023;10473.21450891171;10512.63205787809;10516.68449946503;7558.9244107558225;7799.64901579419;7875.566843823644;8027.036755589366;8059;5898.764049437975;6069.544784141119;6080.817575472743;6104.786332478342;6213.285472170577;9477.289203309641;9720.951395242979;9723.85414218773;9760.219182465244;9763.511824408894;9311.394759340621;9667.419954802454;9681.903180968382;9684.467354295299;9757.853632195382;7377.557346559223;7466.216047315171;7603.429742769204;7635.809104772425;7660.042494688164;8393.454425462325;8437.535935523605;8459.492430454193;8495.490270583785;8511.404201705822;7415.221401752954;7538.434617403826;7643.541387516767;7688.269614386624;7733.729319473791;7493.737719179802;7506;7512.699492020258;7539.849203016019;7679.5776232305525;6932.376086152271;6966;6992.510524263253;6995.125609298838;7034.964825175842;4860.8298709545;4916;4939.802407903644;4983.576396006235;5041.067402530543;5020.774065167003;5173.81891633791;5211.322528071327;5305.734713264244;5333.7866485340155 05:36:55 INFO - PROCESS | 30525 | |4;prototype.html;315.29059615864304;318.84536000039975;326.37173441125844;336.42807227712893;338.3740080850429;5520.503154716075;5652.491275785179;5693.174489698997;5711.828645140642;5714.771409143629;5563.887222555485;5568.1091025435935;5592.552595792337;5632.549396048316;5640.294963129609;4156.376543518474;4204.348326009458;4262.595053469915;4290.206311832306;4296.849610263642;4318.762468064255;4330.631896288819;4343.239933011726;4350.58669426404;4364.974231055699;4306.00961778791;4328.84849030284;4333.198358303724;4346.869593912188;4351.129774045188;4147.216696820366;4260.126674031816;4301.720388174758;4305.375720520523;4313;3781.2248489059675;3784.924301513982;3799.7910114943666;3808.409696497047;3812.7712337259577;5309.256704061435;5392.865178370533;5422.566194704415;5432.130859062531;5437.673739575638;4818.662693611449;4879;4922.852314430573;4927.802887884481;4934.519644106754;5675.971620141914;5763.0202865512965;5781.71091445426;5787.148112603968;5823.825285241407;4125.339945608688;4191.937120943188;4196.664266858644;4200.789960501963;4214;5955.766587529676;5999.370066143079;6000.519958403273;6006.309274433453;6202.534809889231;4198.769067701306;4209.3896385024;4239.936400953989;4248.277792775236;4253.914921701548;4312.417823593837;4354.8258069677495;4356.910772306924;4364.8908777280185;4370.125974804988;4670.626349892001;4942.827001055018;4947.505249475023;4971.229459433794;4991.5258050485145;5870.706464676835;5909.497692696083;5911.733971971272;5919.6152250103605;5923.763049478059;1464.3190916224007;1468.1411374346128;1474.992625036868;1485.4800819713014;1495.9700805984037;923.9630414783468;936.6721647423348;939.4832841936908;960.6925783749273;972.3436680240809;5648.265725455664;5659.377468478464;5706.258186435737;5712.6286791358425;5716.684323092596;6032.819015429544;6042.788502402394;6049.304330002018;6053.27360716708;6094.299155597075;5451.700156491431;5631.7747290108755;5821.835632873443;5838.190161050088;5839.211706419664;3215.710586047267;3248.8213148277073;3253.6420993690676;3263.902082937516;3274.148721332423;6130.754769809158;6208.2239720034995;6219.222597175353;6342.39747224013;6383.265924418658;6173.47525460332;6176.35148309421;6188.628682279078;6210;6215.751369945242;5981.970090149522;6260.593061450991;6275.466585340206;6292.716827742763;6313.494920406449;5942.7920022799;5971.507123219195;6030.48740857032;6064.545159112996;6082.084143494785;5964.642121472725;6002.6398416093425;6043.969780151071;6052.66710330936;6056.424639659225;5952.672603006876;6180.505559555135;6254.21822272216;6254.405126692846;6279.466245369194;4206.915861682688;4209.326507758744;4257.765248078146;4269.466316710411;4278.165757677348;5873.588848780715;5970.820875373745;6068;6118.837420890017;6153.815385538441;5846.883062338815;5904.3210030845285;5916.792912248223;5920.230370051866;5965.761369545169;5852.970735146297;5860.736266867916;5876.735546900485;5883.441073098049;5942.881142377215;5574.9163762542785;5764.42355764437;5798.391168927202;5808.767649293981;5810.302763668386;5916.071544585458;5939.307297420214;5947.3457919627945;5953.464188223081;5955.374685657944;5665.951798917214;5731.277643119485;5772.278465191851;5782.739776710142;5838.423625620973 05:36:55 INFO - PROCESS | 30525 | |5;yui.html;681.1417613806602;686.3171144711014;761.5506850957934;792.4597455213643;826.945644303513;14214.502492412768;15442.305096270667;15489.767653485193;15543.922280388611;16113.83886161138;13600.523981660644;14952.700945981074;15011.924940375282;15042.623934401645;15131.6973660527;786.1391776005265;793.9642716077761;803.2971150243537;805.0781854776278;824.2293455618985;807.4065561812064;811.6063709101081;812.6180695073335;814.6456291513181;817.7669364231195;843.5107637570226;849.1508491508491;851.4805968359295;852.8379607874515;855.670566831768;840.2731637133866;843.2115971566574;843.4812590257009;846.6232526525698;849.354490587152;614.2506142506136;614.938506149386;617.9907301390483;618.839101833522;619.1888625900085;15586.844131558766;15643.687126257411;15684.451044213398;15750.44873429436;15762.133082680448;14752.704945901129;14939.551813445614;15002.174880381575;15085.170315632637;15102.471413500474;11922.701932451671;12029.879701202963;12031.63905082849;12199;12271.141020128594;3784.7729136251914;3955.248502784462;3966.980165099185;4004.959950400517;4005.559388467266;74860.6256968717;75477.24522754812;75549.24450755533;75695.6215218926;75835.24164758393;10590.735231619272;10823.404712740874;10922.453877306103;11710.297382157098;11982.16124871268;19993.200271989248;20035.39893803188;20048;20060.89969550172;20120.295789647585;8537.914620853837;8588.098249683693;8686.134278978474;8701.129887011248;8738.082501337269;4681.368015317957;4837.32277481153;4918.188498897642;4968.403791544965;5003.424606170264;3604.7656902301264;3730.9067273318383;3732.1789206374556;3732.3654978653694;3740.9438858417147;603.1676286724293;606.5966132521912;609.8140067279522;617.5584457113185;622.9595076320115;692.4356649330779;718.270954980695;719.3957076056138;734.8499598128911;741.5031928607846;9776.462294573867;10048.196144308438;10220.744481388025;10243.180545556337;10298;686.9879901375988;723.5767076260447;743.9888401673979;760.4790718357942;774.5236679442103;4375;4408.272635015251;4450.933236001462;4635.6986795858165;4673.439187297546;105865;109827;111069.44465277783;112919.4354028241;113858;92140;98134;99119;99320;99910;86441;86605.566972166;88173.5591322052;89689;90307;8755.080716524673;8863.734087977371;8905.154010369004;8980.191782739585;9223.631054757734;39141.41287880627;52833;53042;53934.46065539294;54778.17832732592;59481;74000;74101.2589874116;74448;77361.61319193368;11546.076313895037;12168.330741809286;12475.93762031184;12569.49722011146;12932.353382330657;13669.863301366859;13714.637757484885;13731.45074197061;13788.448462061806;14131.293435327987;12968.935155324163;13027.348632568144;13046.34768261602;13203.801942971055;13280.203187808376;12549.372531373578;12939.870601293867;13148;13378.598642040753;13887.236202008986;12223.93888030554;12421.75156496847;12480.438380272728;12521.248725076524;12621.621351359474;10490.895091049297;10818.459077046273;10822.080123189617;10828.620998265023;10845.674629761119;10080.596776129167;11068.889311106786;11155.889903874833;11193.160512961398;11376.54493820238 05:36:55 INFO - PROCESS | 30525 | __end_tp_report 05:36:55 INFO - PROCESS | 30525 | __start_cc_report 05:36:55 INFO - PROCESS | 30525 | _x_x_mozilla_cycle_collect,350 05:36:55 INFO - PROCESS | 30525 | __end_cc_report 05:36:55 INFO - PROCESS | 30525 | __startTimestamp1464957415965__endTimestamp 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | ------- Summary: start ------- 05:36:55 INFO - PROCESS | 30525 | Number of tests: 6 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | [#0] dojo.html Cycles:165 Average:5329.18 Median:5610.61 stddev:709.55 (12.6%) stddev-sans-first:688.72 05:36:55 INFO - PROCESS | 30525 | Values: 3044.6 3046.2 3069.2 3070.2 3072.6 5227.5 5240.1 5280.5 5284.2 5332.7 5317.9 5328.1 5370.6 5409.2 5425.9 4837.2 4893.6 4998.7 5068.5 5090.6 618.8 4977.1 4995.0 4996.1 5036.8 4881.2 4898.0 4906.9 4921.1 4940.0 4880.2 4921.0 4938.6 4943.9 5009.4 4859.0 4860.3 4862.8 4870.5 4920.1 5257.9 5336.8 5361.5 5368.4 5420.5 5642.8 5662.8 5804.1 5813.1 5826.4 5679.9 5733.0 5757.2 5774.1 5800.1 5362.7 5376.8 5382.4 5383.9 5393.9 5841.3 5874.8 5894.9 5928.3 5947.5 5672.9 5685.0 5689.9 5703.2 5707.1 5666.6 5777.0 5794.6 5802.5 5807.9 5708.4 5736.5 5752.7 5783.3 5784.0 5549.7 5655.6 5675.8 5715.1 5720.4 4302.7 4375.6 4383.6 4392.0 4432.8 3914.8 3921.9 3967.0 3968.8 4003.8 5615.8 5624.7 5626.2 5632.4 5633.4 5613.9 5729.0 5862.6 5925.9 5938.5 5468.9 5498.4 5528.8 5533.1 5580.6 4998.8 5000.9 5012.8 5025.4 5043.2 5756.3 5871.3 5873.6 5963.7 5991.3 5613.3 5649.4 5683.1 5693.7 5735.7 5852.1 5865.2 5874.8 5877.8 5885.6 5610.9 5614.6 5616.4 5619.2 5632.9 5757.9 5805.2 5840.2 5860.8 5905.5 5664.7 5710.4 5717.7 5744.0 5756.3 5518.4 5587.9 5610.6 5706.3 5721.6 5418.6 5544.7 5552.3 5553.2 5566.1 5647.6 5744.2 5746.3 5749.5 5755.1 5402.1 5474.6 5575.8 5586.9 5595.3 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | [#1] ext.html Cycles:180 Average:55238.09 Median:406526.00 stddev:105685.26 (26.0%) stddev-sans-first:105902.06 05:36:55 INFO - PROCESS | 30525 | Values: 580.5 616.2 620.6 639.4 642.9 32179.7 35626.0 41677.4 42345.6 42516.6 44921.1 45038.8 45264.0 45421.3 45500.8 8749.8 8873.0 8878.4 8880.5 8926.6 8823.6 8948.9 8963.7 8993.1 8994.1 8893.5 8925.0 8949.7 8965.2 9007.3 8867.6 8886.9 8917.4 8919.7 8920.6 8836.7 8910.5 8921.0 8923.3 8958.4 40802.8 41059.2 41232.0 41397.0 41438.2 3541.0 3660.8 3697.9 3820.5 4382.5 32277.5 32282.7 32552.7 32603.5 33613.8 4379.6 4406.6 4428.0 4463.5 4648.7 335245.0 335725.0 336369.0 337114.0 337590.0 33438.8 55999.4 56064.7 56441.4 56461.0 34175.3 36064.0 36286.3 36287.0 36332.5 15504.6 15555.2 15579.5 15728.4 15775.2 13127.9 13229.9 13240.2 13248.8 13261.9 8213.8 8238.6 8302.5 8399.7 8409.4 3179.3 3207.8 3279.8 3284.4 3313.8 1015.5 1057.0 1179.7 1209.0 1243.1 32367.5 32735.3 32796.3 33199.0 33304.3 1100.1 1105.9 1116.7 1170.9 1183.4 16783.3 17050.8 17124.1 17213.5 17436.0 446333.0 448719.0 450919.0 451149.0 453797.0 55464.7 56927.7 56956.7 56973.0 57308.4 1351.0 1382.4 1397.6 1411.1 1413.4 29962.4 30946.5 30981.2 31121.4 32059.8 49776.3 50022.2 50143.5 50192.0 50299.2 403194.0 403994.0 404884.0 405534.0 407518.0 27224.6 27237.3 27801.7 27810.9 29268.0 47983.4 48056.5 48169.0 48217.8 49840.8 39907.2 39961.8 40785.0 41691.8 41822.0 40466.8 40768.4 40782.0 40835.8 41690.0 40029.6 40390.2 41257.0 41268.8 44572.1 34060.8 37691.4 37835.6 38487.0 38721.4 28750.0 29117.4 29141.0 29396.6 29504.4 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | [#2] jquery.html Cycles:180 Average:27297.76 Median:38661.81 stddev:74593.75 (192.9%) stddev-sans-first:74775.66 05:36:55 INFO - PROCESS | 30525 | Values: 393.9 398.6 399.6 402.2 428.9 14792.3 18106.6 19002.2 19708.1 19723.3 18996.8 19319.5 19405.3 19624.9 19713.7 5362.7 5588.0 5675.5 5678.0 5770.8 5617.3 5634.6 5644.1 5655.2 5660.7 5543.5 5726.9 5780.9 5882.2 5895.5 5763.1 5786.9 5794.7 5811.3 5868.4 5526.3 5609.5 5627.2 5654.2 5659.1 12551.0 12593.6 12622.3 13014.3 13017.7 2194.9 2235.9 2245.8 2277.2 2415.4 9867.8 9898.8 10059.8 10473.9 10514.6 1831.7 1926.0 1931.5 1957.1 1976.5 73555.0 74036.6 75828.0 76554.2 77099.6 10799.2 10979.7 11025.4 11377.2 11600.0 11290.7 11917.2 11967.5 15170.8 15288.8 6173.8 6357.7 7055.3 7692.2 7724.1 7567.0 7685.2 7724.4 8253.4 8390.6 3987.4 4074.3 4077.6 4162.1 4251.2 1803.4 1944.4 2010.2 2028.2 2034.6 967.4 979.7 990.7 993.9 1047.4 18773.5 18849.2 19475.8 19799.5 19806.3 975.3 1023.6 1023.8 1034.7 1049.3 10590.8 10950.0 10988.7 11072.3 11094.7 440117.0 442172.0 452544.0 456369.0 458460.0 96995.0 98957.0 99690.5 100731.5 105459.0 995.1 1001.7 1016.1 1028.6 1036.7 17203.8 17326.7 17488.8 17558.4 17659.9 32086.7 38443.8 38879.8 40928.6 42300.0 54335.0 55283.4 55440.4 55905.0 56533.0 8264.8 8269.0 8270.4 8334.3 8412.7 9779.5 12874.2 13013.5 13394.6 13646.7 9515.4 10322.4 11918.1 12005.0 12244.9 7037.5 7953.6 11687.6 11983.5 11999.4 8470.7 12175.7 12261.3 12303.6 12311.2 7366.3 7566.7 7625.4 7866.2 8791.7 11177.8 11787.8 11839.5 11922.9 12043.9 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | [#3] mootools.html Cycles:180 Average:5704.93 Median:5061.83 stddev:3141.29 (62.1%) stddev-sans-first:3134.07 05:36:55 INFO - PROCESS | 30525 | Values: 1482.5 1524.4 1661.2 1808.3 1819.8 7654.9 8224.8 8250.3 8770.8 8835.0 8267.4 8604.6 8628.1 8660.0 8671.8 2350.2 2395.9 2401.4 2402.5 2411.8 2369.9 2375.1 2394.8 2401.4 2406.4 2353.2 2371.0 2372.9 2385.7 2395.7 2332.4 2339.1 2343.9 2364.4 2369.3 2334.8 2348.6 2370.0 2376.8 2378.5 8594.5 8615.7 8649.7 8659.0 8662.6 5082.6 5205.4 5237.8 5253.9 5272.7 3346.3 3347.2 3418.3 3438.7 3479.6 1090.7 1091.1 1118.6 1124.2 1124.5 11754.6 11765.5 11837.5 11858.2 11888.2 4554.3 4594.9 4703.5 4705.1 4706.7 9973.8 9983.4 9999.6 10025.2 10072.2 5240.5 5315.0 5322.3 5335.1 5341.4 4264.5 4612.5 4725.9 4798.8 4914.6 3843.3 3918.2 3996.7 4036.8 4073.0 1194.7 1204.0 1222.1 1232.2 1246.3 916.5 957.8 979.2 1046.9 1065.9 5937.8 6083.6 6127.1 6152.8 6286.8 902.9 975.3 982.8 984.4 1003.2 4176.7 4273.7 4288.0 4353.3 4405.6 10356.5 10527.2 10555.2 10595.5 10622.0 10396.4 10412.7 10473.2 10512.6 10516.7 7558.9 7799.6 7875.6 8027.0 8059.0 5898.8 6069.5 6080.8 6104.8 6213.3 9477.3 9721.0 9723.9 9760.2 9763.5 9311.4 9667.4 9681.9 9684.5 9757.9 7377.6 7466.2 7603.4 7635.8 7660.0 8393.5 8437.5 8459.5 8495.5 8511.4 7415.2 7538.4 7643.5 7688.3 7733.7 7493.7 7506.0 7512.7 7539.8 7679.6 6932.4 6966.0 6992.5 6995.1 7035.0 4860.8 4916.0 4939.8 4983.6 5041.1 5020.8 5173.8 5211.3 5305.7 5333.8 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | [#4] prototype.html Cycles:180 Average:4938.97 Median:5709.04 stddev:1472.95 (25.8%) stddev-sans-first:1435.62 05:36:55 INFO - PROCESS | 30525 | Values: 315.3 318.8 326.4 336.4 338.4 5520.5 5652.5 5693.2 5711.8 5714.8 5563.9 5568.1 5592.6 5632.5 5640.3 4156.4 4204.3 4262.6 4290.2 4296.8 4318.8 4330.6 4343.2 4350.6 4365.0 4306.0 4328.8 4333.2 4346.9 4351.1 4147.2 4260.1 4301.7 4305.4 4313.0 3781.2 3784.9 3799.8 3808.4 3812.8 5309.3 5392.9 5422.6 5432.1 5437.7 4818.7 4879.0 4922.9 4927.8 4934.5 5676.0 5763.0 5781.7 5787.1 5823.8 4125.3 4191.9 4196.7 4200.8 4214.0 5955.8 5999.4 6000.5 6006.3 6202.5 4198.8 4209.4 4239.9 4248.3 4253.9 4312.4 4354.8 4356.9 4364.9 4370.1 4670.6 4942.8 4947.5 4971.2 4991.5 5870.7 5909.5 5911.7 5919.6 5923.8 1464.3 1468.1 1475.0 1485.5 1496.0 924.0 936.7 939.5 960.7 972.3 5648.3 5659.4 5706.3 5712.6 5716.7 6032.8 6042.8 6049.3 6053.3 6094.3 5451.7 5631.8 5821.8 5838.2 5839.2 3215.7 3248.8 3253.6 3263.9 3274.1 6130.8 6208.2 6219.2 6342.4 6383.3 6173.5 6176.4 6188.6 6210.0 6215.8 5982.0 6260.6 6275.5 6292.7 6313.5 5942.8 5971.5 6030.5 6064.5 6082.1 5964.6 6002.6 6044.0 6052.7 6056.4 5952.7 6180.5 6254.2 6254.4 6279.5 4206.9 4209.3 4257.8 4269.5 4278.2 5873.6 5970.8 6068.0 6118.8 6153.8 5846.9 5904.3 5916.8 5920.2 5965.8 5853.0 5860.7 5876.7 5883.4 5942.9 5574.9 5764.4 5798.4 5808.8 5810.3 5916.1 5939.3 5947.3 5953.5 5955.4 5666.0 5731.3 5772.3 5782.7 5838.4 05:36:55 INFO - PROCESS | 30525 | 05:36:55 INFO - PROCESS | 30525 | [#5] yui.html Cycles:180 Average:20472.99 Median:4391.64 stddev:29450.76 (670.6%) stddev-sans-first:29495.88 05:36:55 INFO - PROCESS | 30525 | Values: 681.1 686.3 761.6 792.5 826.9 14214.5 15442.3 15489.8 15543.9 16113.8 13600.5 14952.7 15011.9 15042.6 15131.7 786.1 794.0 803.3 805.1 824.2 807.4 811.6 812.6 814.6 817.8 843.5 849.2 851.5 852.8 855.7 840.3 843.2 843.5 846.6 849.4 614.3 614.9 618.0 618.8 619.2 15586.8 15643.7 15684.5 15750.4 15762.1 14752.7 14939.6 15002.2 15085.2 15102.5 11922.7 12029.9 12031.6 12199.0 12271.1 3784.8 3955.2 3967.0 4005.0 4005.6 74860.6 75477.2 75549.2 75695.6 75835.2 10590.7 10823.4 10922.5 11710.3 11982.2 19993.2 20035.4 20048.0 20060.9 20120.3 8537.9 8588.1 8686.1 8701.1 8738.1 4681.4 4837.3 4918.2 4968.4 5003.4 3604.8 3730.9 3732.2 3732.4 3740.9 603.2 606.6 609.8 617.6 623.0 692.4 718.3 719.4 734.8 741.5 9776.5 10048.2 10220.7 10243.2 10298.0 687.0 723.6 744.0 760.5 774.5 4375.0 4408.3 4450.9 4635.7 4673.4 105865.0 109827.0 111069.4 112919.4 113858.0 92140.0 98134.0 99119.0 99320.0 99910.0 86441.0 86605.6 88173.6 89689.0 90307.0 8755.1 8863.7 8905.2 8980.2 9223.6 39141.4 52833.0 53042.0 53934.5 54778.2 59481.0 74000.0 74101.3 74448.0 77361.6 11546.1 12168.3 12475.9 12569.5 12932.4 13669.9 13714.6 13731.5 13788.4 14131.3 12968.9 13027.3 13046.3 13203.8 13280.2 12549.4 12939.9 13148.0 13378.6 13887.2 12223.9 12421.8 12480.4 12521.2 12621.6 10490.9 10818.5 10822.1 10828.6 10845.7 10080.6 11068.9 11155.9 11193.2 11376.5 05:36:55 INFO - PROCESS | 30525 | -------- Summary: end -------- 05:36:55 INFO - PROCESS | 30525 | 05:36:56 INFO - TEST-INFO | 30525: exit 0 05:36:56 INFO - TEST-OK | dromaeo_css | took 1109945ms 05:36:56 INFO - TEST-START | kraken 05:36:56 INFO - operating with platform_type : linux_ 05:36:56 INFO - Initialising browser for kraken test... 05:36:56 INFO - TEST-INFO | started process 30757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXC5p0/profile http://localhost:56135/getInfo.html) 05:37:01 INFO - PROCESS | 30757 | __metrics Screen width/height:1600/1200 05:37:01 INFO - PROCESS | 30757 | colorDepth:24 05:37:01 INFO - PROCESS | 30757 | Browser inner width/height: 1024/697 05:37:01 INFO - PROCESS | 30757 | __metrics 05:37:01 ERROR - PROCESS | 30757 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:37:02 INFO - TEST-INFO | 30757: exit 0 05:37:02 INFO - Browser initialized. 05:37:02 INFO - Running cycle 1/1 for kraken test... 05:37:02 INFO - TEST-INFO | started process 30875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiXC5p0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:14 INFO - PROCESS | 30875 | RSS: Main: 168001536 05:37:14 INFO - PROCESS | 30875 | 05:37:17 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56135/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:17 INFO - PROCESS | 30875 | RSS: Main: 172908544 05:37:17 INFO - PROCESS | 30875 | 05:37:20 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56135/tests/kraken/driver.html?testName=audio-dft) 05:37:21 INFO - PROCESS | 30875 | RSS: Main: 171720704 05:37:21 INFO - PROCESS | 30875 | 05:37:24 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56135/tests/kraken/driver.html?testName=audio-fft) 05:37:24 INFO - PROCESS | 30875 | RSS: Main: 167497728 05:37:24 INFO - PROCESS | 30875 | 05:37:26 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56135/tests/kraken/driver.html?testName=audio-oscillator) 05:37:27 INFO - PROCESS | 30875 | RSS: Main: 168165376 05:37:27 INFO - PROCESS | 30875 | 05:37:29 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56135/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:30 INFO - PROCESS | 30875 | RSS: Main: 168226816 05:37:30 INFO - PROCESS | 30875 | 05:37:33 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56135/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:34 INFO - PROCESS | 30875 | RSS: Main: 168267776 05:37:34 INFO - PROCESS | 30875 | 05:37:37 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56135/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:38 INFO - PROCESS | 30875 | RSS: Main: 165576704 05:37:38 INFO - PROCESS | 30875 | 05:37:41 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56135/tests/kraken/driver.html?testName=json-parse-financial) 05:37:41 INFO - PROCESS | 30875 | RSS: Main: 166952960 05:37:41 INFO - PROCESS | 30875 | 05:37:43 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56135/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:43 INFO - PROCESS | 30875 | RSS: Main: 167919616 05:37:43 INFO - PROCESS | 30875 | 05:37:45 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:46 INFO - PROCESS | 30875 | RSS: Main: 168251392 05:37:46 INFO - PROCESS | 30875 | 05:37:48 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:49 INFO - PROCESS | 30875 | RSS: Main: 168095744 05:37:49 INFO - PROCESS | 30875 | 05:37:51 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:52 INFO - PROCESS | 30875 | RSS: Main: 168370176 05:37:52 INFO - PROCESS | 30875 | 05:37:55 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:55 INFO - PROCESS | 30875 | RSS: Main: 168222720 05:37:55 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | Cycle 1(1): loaded http://localhost:56135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56135/tests/kraken/driver.html?testName=ai-astar) 05:37:57 INFO - PROCESS | 30875 | RSS: Main: 169148416 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | __start_tp_report 05:37:57 INFO - PROCESS | 30875 | _x_x_mozilla_page_load 05:37:57 INFO - PROCESS | 30875 | _x_x_mozilla_page_load_details 05:37:57 INFO - PROCESS | 30875 | |i|pagename|runs| 05:37:57 INFO - PROCESS | 30875 | |0;ai-astar;112;109;112;110;111;110;110;111;111;112 05:37:57 INFO - PROCESS | 30875 | |1;audio-beat-detection;168;126;155;185;128;155;152;127;188;126 05:37:57 INFO - PROCESS | 30875 | |2;audio-dft;161;163;163;163;161;164;168;160;163;162 05:37:57 INFO - PROCESS | 30875 | |3;audio-fft;75;75;75;163;75;75;79;74;178;75 05:37:57 INFO - PROCESS | 30875 | |4;audio-oscillator;86;84;141;85;85;86;143;84;84;145 05:37:57 INFO - PROCESS | 30875 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;119;117 05:37:57 INFO - PROCESS | 30875 | |6;imaging-darkroom;146;147;147;146;146;147;146;147;146;152 05:37:57 INFO - PROCESS | 30875 | |7;imaging-desaturate;96;97;96;95;96;95;96;100;95;95 05:37:57 INFO - PROCESS | 30875 | |8;json-parse-financial;55;56;55;54;56;55;57;55;54;55 05:37:57 INFO - PROCESS | 30875 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;62;62;63 05:37:57 INFO - PROCESS | 30875 | |10;stanford-crypto-aes;82;80;82;85;82;88;87;82;114;83 05:37:57 INFO - PROCESS | 30875 | |11;stanford-crypto-ccm;122;130;133;141;121;122;128;124;128;135 05:37:57 INFO - PROCESS | 30875 | |12;stanford-crypto-pbkdf2;172;167;166;161;171;166;164;166;165;164 05:37:57 INFO - PROCESS | 30875 | |13;stanford-crypto-sha256-iterative;64;66;68;64;66;61;62;67;63;73 05:37:57 INFO - PROCESS | 30875 | __end_tp_report 05:37:57 INFO - PROCESS | 30875 | __start_cc_report 05:37:57 INFO - PROCESS | 30875 | _x_x_mozilla_cycle_collect,896 05:37:57 INFO - PROCESS | 30875 | __end_cc_report 05:37:57 INFO - PROCESS | 30875 | __startTimestamp1464957477649__endTimestamp 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | ------- Summary: start ------- 05:37:57 INFO - PROCESS | 30875 | Number of tests: 14 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 05:37:57 INFO - PROCESS | 30875 | Values: 112.0 109.0 112.0 110.0 111.0 110.0 110.0 111.0 111.0 112.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:155.00 stddev:24.04 (15.5%) stddev-sans-first:24.70 05:37:57 INFO - PROCESS | 30875 | Values: 168.0 126.0 155.0 185.0 128.0 155.0 152.0 127.0 188.0 126.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.20 (1.4%) stddev-sans-first:2.24 05:37:57 INFO - PROCESS | 30875 | Values: 161.0 163.0 163.0 163.0 161.0 164.0 168.0 160.0 163.0 162.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.00 stddev:40.29 (53.7%) stddev-sans-first:42.11 05:37:57 INFO - PROCESS | 30875 | Values: 75.0 75.0 75.0 163.0 75.0 75.0 79.0 74.0 178.0 75.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.50 stddev:28.11 (33.3%) stddev-sans-first:29.19 05:37:57 INFO - PROCESS | 30875 | Values: 86.0 84.0 141.0 85.0 85.0 86.0 143.0 84.0 84.0 145.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:37:57 INFO - PROCESS | 30875 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.83 (1.2%) stddev-sans-first:1.90 05:37:57 INFO - PROCESS | 30875 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 152.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 05:37:57 INFO - PROCESS | 30875 | Values: 96.0 97.0 96.0 95.0 96.0 95.0 96.0 100.0 95.0 95.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 05:37:57 INFO - PROCESS | 30875 | Values: 55.0 56.0 55.0 54.0 56.0 55.0 57.0 55.0 54.0 55.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 05:37:57 INFO - PROCESS | 30875 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 63.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:82.50 stddev:9.98 (12.1%) stddev-sans-first:10.45 05:37:57 INFO - PROCESS | 30875 | Values: 82.0 80.0 82.0 85.0 82.0 88.0 87.0 82.0 114.0 83.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.00 stddev:6.52 (5.1%) stddev-sans-first:6.49 05:37:57 INFO - PROCESS | 30875 | Values: 122.0 130.0 133.0 141.0 121.0 122.0 128.0 124.0 128.0 135.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:3.26 (2.0%) stddev-sans-first:2.70 05:37:57 INFO - PROCESS | 30875 | Values: 172.0 167.0 166.0 161.0 171.0 166.0 164.0 166.0 165.0 164.0 05:37:57 INFO - PROCESS | 30875 | 05:37:57 INFO - PROCESS | 30875 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:3.47 (5.3%) stddev-sans-first:3.64 05:37:57 INFO - PROCESS | 30875 | Values: 64.0 66.0 68.0 64.0 66.0 61.0 62.0 67.0 63.0 73.0 05:37:57 INFO - PROCESS | 30875 | -------- Summary: end -------- 05:37:57 INFO - PROCESS | 30875 | 05:37:58 INFO - TEST-INFO | 30875: exit 0 05:37:58 INFO - TEST-OK | kraken | took 61894ms 05:37:58 INFO - SUITE-END | took 1171s 05:37:58 INFO - Completed test suite (00:19:32) 05:37:58 INFO - javascript benchmark 05:37:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7166.288175940606, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3044.649865265495, 3046.2232130806647, 3069.202007478055, 3070.247789291624, 3072.585200997865, 5227.503387178222, 5240.109181439155, 5280.471952804718, 5284.180951952444, 5332.680039197651, 5317.8936421271555, 5328.094223981922, 5370.624056316059, 5409.24270602115, 5425.864353391167, 4837.201861692825, 4893.608511319086, 4998.7250701211415, 5068.5438310552045, 5090.618203634724, 618.7677765602333, 4977.104121258172, 4995.0, 4996.075725990685, 5036.84889453317, 4881.219004959189, 4897.975510122445, 4906.877328066791, 4921.089598424303, 4940.0, 4880.243562247857, 4920.975395123001, 4938.555530002317, 4943.9258411123865, 5009.373828271466, 4858.951410485885, 4860.3195552622665, 4862.7568621569135, 4870.464248932614, 4920.089783390084, 5257.894842103175, 5336.759845806909, 5361.51746342831, 5368.382635996872, 5420.457954204588, 5642.830715078554, 5662.801801936913, 5804.100364443518, 5813.09896965971, 5826.446487583715, 5679.914801277984, 5732.971335143297, 5757.165211044375, 5774.133879918046, 5800.0719884818645, 5362.65142765719, 5376.838694839161, 5382.434844341327, 5383.892322153574, 5393.865153371158, 5841.269841269841, 5874.765009399662, 5894.882102358015, 5928.258967629046, 5947.494462970696, 5672.858178545487, 5685.005124103265, 5689.9146512802345, 5703.201551782754, 5707.143928410772, 5666.603337766399, 5777.0, 5794.565407594448, 5802.506786923074, 5807.925533776265, 5708.400617935057, 5736.5123964462655, 5752.654840709571, 5783.334916484574, 5784.016717158009, 5549.72251387429, 5655.604107712421, 5675.80134695292, 5715.085586306171, 5720.370759216483, 4302.698811083257, 4375.562443755663, 4383.553486894971, 4391.956080439219, 4432.756198409054, 3914.784686842194, 3921.9215615687526, 3966.960330396717, 3968.7817170055346, 4003.779792111462, 5615.831525054255, 5624.71876406178, 5626.212330273765, 5632.408597097246, 5633.380328163898, 5613.915791263134, 5728.971355143281, 5862.5896187267335, 5925.851853703605, 5938.465538101592, 5468.91796623051, 5498.422665620133, 5528.834134975958, 5533.142362933671, 5580.609357344947, 4998.800047998039, 5000.899802043545, 5012.774425150804, 5025.422076461181, 5043.218301163325, 5756.30924289088, 5871.266091738533, 5873.58884878063, 5963.701814909324, 5991.281046274475, 5613.298337707786, 5649.350324712711, 5683.119116536944, 5693.743781529758, 5735.7418916148035, 5852.122181672613, 5865.178874957424, 5874.794382196774, 5877.823665290048, 5885.588008839341, 5610.9158362623775, 5614.550835933034, 5616.354119276172, 5619.185218143428, 5632.887342253214, 5757.913631295618, 5805.187273781589, 5840.240768700041, 5860.794872179454, 5905.527557795452, 5664.688442135722, 5710.428957104256, 5717.742701578522, 5743.971280143573, 5756.280464941882, 5518.448155184449, 5587.860303492445, 5610.607257491936, 5706.28671416073, 5721.628094173865, 5418.566514678895, 5544.667319960815, 5552.333719953632, 5553.194786755817, 5566.137248726453, 5647.632903861236, 5744.224529688438, 5746.339170995222, 5749.54003679713, 5755.050416681201, 5402.135658294654, 5474.644148130359, 5575.832725018256, 5586.916196256978, 5595.300587426572], "value": 5283.343336004254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.509469498274, 616.1712496691949, 620.5594028239949, 639.4245179338594, 642.9003504456808, 32179.67820321796, 35626.0, 41677.37483937736, 42345.57654423455, 42516.574834251645, 44921.101577968424, 45038.774806125926, 45264.0, 45421.318680219825, 45500.814942954006, 8749.825003499926, 8872.955635221815, 8878.378513504058, 8880.467171969702, 8926.598303076345, 8823.602937867812, 8948.8657670135, 8963.731088067369, 8993.145651163162, 8994.055624159468, 8893.510856902867, 8924.955375223115, 8949.731508054736, 8965.23795477382, 9007.324450666194, 8867.55662216893, 8886.889138857643, 8917.42036767608, 8919.732408027738, 8920.643174273022, 8836.734897953073, 8910.465372077697, 8921.0, 8923.330750193696, 8958.37291389603, 40802.79598602017, 41059.1788164238, 41232.0, 41397.0, 41438.1712365751, 3540.982305012762, 3660.798656073915, 3697.8890633281044, 3820.541535015788, 4382.53983331752, 32277.51583726246, 32282.677173228203, 32552.674473255436, 32603.51094733581, 33613.83193084043, 4379.64962802975, 4406.581374769392, 4428.0, 4463.531329210418, 4648.74431906245, 335245.0, 335725.0, 336369.0, 337114.0, 337590.0, 33438.83280583582, 55999.440005600234, 56064.71967640136, 56441.43558564444, 56461.0, 34175.31649366999, 36064.0, 36286.27427451436, 36287.0, 36332.455013174294, 15504.612384690246, 15555.22223888801, 15579.532614021597, 15728.370865165494, 15775.211239438211, 13127.934360328138, 13229.933850330686, 13240.20558766477, 13248.801267980987, 13261.933690331487, 8213.79465513355, 8238.588070596446, 8302.54336011513, 8399.748007559783, 8409.41134120618, 3179.2528755742383, 3207.8075315481146, 3279.7868138570916, 3284.3759685659647, 3313.784604000732, 1015.5227043289642, 1057.0, 1179.687382843547, 1208.9697757555955, 1243.0925424440209, 32367.51448728271, 32735.345293094004, 32796.3440731184, 33199.0, 33304.33391332208, 1100.1199040767353, 1105.9170562207867, 1116.7040734205443, 1170.9355985420714, 1183.408295852074, 16783.30067581079, 17050.82949170517, 17124.14379281056, 17213.483595492155, 17436.0, 446333.0, 448719.0, 450919.0, 451149.0, 453797.0, 55464.72267638636, 56927.715361423754, 56956.71521642448, 56973.0, 57308.42691573114, 1351.0010369306765, 1382.357203900171, 1397.5667543061684, 1411.0597927849208, 1413.434626149528, 29962.400751985275, 30946.53580196344, 30981.225469363446, 31121.377572448877, 32059.839700801345, 49776.25335619896, 50022.24966625576, 50143.498565013884, 50192.0, 50299.24551131663, 403194.0, 403994.0, 404884.0, 405534.0, 407518.0, 27224.591631125153, 27237.319067023484, 27801.721982780724, 27810.86094569514, 29268.0, 47983.40124490747, 48056.5194348066, 48169.0, 48217.75891120522, 49840.75079624579, 39907.2018559633, 39961.80019099886, 40785.0, 41691.7915410421, 41822.0, 40466.79766601148, 40768.3884741735, 40782.0, 40835.79582102071, 41690.0, 40029.59970400259, 40390.19219615532, 41257.0, 41268.79365603153, 44572.10855782931, 34060.82969585136, 37691.41931516502, 37835.62164378321, 38487.0, 38721.41917871178, 28750.0, 29117.417651647273, 29141.0, 29396.559051613815, 29504.40991180207], "value": 18852.087876869635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.91136994176316, 398.5994075953666, 399.56846605665885, 402.20965802198674, 428.86276391554696, 14792.334344954475, 18106.637867242647, 19002.23991040357, 19708.113134908926, 19723.309684161057, 18996.810031899677, 19319.517012074706, 19405.32081377152, 19624.90187549064, 19713.71860829049, 5362.65142765721, 5588.022096133181, 5675.489205971462, 5678.034734095214, 5770.826875193751, 5617.269754931853, 5634.577406694514, 5644.068728659787, 5655.1517272409055, 5660.745266462998, 5543.528800052, 5726.856828579277, 5780.942190578104, 5882.176495290662, 5895.498882594985, 5763.106718458645, 5786.942130578725, 5794.6812925289305, 5811.302643682743, 5868.4424979626865, 5526.336839579276, 5609.467100625434, 5627.184058311522, 5654.236678048452, 5659.094544872801, 12551.0, 12593.559225427067, 12622.305773182472, 13014.284214368206, 13017.674558136028, 2194.8902554872193, 2235.910563577455, 2245.820334373246, 2277.202978957368, 2415.3840770603383, 9867.802643947081, 9898.752531186707, 10059.849102263472, 10473.947630261877, 10514.631987880464, 1831.6794560951914, 1925.9614807703767, 1931.5460866696314, 1957.109515170594, 1976.4959935216427, 73555.0, 74036.62981685057, 75828.0, 76554.23445765527, 77099.61450192826, 10799.190060745475, 10979.725506862393, 11025.393603351733, 11377.203595748219, 11600.0, 11290.717732056764, 11917.165798394202, 11967.521299147937, 15170.848291517164, 15288.847111528965, 6173.84565385869, 6357.696672182192, 7055.2944705529035, 7692.230776922263, 7724.0731112266885, 7566.962165189138, 7685.193054729285, 7724.420668449889, 8253.380996425292, 8390.622421991025, 3987.441758153861, 4074.2869997750868, 4077.6330130288416, 4162.063535704442, 4251.234777740036, 1803.3507937142617, 1944.397236856579, 2010.2059686423781, 2028.1785876719953, 2034.5523984723336, 967.4243824924159, 979.6962941488162, 990.7424069741919, 993.8757655293089, 1047.4343854318583, 18773.530661733294, 18849.151788169565, 19475.80524194768, 19799.505012374804, 19806.306779262657, 975.3465178330536, 1023.5598692562121, 1023.8310678738073, 1034.6533911139702, 1049.2969710294121, 10590.841137382946, 10950.0, 10988.670339889815, 11072.335659860435, 11094.667159985212, 440117.0, 442172.0, 452544.0, 456369.0, 458460.0, 96995.0, 98957.0, 99690.5015474918, 100731.49634251781, 105459.0, 995.1193194023197, 1001.7445551384351, 1016.1464369929442, 1028.6348346336943, 1036.6889933020063, 17203.764757520006, 17326.65346693034, 17488.82511174923, 17558.385456509473, 17659.911700441415, 32086.67913320837, 38443.80778096092, 38879.80560097181, 40928.62773092912, 42300.0, 54335.0, 55283.44716552783, 55440.44559554514, 55905.0, 56533.0, 8264.842921991047, 8268.958655206685, 8270.37972152079, 8334.291585215324, 8412.747617571482, 9779.511024448606, 12874.16317939331, 13013.544525941546, 13394.598162055154, 13646.658833528843, 9515.429074255568, 10322.432266225429, 11918.106142039554, 12005.0, 12244.897959183716, 7037.507374483737, 7953.642086106255, 11687.649370518899, 11983.460744266355, 11999.40002999864, 8470.703525376583, 12175.695607609881, 12261.325627090238, 12303.56937507183, 12311.19977201479, 7366.263373662591, 7566.6973321068745, 7625.351845093229, 7866.174051724486, 8791.736247912573, 11177.832332514856, 11787.764244714886, 11839.526418943145, 11922.940385298018, 12043.939780301042], "value": 8825.677883746754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.5255918106204, 1524.4359586952828, 1661.1860188507635, 1808.276689324271, 1819.7634307540027, 7654.923450765491, 8224.83550328993, 8250.257476827084, 8770.780730481742, 8835.028146903835, 8267.421280510367, 8604.612792424341, 8628.09405012474, 8660.0, 8671.78594996701, 2350.153944579954, 2395.8921848516857, 2401.3756423329887, 2402.4834660547976, 2411.770881766229, 2369.869657168855, 2375.133076427109, 2394.8084153267782, 2401.411654144737, 2406.3743426709007, 2353.1646265575732, 2370.988145059281, 2372.9406764830846, 2385.71371435428, 2395.712514498263, 2332.3935776698013, 2339.0526836631193, 2343.8828058597173, 2364.373441038126, 2369.2773704020183, 2334.8482348647285, 2348.6495265222566, 2370.0, 2376.845505042184, 2378.452955820154, 8594.527300998443, 8615.698450554262, 8649.697260595849, 8658.956705216497, 8662.566871656392, 5082.593392528625, 5205.401378841444, 5237.79048838046, 5253.86865328366, 5272.736363181864, 3346.330733853215, 3347.196672798535, 3418.282160746246, 3438.6561343865665, 3479.5824501059783, 1090.6618948126027, 1091.0834898685143, 1118.5637601335486, 1124.162498938288, 1124.4602590756401, 11754.588589399416, 11765.470553825098, 11837.467313970892, 11858.229215100904, 11888.167828252026, 4554.316852472156, 4594.931076033862, 4703.459102203222, 4705.058988202373, 4706.717596944194, 9973.80052398948, 9983.351082179635, 9999.550020249106, 10025.19798416125, 10072.244581656258, 5240.4759524047295, 5314.9901518712095, 5322.33470816148, 5335.093034184198, 5341.412444631087, 4264.530901600821, 4612.5156858530045, 4725.9366642505165, 4798.760061996886, 4914.557689807934, 3843.2904802114444, 3918.2359439909515, 3996.660283875845, 4036.8385264589087, 4072.9592704073175, 1194.6714653470365, 1204.0247399606346, 1222.1383924333325, 1232.186756740547, 1246.3456685240321, 916.5417291354323, 957.760559860035, 979.1885309201758, 1046.8691413573304, 1065.898739619735, 5937.762489500458, 6083.574149809471, 6127.142200091991, 6152.784652537229, 6286.842828929313, 902.9187373136449, 975.327024353194, 982.7641366072091, 984.4044353166374, 1003.2124782046059, 4176.665866730655, 4273.743575385487, 4287.957120428819, 4353.325234588644, 4405.647548196137, 10356.482175891175, 10527.21045921559, 10555.208359373079, 10595.523201455953, 10622.044016038593, 10396.376217426978, 10412.739681508023, 10473.21450891171, 10512.63205787809, 10516.68449946503, 7558.9244107558225, 7799.64901579419, 7875.566843823644, 8027.036755589366, 8059.0, 5898.764049437975, 6069.544784141119, 6080.817575472743, 6104.786332478342, 6213.285472170577, 9477.289203309641, 9720.951395242979, 9723.85414218773, 9760.219182465244, 9763.511824408894, 9311.394759340621, 9667.419954802454, 9681.903180968382, 9684.467354295299, 9757.853632195382, 7377.557346559223, 7466.216047315171, 7603.429742769204, 7635.809104772425, 7660.042494688164, 8393.454425462325, 8437.535935523605, 8459.492430454193, 8495.490270583785, 8511.404201705822, 7415.221401752954, 7538.434617403826, 7643.541387516767, 7688.269614386624, 7733.729319473791, 7493.737719179802, 7506.0, 7512.699492020258, 7539.849203016019, 7679.5776232305525, 6932.376086152271, 6966.0, 6992.510524263253, 6995.125609298838, 7034.964825175842, 4860.8298709545, 4916.0, 4939.802407903644, 4983.576396006235, 5041.067402530543, 5020.774065167003, 5173.81891633791, 5211.322528071327, 5305.734713264244, 5333.7866485340155], "value": 4617.068294569107, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.29059615864304, 318.84536000039975, 326.37173441125844, 336.42807227712893, 338.3740080850429, 5520.503154716075, 5652.491275785179, 5693.174489698997, 5711.828645140642, 5714.771409143629, 5563.887222555485, 5568.1091025435935, 5592.552595792337, 5632.549396048316, 5640.294963129609, 4156.376543518474, 4204.348326009458, 4262.595053469915, 4290.206311832306, 4296.849610263642, 4318.762468064255, 4330.631896288819, 4343.239933011726, 4350.58669426404, 4364.974231055699, 4306.00961778791, 4328.84849030284, 4333.198358303724, 4346.869593912188, 4351.129774045188, 4147.216696820366, 4260.126674031816, 4301.720388174758, 4305.375720520523, 4313.0, 3781.2248489059675, 3784.924301513982, 3799.7910114943666, 3808.409696497047, 3812.7712337259577, 5309.256704061435, 5392.865178370533, 5422.566194704415, 5432.130859062531, 5437.673739575638, 4818.662693611449, 4879.0, 4922.852314430573, 4927.802887884481, 4934.519644106754, 5675.971620141914, 5763.0202865512965, 5781.71091445426, 5787.148112603968, 5823.825285241407, 4125.339945608688, 4191.937120943188, 4196.664266858644, 4200.789960501963, 4214.0, 5955.766587529676, 5999.370066143079, 6000.519958403273, 6006.309274433453, 6202.534809889231, 4198.769067701306, 4209.3896385024, 4239.936400953989, 4248.277792775236, 4253.914921701548, 4312.417823593837, 4354.8258069677495, 4356.910772306924, 4364.8908777280185, 4370.125974804988, 4670.626349892001, 4942.827001055018, 4947.505249475023, 4971.229459433794, 4991.5258050485145, 5870.706464676835, 5909.497692696083, 5911.733971971272, 5919.6152250103605, 5923.763049478059, 1464.3190916224007, 1468.1411374346128, 1474.992625036868, 1485.4800819713014, 1495.9700805984037, 923.9630414783468, 936.6721647423348, 939.4832841936908, 960.6925783749273, 972.3436680240809, 5648.265725455664, 5659.377468478464, 5706.258186435737, 5712.6286791358425, 5716.684323092596, 6032.819015429544, 6042.788502402394, 6049.304330002018, 6053.27360716708, 6094.299155597075, 5451.700156491431, 5631.7747290108755, 5821.835632873443, 5838.190161050088, 5839.211706419664, 3215.710586047267, 3248.8213148277073, 3253.6420993690676, 3263.902082937516, 3274.148721332423, 6130.754769809158, 6208.2239720034995, 6219.222597175353, 6342.39747224013, 6383.265924418658, 6173.47525460332, 6176.35148309421, 6188.628682279078, 6210.0, 6215.751369945242, 5981.970090149522, 6260.593061450991, 6275.466585340206, 6292.716827742763, 6313.494920406449, 5942.7920022799, 5971.507123219195, 6030.48740857032, 6064.545159112996, 6082.084143494785, 5964.642121472725, 6002.6398416093425, 6043.969780151071, 6052.66710330936, 6056.424639659225, 5952.672603006876, 6180.505559555135, 6254.21822272216, 6254.405126692846, 6279.466245369194, 4206.915861682688, 4209.326507758744, 4257.765248078146, 4269.466316710411, 4278.165757677348, 5873.588848780715, 5970.820875373745, 6068.0, 6118.837420890017, 6153.815385538441, 5846.883062338815, 5904.3210030845285, 5916.792912248223, 5920.230370051866, 5965.761369545169, 5852.970735146297, 5860.736266867916, 5876.735546900485, 5883.441073098049, 5942.881142377215, 5574.9163762542785, 5764.42355764437, 5798.391168927202, 5808.767649293981, 5810.302763668386, 5916.071544585458, 5939.307297420214, 5947.3457919627945, 5953.464188223081, 5955.374685657944, 5665.951798917214, 5731.277643119485, 5772.278465191851, 5782.739776710142, 5838.423625620973], "value": 4458.196278093798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.1417613806602, 686.3171144711014, 761.5506850957934, 792.4597455213643, 826.945644303513, 14214.502492412768, 15442.305096270667, 15489.767653485193, 15543.922280388611, 16113.83886161138, 13600.523981660644, 14952.700945981074, 15011.924940375282, 15042.623934401645, 15131.6973660527, 786.1391776005265, 793.9642716077761, 803.2971150243537, 805.0781854776278, 824.2293455618985, 807.4065561812064, 811.6063709101081, 812.6180695073335, 814.6456291513181, 817.7669364231195, 843.5107637570226, 849.1508491508491, 851.4805968359295, 852.8379607874515, 855.670566831768, 840.2731637133866, 843.2115971566574, 843.4812590257009, 846.6232526525698, 849.354490587152, 614.2506142506136, 614.938506149386, 617.9907301390483, 618.839101833522, 619.1888625900085, 15586.844131558766, 15643.687126257411, 15684.451044213398, 15750.44873429436, 15762.133082680448, 14752.704945901129, 14939.551813445614, 15002.174880381575, 15085.170315632637, 15102.471413500474, 11922.701932451671, 12029.879701202963, 12031.63905082849, 12199.0, 12271.141020128594, 3784.7729136251914, 3955.248502784462, 3966.980165099185, 4004.959950400517, 4005.559388467266, 74860.6256968717, 75477.24522754812, 75549.24450755533, 75695.6215218926, 75835.24164758393, 10590.735231619272, 10823.404712740874, 10922.453877306103, 11710.297382157098, 11982.16124871268, 19993.200271989248, 20035.39893803188, 20048.0, 20060.89969550172, 20120.295789647585, 8537.914620853837, 8588.098249683693, 8686.134278978474, 8701.129887011248, 8738.082501337269, 4681.368015317957, 4837.32277481153, 4918.188498897642, 4968.403791544965, 5003.424606170264, 3604.7656902301264, 3730.9067273318383, 3732.1789206374556, 3732.3654978653694, 3740.9438858417147, 603.1676286724293, 606.5966132521912, 609.8140067279522, 617.5584457113185, 622.9595076320115, 692.4356649330779, 718.270954980695, 719.3957076056138, 734.8499598128911, 741.5031928607846, 9776.462294573867, 10048.196144308438, 10220.744481388025, 10243.180545556337, 10298.0, 686.9879901375988, 723.5767076260447, 743.9888401673979, 760.4790718357942, 774.5236679442103, 4375.0, 4408.272635015251, 4450.933236001462, 4635.6986795858165, 4673.439187297546, 105865.0, 109827.0, 111069.44465277783, 112919.4354028241, 113858.0, 92140.0, 98134.0, 99119.0, 99320.0, 99910.0, 86441.0, 86605.566972166, 88173.5591322052, 89689.0, 90307.0, 8755.080716524673, 8863.734087977371, 8905.154010369004, 8980.191782739585, 9223.631054757734, 39141.41287880627, 52833.0, 53042.0, 53934.46065539294, 54778.17832732592, 59481.0, 74000.0, 74101.2589874116, 74448.0, 77361.61319193368, 11546.076313895037, 12168.330741809286, 12475.93762031184, 12569.49722011146, 12932.353382330657, 13669.863301366859, 13714.637757484885, 13731.45074197061, 13788.448462061806, 14131.293435327987, 12968.935155324163, 13027.348632568144, 13046.34768261602, 13203.801942971055, 13280.203187808376, 12549.372531373578, 12939.870601293867, 13148.0, 13378.598642040753, 13887.236202008986, 12223.93888030554, 12421.75156496847, 12480.438380272728, 12521.248725076524, 12621.621351359474, 10490.895091049297, 10818.459077046273, 10822.080123189617, 10828.620998265023, 10845.674629761119, 10080.596776129167, 11068.889311106786, 11155.889903874833, 11193.160512961398, 11376.54493820238], "value": 7484.855892399681, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 126.0, 155.0, 185.0, 128.0, 155.0, 152.0, 127.0, 188.0, 126.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 163.0, 161.0, 164.0, 168.0, 160.0, 163.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 163.0, 75.0, 75.0, 79.0, 74.0, 178.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 141.0, 85.0, 85.0, 86.0, 143.0, 84.0, 84.0, 145.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 152.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 96.0, 100.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 56.0, 55.0, 57.0, 55.0, 54.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 63.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 85.0, 82.0, 88.0, 87.0, 82.0, 114.0, 83.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 133.0, 141.0, 121.0, 122.0, 128.0, 124.0, 128.0, 135.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 166.0, 161.0, 171.0, 166.0, 164.0, 166.0, 165.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 68.0, 64.0, 66.0, 61.0, 62.0, 67.0, 63.0, 73.0], "value": 65.4, "unit": "score"}]}]} 05:37:58 INFO - Return code: 0 05:37:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:58 ERROR - # TBPL SUCCESS # 05:37:58 INFO - Running post-action listener: _resource_record_post_action 05:37:58 INFO - ##### 05:37:58 INFO - ##### Finished run-tests step (success) 05:37:58 INFO - ##### 05:37:58 INFO - Running post-run listener: _resource_record_post_run 05:37:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 541777920; Read time: 0; Write time: 605084 05:37:59 INFO - TinderboxPrint: CPU usage
13.5% 05:37:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:37:59 INFO - TinderboxPrint: I/O write bytes / time
541,777,920 / 605,084 05:37:59 INFO - TinderboxPrint: CPU idle
8,214.1 (86.5%) 05:37:59 INFO - TinderboxPrint: CPU user
1,224.7 (12.9%) 05:37:59 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:59 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254410752; Read time: 0; Write time: 402528 05:37:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 287367168; Read time: 0; Write time: 202556 05:37:59 INFO - Running post-run listener: _upload_blobber_files 05:37:59 INFO - Blob upload gear active. 05:37:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:59 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:37:59 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:37:59 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:37:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:00 INFO - (blobuploader) - INFO - Done attempting. 05:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:38:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:06 INFO - (blobuploader) - INFO - Done attempting. 05:38:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:38:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:38:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:07 INFO - (blobuploader) - INFO - Done attempting. 05:38:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:07 INFO - Return code: 0 05:38:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232f335dae138b71befd04a06a8e47ef81b1f59bb5b6e9032ecbddf17013ec92a1e230e685fde9ae0e5d85e5a3734b5ec45b03977a33a91f793276e4eb75e443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793006a70645dc3c561b3333b25ef2bf3e2b3174a2251eda9e2d66316a422279fbc2f951ab8a7c85f98931ac784f3a514696729a31ccc5f7c53647be90da2e57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3dacc4c512ee39b4d072a5c66023dc5770ae270d79b9ac934c56c155ef5de714fa1deab5b71d6fa8ca14aabfd50a9c604f36bc1b9ca7d5ee006e5388f52f14a"} 05:38:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:07 INFO - Contents: 05:38:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232f335dae138b71befd04a06a8e47ef81b1f59bb5b6e9032ecbddf17013ec92a1e230e685fde9ae0e5d85e5a3734b5ec45b03977a33a91f793276e4eb75e443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793006a70645dc3c561b3333b25ef2bf3e2b3174a2251eda9e2d66316a422279fbc2f951ab8a7c85f98931ac784f3a514696729a31ccc5f7c53647be90da2e57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3dacc4c512ee39b4d072a5c66023dc5770ae270d79b9ac934c56c155ef5de714fa1deab5b71d6fa8ca14aabfd50a9c604f36bc1b9ca7d5ee006e5388f52f14a"} 05:38:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:07 INFO - Copying logs to upload dir... 05:38:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.487158 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-03 05:38:06.478551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 05:38:06.485258) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232f335dae138b71befd04a06a8e47ef81b1f59bb5b6e9032ecbddf17013ec92a1e230e685fde9ae0e5d85e5a3734b5ec45b03977a33a91f793276e4eb75e443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793006a70645dc3c561b3333b25ef2bf3e2b3174a2251eda9e2d66316a422279fbc2f951ab8a7c85f98931ac784f3a514696729a31ccc5f7c53647be90da2e57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3dacc4c512ee39b4d072a5c66023dc5770ae270d79b9ac934c56c155ef5de714fa1deab5b71d6fa8ca14aabfd50a9c604f36bc1b9ca7d5ee006e5388f52f14a"} build_url:https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/aPc1uvKcRi2-jtllvljI2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/232f335dae138b71befd04a06a8e47ef81b1f59bb5b6e9032ecbddf17013ec92a1e230e685fde9ae0e5d85e5a3734b5ec45b03977a33a91f793276e4eb75e443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793006a70645dc3c561b3333b25ef2bf3e2b3174a2251eda9e2d66316a422279fbc2f951ab8a7c85f98931ac784f3a514696729a31ccc5f7c53647be90da2e57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3dacc4c512ee39b4d072a5c66023dc5770ae270d79b9ac934c56c155ef5de714fa1deab5b71d6fa8ca14aabfd50a9c604f36bc1b9ca7d5ee006e5388f52f14a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 05:38:06.513345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:38:06.513781) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464954725.19081-589329491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 05:38:06.564617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 05:38:06.564942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 05:38:06.565242) ========= ========= Total master_lag: 0.18 =========