builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1463489894.33 results: success (0) buildid: 20160517050231 builduid: 863f297cae7d4c62b7e739ec681fed25 revision: 6e2add233b54766d44568f81aa207c624bbe4437 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.331578) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.332023) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.332302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.344939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.345205) ========= 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=cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 05:58:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-05-17 05:58:15 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112034 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.468295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.468630) ========= 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=cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022399 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:14.518288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 05:58:14.518655) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6e2add233b54766d44568f81aa207c624bbe4437 --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 6e2add233b54766d44568f81aa207c624bbe4437 --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=cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 05:58:15,324 truncating revision to first 12 chars 2016-05-17 05:58:15,324 Setting DEBUG logging. 2016-05-17 05:58:15,324 attempt 1/10 2016-05-17 05:58:15,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6e2add233b54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 05:58:16,258 unpacking tar archive at: fx-team-6e2add233b54/testing/mozharness/ program finished with exit code 0 elapsedTime=1.198674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 05:58:15.730606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:15.730936) ========= script_repo_revision: 6e2add233b54766d44568f81aa207c624bbe4437 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:15.731409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:15.731721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 05:58:15.741224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-17 05:58:15.741509) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:16 INFO - MultiFileLogger online at 20160517 05:58:16 in /builds/slave/test 05:58:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:58:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:16 INFO - {'append_to_log': False, 05:58:16 INFO - 'base_work_dir': '/builds/slave/test', 05:58:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:58:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:16 INFO - 'branch': 'Fx-Team-Non-PGO', 05:58:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:16 INFO - 'config_files': ('talos/linux_config.py',), 05:58:16 INFO - 'default_actions': ('clobber', 05:58:16 INFO - 'read-buildbot-config', 05:58:16 INFO - 'download-and-extract', 05:58:16 INFO - 'populate-webroot', 05:58:16 INFO - 'create-virtualenv', 05:58:16 INFO - 'install', 05:58:16 INFO - 'run-tests'), 05:58:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:16 INFO - 'download_minidump_stackwalk': True, 05:58:16 INFO - 'download_symbols': 'ondemand', 05:58:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:16 INFO - 'installer_path': 'installer.exe', 05:58:16 INFO - 'log_level': 'info', 05:58:16 INFO - 'log_name': 'talos', 05:58:16 INFO - 'log_to_console': True, 05:58:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:16 INFO - 'opt_config_files': (), 05:58:16 INFO - 'pip_index': False, 05:58:16 INFO - 'sps_profile': False, 05:58:16 INFO - 'sps_profile_interval': 0, 05:58:16 INFO - 'suite': 'dromaeojs', 05:58:16 INFO - 'system_bits': '32', 05:58:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:16 INFO - 'title': 'talos-linux64-ix-054', 05:58:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:16 INFO - 'use_talos_json': True, 05:58:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:16 INFO - 'work_dir': 'build'} 05:58:16 INFO - ##### 05:58:16 INFO - ##### Running clobber step. 05:58:16 INFO - ##### 05:58:16 INFO - Running pre-action listener: _resource_record_pre_action 05:58:16 INFO - Running main action method: clobber 05:58:16 INFO - rmtree: /builds/slave/test/build 05:58:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:17 INFO - Running post-action listener: _resource_record_post_action 05:58:17 INFO - ##### 05:58:17 INFO - ##### Finished clobber step (success) 05:58:17 INFO - ##### 05:58:17 INFO - ##### 05:58:17 INFO - ##### Running read-buildbot-config step. 05:58:17 INFO - ##### 05:58:17 INFO - Running pre-action listener: _resource_record_pre_action 05:58:17 INFO - Running main action method: read_buildbot_config 05:58:17 INFO - Using buildbot properties: 05:58:17 INFO - { 05:58:17 INFO - "project": "", 05:58:17 INFO - "product": "firefox", 05:58:17 INFO - "script_repo_revision": "production", 05:58:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:58:17 INFO - "repository": "", 05:58:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:58:17 INFO - "buildid": "20160517050231", 05:58:17 INFO - "pgo_build": "False", 05:58:17 INFO - "basedir": "/builds/slave/test", 05:58:17 INFO - "buildnumber": 1689, 05:58:17 INFO - "slavename": "talos-linux64-ix-054", 05:58:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:58:17 INFO - "platform": "ubuntu64_hw", 05:58:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:58:17 INFO - "branch": "fx-team", 05:58:17 INFO - "repo_path": "integration/fx-team", 05:58:17 INFO - "revision": "6e2add233b54766d44568f81aa207c624bbe4437", 05:58:17 INFO - "stage_platform": "linux64", 05:58:17 INFO - "builduid": "863f297cae7d4c62b7e739ec681fed25", 05:58:17 INFO - "slavebuilddir": "test" 05:58:17 INFO - } 05:58:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:58:17 INFO - Running post-action listener: _resource_record_post_action 05:58:17 INFO - ##### 05:58:17 INFO - ##### Finished read-buildbot-config step (success) 05:58:17 INFO - ##### 05:58:17 INFO - ##### 05:58:17 INFO - ##### Running download-and-extract step. 05:58:17 INFO - ##### 05:58:17 INFO - Running pre-action listener: _resource_record_pre_action 05:58:17 INFO - Running main action method: download_and_extract 05:58:17 INFO - mkdir: /builds/slave/test/build/tests 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:17 INFO - https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:17 INFO - Downloaded 1361 bytes. 05:58:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:58:17 INFO - Using the following test package requirements: 05:58:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'jsshell-linux-x86_64.zip'], 05:58:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:17 INFO - https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:18 INFO - Downloaded 22448136 bytes. 05:58:18 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:58:18 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:58:20 INFO - Return code: 0 05:58:20 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:58:20 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:58:20 INFO - https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:21 INFO - Downloaded 22448136 bytes. 05:58:21 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:58:21 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:58:22 INFO - Return code: 0 05:58:22 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:58:22 INFO - https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:23 INFO - Downloaded 10840194 bytes. 05:58:23 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:58:23 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:58:23 INFO - Return code: 0 05:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:23 INFO - https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIzLsMhDQsu3wXYwlKluyQ/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:58:25 INFO - Downloaded 54767785 bytes. 05:58:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:25 INFO - mkdir: /builds/slave/test/properties 05:58:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:25 INFO - Contents: 05:58:25 INFO - build_url:https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:58:26 INFO - Running post-action listener: _resource_record_post_action 05:58:26 INFO - Running post-action listener: set_extra_try_arguments 05:58:26 INFO - ##### 05:58:26 INFO - ##### Finished download-and-extract step (success) 05:58:26 INFO - ##### 05:58:26 INFO - ##### 05:58:26 INFO - ##### Running populate-webroot step. 05:58:26 INFO - ##### 05:58:26 INFO - Running pre-action listener: _resource_record_pre_action 05:58:26 INFO - Running main action method: populate_webroot 05:58:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:26 INFO - '--tppagecycles', 05:58:26 INFO - '7'], 05:58:26 INFO - 'tests': ['tsvgm']}}, 05:58:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['damp', 'tps']}, 05:58:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'tests': ['damp', 'tps']}, 05:58:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['dromaeo_dom']}, 05:58:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['a11yr', 05:58:26 INFO - 'ts_paint', 05:58:26 INFO - 'tpaint', 05:58:26 INFO - 'sessionrestore', 05:58:26 INFO - 'sessionrestore_no_auto_restore', 05:58:26 INFO - 'tabpaint']}, 05:58:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:26 INFO - 'ts_paint', 05:58:26 INFO - 'tpaint', 05:58:26 INFO - 'sessionrestore', 05:58:26 INFO - 'sessionrestore_no_auto_restore', 05:58:26 INFO - 'tabpaint']}, 05:58:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:26 INFO - 'ts_paint', 05:58:26 INFO - 'tpaint', 05:58:26 INFO - 'sessionrestore', 05:58:26 INFO - 'sessionrestore_no_auto_restore', 05:58:26 INFO - 'tabpaint']}, 05:58:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:26 INFO - 'ts_paint', 05:58:26 INFO - 'tpaint', 05:58:26 INFO - 'sessionrestore', 05:58:26 INFO - 'sessionrestore_no_auto_restore', 05:58:26 INFO - 'tabpaint']}, 05:58:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['a11yr', 05:58:26 INFO - 'ts_paint', 05:58:26 INFO - 'tpaint', 05:58:26 INFO - 'sessionrestore', 05:58:26 INFO - 'sessionrestore_no_auto_restore', 05:58:26 INFO - 'tabpaint']}, 05:58:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['a11yr', 05:58:26 INFO - 'ts_paint', 05:58:26 INFO - 'tpaint', 05:58:26 INFO - 'sessionrestore', 05:58:26 INFO - 'sessionrestore_no_auto_restore', 05:58:26 INFO - 'tabpaint']}, 05:58:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['tsvgx', 05:58:26 INFO - 'tsvgr_opacity', 05:58:26 INFO - 'tart', 05:58:26 INFO - 'tscrollx', 05:58:26 INFO - 'cart']}, 05:58:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:26 INFO - 'tsvgr_opacity', 05:58:26 INFO - 'tart', 05:58:26 INFO - 'tscrollx', 05:58:26 INFO - 'cart']}, 05:58:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'talos_options': ['--disable-e10s'], 05:58:26 INFO - 'tests': ['tp5o']}, 05:58:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'tests': ['tp5o']}, 05:58:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'talos_options': ['--disable-e10s', 05:58:26 INFO - '--xperf_path', 05:58:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:26 INFO - 'tests': ['tp5n']}, 05:58:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:26 INFO - 'talos_options': ['--xperf_path', 05:58:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:26 INFO - 'tests': ['tp5n']}}, 05:58:26 INFO - 'talos.zip': {'path': '', 05:58:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:26 INFO - Running post-action listener: _resource_record_post_action 05:58:26 INFO - ##### 05:58:26 INFO - ##### Finished populate-webroot step (success) 05:58:26 INFO - ##### 05:58:26 INFO - ##### 05:58:26 INFO - ##### Running create-virtualenv step. 05:58:26 INFO - ##### 05:58:26 INFO - Running pre-action listener: _resource_record_pre_action 05:58:26 INFO - Running main action method: create_virtualenv 05:58:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:26 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:58:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:26 INFO - Using real prefix '/usr' 05:58:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:29 INFO - Installing pip.................done. 05:58:29 INFO - Return code: 0 05:58:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:29 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:58:29 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:58:29 INFO - Using env: {'DISPLAY': ':0', 05:58:29 INFO - 'HOME': '/home/cltbld', 05:58:29 INFO - 'LANG': 'en_US.UTF-8', 05:58:29 INFO - 'LANGUAGE': 'en_US:en', 05:58:29 INFO - 'LOGNAME': 'cltbld', 05:58:29 INFO - 'MAIL': '/var/mail/cltbld', 05:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:29 INFO - 'MOZ_NO_REMOTE': '1', 05:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:29 INFO - 'NO_EM_RESTART': '1', 05:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:29 INFO - 'PWD': '/builds/slave/test', 05:58:29 INFO - 'SHELL': '/bin/bash', 05:58:29 INFO - 'SHLVL': '1', 05:58:29 INFO - 'TERM': 'linux', 05:58:29 INFO - 'TMOUT': '86400', 05:58:29 INFO - 'USER': 'cltbld', 05:58:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:29 INFO - '_': '/tools/buildbot/bin/python'} 05:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:29 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:58:29 INFO - Cleaning up... 05:58:29 INFO - Return code: 0 05:58:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:29 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:58:29 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:58:29 INFO - Using env: {'DISPLAY': ':0', 05:58:29 INFO - 'HOME': '/home/cltbld', 05:58:29 INFO - 'LANG': 'en_US.UTF-8', 05:58:29 INFO - 'LANGUAGE': 'en_US:en', 05:58:29 INFO - 'LOGNAME': 'cltbld', 05:58:29 INFO - 'MAIL': '/var/mail/cltbld', 05:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:29 INFO - 'MOZ_NO_REMOTE': '1', 05:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:29 INFO - 'NO_EM_RESTART': '1', 05:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:29 INFO - 'PWD': '/builds/slave/test', 05:58:29 INFO - 'SHELL': '/bin/bash', 05:58:29 INFO - 'SHLVL': '1', 05:58:29 INFO - 'TERM': 'linux', 05:58:29 INFO - 'TMOUT': '86400', 05:58:29 INFO - 'USER': 'cltbld', 05:58:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:29 INFO - '_': '/tools/buildbot/bin/python'} 05:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:29 INFO - Downloading/unpacking psutil>=3.1.1 05:58:29 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:58:29 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:58:29 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:58:29 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:58:29 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:58:29 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:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:31 INFO - Installing collected packages: psutil 05:58:31 INFO - Running setup.py install for psutil 05:58:31 INFO - building 'psutil._psutil_linux' extension 05:58:31 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:58:32 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:58:32 INFO - building 'psutil._psutil_posix' extension 05:58:32 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:58:32 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:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:32 INFO - Successfully installed psutil 05:58:32 INFO - Cleaning up... 05:58:32 INFO - Return code: 0 05:58:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:32 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:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:32 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:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:32 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:32 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:58:32 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:58:32 INFO - Using env: {'DISPLAY': ':0', 05:58:32 INFO - 'HOME': '/home/cltbld', 05:58:32 INFO - 'LANG': 'en_US.UTF-8', 05:58:32 INFO - 'LANGUAGE': 'en_US:en', 05:58:32 INFO - 'LOGNAME': 'cltbld', 05:58:32 INFO - 'MAIL': '/var/mail/cltbld', 05:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:32 INFO - 'MOZ_NO_REMOTE': '1', 05:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:32 INFO - 'NO_EM_RESTART': '1', 05:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:32 INFO - 'PWD': '/builds/slave/test', 05:58:32 INFO - 'SHELL': '/bin/bash', 05:58:32 INFO - 'SHLVL': '1', 05:58:32 INFO - 'TERM': 'linux', 05:58:32 INFO - 'TMOUT': '86400', 05:58:32 INFO - 'USER': 'cltbld', 05:58:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:32 INFO - '_': '/tools/buildbot/bin/python'} 05:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:35 INFO - Installing collected packages: mozsystemmonitor 05:58:35 INFO - Running setup.py install for mozsystemmonitor 05:58:35 INFO - Successfully installed mozsystemmonitor 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58: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:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:35 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:58:35 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:58:35 INFO - Using env: {'DISPLAY': ':0', 05:58:35 INFO - 'HOME': '/home/cltbld', 05:58:35 INFO - 'LANG': 'en_US.UTF-8', 05:58:35 INFO - 'LANGUAGE': 'en_US:en', 05:58:35 INFO - 'LOGNAME': 'cltbld', 05:58:35 INFO - 'MAIL': '/var/mail/cltbld', 05:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:35 INFO - 'MOZ_NO_REMOTE': '1', 05:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:35 INFO - 'NO_EM_RESTART': '1', 05:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:35 INFO - 'PWD': '/builds/slave/test', 05:58:35 INFO - 'SHELL': '/bin/bash', 05:58:35 INFO - 'SHLVL': '1', 05:58:35 INFO - 'TERM': 'linux', 05:58:35 INFO - 'TMOUT': '86400', 05:58:35 INFO - 'USER': 'cltbld', 05:58:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:35 INFO - '_': '/tools/buildbot/bin/python'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:35 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:58:35 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:58:35 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:58:35 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:58:35 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:58:35 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:58:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 INFO - Downloading docopt-0.6.1.tar.gz 05:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:38 INFO - Running setup.py install for blobuploader 05:58:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:38 INFO - Running setup.py install for requests 05:58:39 INFO - Running setup.py install for docopt 05:58:39 INFO - Successfully installed blobuploader requests docopt 05:58:39 INFO - Cleaning up... 05:58:39 INFO - Return code: 0 05:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:39 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:39 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:58:39 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:58:39 INFO - Using env: {'DISPLAY': ':0', 05:58:39 INFO - 'HOME': '/home/cltbld', 05:58:39 INFO - 'LANG': 'en_US.UTF-8', 05:58:39 INFO - 'LANGUAGE': 'en_US:en', 05:58:39 INFO - 'LOGNAME': 'cltbld', 05:58:39 INFO - 'MAIL': '/var/mail/cltbld', 05:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:39 INFO - 'MOZ_NO_REMOTE': '1', 05:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:39 INFO - 'NO_EM_RESTART': '1', 05:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:39 INFO - 'PWD': '/builds/slave/test', 05:58:39 INFO - 'SHELL': '/bin/bash', 05:58:39 INFO - 'SHLVL': '1', 05:58:39 INFO - 'TERM': 'linux', 05:58:39 INFO - 'TMOUT': '86400', 05:58:39 INFO - 'USER': 'cltbld', 05:58:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:39 INFO - '_': '/tools/buildbot/bin/python'} 05:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:39 INFO - Running setup.py (path:/tmp/pip-BKifjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:39 INFO - Running setup.py (path:/tmp/pip-gvIHGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:39 INFO - Running setup.py (path:/tmp/pip-zEoo0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:39 INFO - Running setup.py (path:/tmp/pip-lL9aFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:39 INFO - Running setup.py (path:/tmp/pip-a9Q5am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:39 INFO - Running setup.py (path:/tmp/pip-FWEp0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:39 INFO - Running setup.py (path:/tmp/pip-MWFQRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:39 INFO - Running setup.py (path:/tmp/pip-EJuVEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:39 INFO - Running setup.py (path:/tmp/pip-SckQED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:40 INFO - Running setup.py (path:/tmp/pip-ryY1iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:40 INFO - Running setup.py (path:/tmp/pip-S3t8VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:40 INFO - Running setup.py (path:/tmp/pip-XESUUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:40 INFO - Running setup.py (path:/tmp/pip-hLBaL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:40 INFO - Running setup.py (path:/tmp/pip-9KpytG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:40 INFO - Running setup.py (path:/tmp/pip-Bc5MBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:40 INFO - Running setup.py (path:/tmp/pip-ktrKPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:40 INFO - Running setup.py (path:/tmp/pip-OT2gUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:40 INFO - Running setup.py install for manifestparser 05:58:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozcrash 05:58:40 INFO - Running setup.py install for mozdebug 05:58:40 INFO - Running setup.py install for mozdevice 05:58:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozfile 05:58:41 INFO - Running setup.py install for mozhttpd 05:58:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozinfo 05:58:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozInstall 05:58:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozleak 05:58:41 INFO - Running setup.py install for mozlog 05:58:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for moznetwork 05:58:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozprocess 05:58:41 INFO - Running setup.py install for mozprofile 05:58:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozrunner 05:58:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Running setup.py install for mozscreenshot 05:58:42 INFO - Running setup.py install for moztest 05:58:42 INFO - Running setup.py install for mozversion 05:58:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:42 INFO - Cleaning up... 05:58:42 INFO - Return code: 0 05:58:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:42 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:42 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:58:42 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:58:42 INFO - Using env: {'DISPLAY': ':0', 05:58:42 INFO - 'HOME': '/home/cltbld', 05:58:42 INFO - 'LANG': 'en_US.UTF-8', 05:58:42 INFO - 'LANGUAGE': 'en_US:en', 05:58:42 INFO - 'LOGNAME': 'cltbld', 05:58:42 INFO - 'MAIL': '/var/mail/cltbld', 05:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:42 INFO - 'MOZ_NO_REMOTE': '1', 05:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:42 INFO - 'NO_EM_RESTART': '1', 05:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:42 INFO - 'PWD': '/builds/slave/test', 05:58:42 INFO - 'SHELL': '/bin/bash', 05:58:42 INFO - 'SHLVL': '1', 05:58:42 INFO - 'TERM': 'linux', 05:58:42 INFO - 'TMOUT': '86400', 05:58:42 INFO - 'USER': 'cltbld', 05:58:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:42 INFO - '_': '/tools/buildbot/bin/python'} 05:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:42 INFO - Running setup.py (path:/tmp/pip-PELndG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:42 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:42 INFO - Running setup.py (path:/tmp/pip-HTxfWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:42 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:42 INFO - Running setup.py (path:/tmp/pip-Rkd1mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:42 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:42 INFO - Running setup.py (path:/tmp/pip-ppL9FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:42 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:42 INFO - Running setup.py (path:/tmp/pip-OMY8AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:43 INFO - Running setup.py (path:/tmp/pip-xNfF7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:43 INFO - Running setup.py (path:/tmp/pip-pe0Ak7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:43 INFO - Running setup.py (path:/tmp/pip-4NPN5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:43 INFO - Running setup.py (path:/tmp/pip-fp6KyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:43 INFO - Running setup.py (path:/tmp/pip-H1G_6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:43 INFO - Running setup.py (path:/tmp/pip-HnCT5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:43 INFO - Running setup.py (path:/tmp/pip-ZL128c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:43 INFO - Running setup.py (path:/tmp/pip-RGhQ5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:43 INFO - Running setup.py (path:/tmp/pip-8RaaGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:43 INFO - Running setup.py (path:/tmp/pip-fW4yYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:43 INFO - Running setup.py (path:/tmp/pip-0VD0c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:43 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:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:43 INFO - Running setup.py (path:/tmp/pip-UiF_Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:43 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:58:43 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:58:43 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:58:43 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:58:43 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:58:43 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:58:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:43 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:58:43 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:58:43 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:58:43 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:58:43 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:58:43 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:58:45 INFO - Downloading blessings-1.6.tar.gz 05:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:46 INFO - Installing collected packages: blessings 05:58:46 INFO - Running setup.py install for blessings 05:58:46 INFO - Successfully installed blessings 05:58:46 INFO - Cleaning up... 05:58:46 INFO - Return code: 0 05:58:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:46 INFO - Reading from file tmpfile_stdout 05:58:46 INFO - Current package versions: 05:58:46 INFO - argparse == 1.2.1 05:58:46 INFO - blessings == 1.6 05:58:46 INFO - blobuploader == 1.2.4 05:58:46 INFO - docopt == 0.6.1 05:58:46 INFO - manifestparser == 1.1 05:58:46 INFO - mozInstall == 1.12 05:58:46 INFO - mozcrash == 0.17 05:58:46 INFO - mozdebug == 0.1 05:58:46 INFO - mozdevice == 0.48 05:58:46 INFO - mozfile == 1.2 05:58:46 INFO - mozhttpd == 0.7 05:58:46 INFO - mozinfo == 0.9 05:58:46 INFO - mozleak == 0.1 05:58:46 INFO - mozlog == 3.2 05:58:46 INFO - moznetwork == 0.27 05:58:46 INFO - mozprocess == 0.22 05:58:46 INFO - mozprofile == 0.28 05:58:46 INFO - mozrunner == 6.11 05:58:46 INFO - mozscreenshot == 0.1 05:58:46 INFO - mozsystemmonitor == 0.3 05:58:46 INFO - moztest == 0.7 05:58:46 INFO - mozversion == 1.4 05:58:46 INFO - psutil == 3.1.1 05:58:46 INFO - requests == 1.2.3 05:58:46 INFO - wsgiref == 0.1.2 05:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:46 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:58:46 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:58:46 INFO - Using env: {'DISPLAY': ':0', 05:58:46 INFO - 'HOME': '/home/cltbld', 05:58:46 INFO - 'LANG': 'en_US.UTF-8', 05:58:46 INFO - 'LANGUAGE': 'en_US:en', 05:58:46 INFO - 'LOGNAME': 'cltbld', 05:58:46 INFO - 'MAIL': '/var/mail/cltbld', 05:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:46 INFO - 'MOZ_NO_REMOTE': '1', 05:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:46 INFO - 'NO_EM_RESTART': '1', 05:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:46 INFO - 'PWD': '/builds/slave/test', 05:58:46 INFO - 'SHELL': '/bin/bash', 05:58:46 INFO - 'SHLVL': '1', 05:58:46 INFO - 'TERM': 'linux', 05:58:46 INFO - 'TMOUT': '86400', 05:58:46 INFO - 'USER': 'cltbld', 05:58:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:46 INFO - '_': '/tools/buildbot/bin/python'} 05:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 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:58:46 INFO - Cleaning up... 05:58:46 INFO - Return code: 0 05:58:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 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 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:46 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:58:46 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:58:46 INFO - Using env: {'DISPLAY': ':0', 05:58:46 INFO - 'HOME': '/home/cltbld', 05:58:46 INFO - 'LANG': 'en_US.UTF-8', 05:58:46 INFO - 'LANGUAGE': 'en_US:en', 05:58:46 INFO - 'LOGNAME': 'cltbld', 05:58:46 INFO - 'MAIL': '/var/mail/cltbld', 05:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:46 INFO - 'MOZ_NO_REMOTE': '1', 05:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:46 INFO - 'NO_EM_RESTART': '1', 05:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:46 INFO - 'PWD': '/builds/slave/test', 05:58:46 INFO - 'SHELL': '/bin/bash', 05:58:46 INFO - 'SHLVL': '1', 05:58:46 INFO - 'TERM': 'linux', 05:58:46 INFO - 'TMOUT': '86400', 05:58:46 INFO - 'USER': 'cltbld', 05:58:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:46 INFO - '_': '/tools/buildbot/bin/python'} 05:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:46 INFO - Downloading/unpacking jsonschema 05:58: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:58: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:58: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:58: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:58: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:58: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:58:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:48 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58: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:58: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:58: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:58: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:58: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:58: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:58:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:49 INFO - warning: no files found matching '*.txt' 05:58:49 INFO - no previously-included directories found matching 'build' 05:58:49 INFO - no previously-included directories found matching 'dist' 05:58:49 INFO - no previously-included directories found matching '.git*' 05:58:49 INFO - Installing collected packages: jsonschema, functools32 05:58:49 INFO - Running setup.py install for functools32 05:58:49 INFO - warning: no files found matching '*.txt' 05:58:49 INFO - no previously-included directories found matching 'build' 05:58:49 INFO - no previously-included directories found matching 'dist' 05:58:49 INFO - no previously-included directories found matching '.git*' 05:58:49 INFO - Successfully installed jsonschema functools32 05:58:49 INFO - Cleaning up... 05:58:49 INFO - Return code: 0 05:58:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe2e8bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd27770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', '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:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:58:49 INFO - Using env: {'DISPLAY': ':0', 05:58:49 INFO - 'HOME': '/home/cltbld', 05:58:49 INFO - 'LANG': 'en_US.UTF-8', 05:58:49 INFO - 'LANGUAGE': 'en_US:en', 05:58:49 INFO - 'LOGNAME': 'cltbld', 05:58:49 INFO - 'MAIL': '/var/mail/cltbld', 05:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:49 INFO - 'MOZ_NO_REMOTE': '1', 05:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:49 INFO - 'NO_EM_RESTART': '1', 05:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:49 INFO - 'PWD': '/builds/slave/test', 05:58:49 INFO - 'SHELL': '/bin/bash', 05:58:49 INFO - 'SHLVL': '1', 05:58:49 INFO - 'TERM': 'linux', 05:58:49 INFO - 'TMOUT': '86400', 05:58:49 INFO - 'USER': 'cltbld', 05:58:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:49 INFO - '_': '/tools/buildbot/bin/python'} 05:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:49 INFO - Downloading/unpacking flake8 05:58:49 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:58:49 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:58:49 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:58:49 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:58:49 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:58:49 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:58:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:51 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:58:51 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:58:51 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:58:51 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:58:51 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:58:51 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:58:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58:51 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:58:51 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:58:51 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:58:51 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:58:51 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:58:51 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:58:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58:51 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:58:51 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:58:51 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:58:51 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:58:51 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:58:51 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:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:52 INFO - no previously-included directories found matching 'docs/_build' 05:58:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:52 INFO - Running setup.py install for pep8 05:58:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:52 INFO - no previously-included directories found matching 'docs/_build' 05:58:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:52 INFO - Cleaning up... 05:58:52 INFO - Return code: 0 05:58:52 INFO - Running post-action listener: _resource_record_post_action 05:58:52 INFO - Running post-action listener: _start_resource_monitoring 05:58:52 INFO - Starting resource monitoring. 05:58:52 INFO - ##### 05:58:52 INFO - ##### Finished create-virtualenv step (success) 05:58:52 INFO - ##### 05:58:52 INFO - ##### 05:58:52 INFO - ##### Running install step. 05:58:52 INFO - ##### 05:58:52 INFO - Running pre-action listener: _resource_record_pre_action 05:58:52 INFO - Running main action method: install 05:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:52 INFO - Reading from file tmpfile_stdout 05:58:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:52 INFO - Reading from file tmpfile_stdout 05:58:52 INFO - Output received: 05:58:52 INFO - Usage: mozinstall [options] installer 05:58:52 INFO - Options: 05:58:52 INFO - -h, --help show this help message and exit 05:58:52 INFO - -d DEST, --destination=DEST 05:58:52 INFO - Directory to install application into. [default: 05:58:52 INFO - "/builds/slave/test"] 05:58:52 INFO - --app=APP Application being installed. [default: firefox] 05:58:52 INFO - mkdir: /builds/slave/test/build/application 05:58:52 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:58:52 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:59:08 INFO - Reading from file tmpfile_stdout 05:59:08 INFO - Output received: 05:59:08 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:08 INFO - Running post-action listener: _resource_record_post_action 05:59:08 INFO - ##### 05:59:08 INFO - ##### Finished install step (success) 05:59:08 INFO - ##### 05:59:08 INFO - ##### 05:59:08 INFO - ##### Running run-tests step. 05:59:08 INFO - ##### 05:59:08 INFO - Running pre-action listener: _resource_record_pre_action 05:59:08 INFO - Running main action method: run_tests 05:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:08 INFO - Python 2.7.3 05:59:08 INFO - Return code: 0 05:59:08 INFO - grabbing minidump binary from tooltool 05:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:08 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 0xdb69c0>, '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 0xdb78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:08 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:59:08 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:59:08 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:59:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:08 INFO - Return code: 0 05:59:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:09 INFO - Return code: 0 05:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:09 INFO - Using env: {'DISPLAY': ':0', 05:59:09 INFO - 'HOME': '/home/cltbld', 05:59:09 INFO - 'LANG': 'en_US.UTF-8', 05:59:09 INFO - 'LANGUAGE': 'en_US:en', 05:59:09 INFO - 'LOGNAME': 'cltbld', 05:59:09 INFO - 'MAIL': '/var/mail/cltbld', 05:59:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:09 INFO - 'MOZ_NO_REMOTE': '1', 05:59:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:09 INFO - 'NO_EM_RESTART': '1', 05:59:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:09 INFO - 'PWD': '/builds/slave/test', 05:59:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:09 INFO - 'SHELL': '/bin/bash', 05:59:09 INFO - 'SHLVL': '1', 05:59:09 INFO - 'TERM': 'linux', 05:59:09 INFO - 'TMOUT': '86400', 05:59:09 INFO - 'USER': 'cltbld', 05:59:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800', 05:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:09 INFO - '_': '/tools/buildbot/bin/python'} 05:59:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:09 INFO - mozversion application_buildid: 20160517050231 05:59:09 INFO - mozversion application_changeset: 6e2add233b54766d44568f81aa207c624bbe4437 05:59:09 INFO - mozversion application_display_name: Nightly 05:59:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:09 INFO - mozversion application_name: Firefox 05:59:09 INFO - mozversion application_remotingname: firefox 05:59:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:59:09 INFO - mozversion application_vendor: Mozilla 05:59:09 INFO - mozversion application_version: 49.0a1 05:59:09 INFO - mozversion platform_buildid: 20160517050231 05:59:09 INFO - mozversion platform_changeset: 6e2add233b54766d44568f81aa207c624bbe4437 05:59:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:59:09 INFO - mozversion platform_version: 49.0a1 05:59:09 INFO - using testdate: 1463489949 05:59:09 INFO - actual date: 1463489949 05:59:09 INFO - starting webserver on 'localhost:40144' 05:59:09 INFO - SUITE-START | Running 2 tests 05:59:09 INFO - TEST-START | dromaeo_css 05:59:09 INFO - operating with platform_type : linux_ 05:59:09 INFO - Initialising browser for dromaeo_css test... 05:59:09 INFO - TEST-INFO | started process 15251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFSRPw/profile http://localhost:40144/getInfo.html) 05:59:13 INFO - PROCESS | 15251 | __metrics Screen width/height:1600/1200 05:59:13 INFO - PROCESS | 15251 | colorDepth:24 05:59:13 INFO - PROCESS | 15251 | Browser inner width/height: 1024/697 05:59:13 INFO - PROCESS | 15251 | __metrics 05:59:15 ERROR - PROCESS | 15251 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:59:16 INFO - TEST-INFO | 15251: exit 0 05:59:16 INFO - Browser initialized. 05:59:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:16 INFO - TEST-INFO | started process 15335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFSRPw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:28 INFO - PROCESS | 15335 | RSS: Main: 154587136 05:59:28 INFO - PROCESS | 15335 | 06:00:19 INFO - PROCESS | 15335 | 1463490019046 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] 06:02:32 INFO - PROCESS | 15335 | Cycle 1(1): loaded http://localhost:40144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40144/tests/dromaeo/cssquery-ext.html) 06:02:33 INFO - PROCESS | 15335 | RSS: Main: 245559296 06:02:33 INFO - PROCESS | 15335 | 06:05:35 INFO - PROCESS | 15335 | Cycle 1(1): loaded http://localhost:40144/tests/dromaeo/cssquery-ext.html (next: http://localhost:40144/tests/dromaeo/cssquery-jquery.html) 06:05:36 INFO - PROCESS | 15335 | RSS: Main: 245596160 06:05:36 INFO - PROCESS | 15335 | 06:08:38 INFO - PROCESS | 15335 | Cycle 1(1): loaded http://localhost:40144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40144/tests/dromaeo/cssquery-mootools.html) 06:08:38 INFO - PROCESS | 15335 | RSS: Main: 237666304 06:08:39 INFO - PROCESS | 15335 | 06:11:41 INFO - PROCESS | 15335 | Cycle 1(1): loaded http://localhost:40144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40144/tests/dromaeo/cssquery-prototype.html) 06:11:41 INFO - PROCESS | 15335 | RSS: Main: 233148416 06:11:41 INFO - PROCESS | 15335 | 06:14:44 INFO - PROCESS | 15335 | Cycle 1(1): loaded http://localhost:40144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40144/tests/dromaeo/cssquery-yui.html) 06:14:45 INFO - PROCESS | 15335 | RSS: Main: 217681920 06:14:45 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | Cycle 1(1): loaded http://localhost:40144/tests/dromaeo/cssquery-yui.html (next: http://localhost:40144/tests/dromaeo/cssquery-dojo.html) 06:17:48 INFO - PROCESS | 15335 | RSS: Main: 271765504 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | __start_tp_report 06:17:48 INFO - PROCESS | 15335 | _x_x_mozilla_page_load 06:17:48 INFO - PROCESS | 15335 | _x_x_mozilla_page_load_details 06:17:48 INFO - PROCESS | 15335 | |i|pagename|runs| 06:17:48 INFO - PROCESS | 15335 | |0;dojo.html;2649.933751656208;2658.8404695718273;2695.4204845958116;2695.9865200673994;2704.878280477378;4642.512536183703;4737.218358970775;4742.9288560671575;4811.711297322163;4864.464908860023;4762.214234651287;4768.284757286408;4787.6169906407495;4831.396075490564;4836.032793441317;4341.739495630257;4353.978230108845;4411.514733379326;4440.444944381952;4525.637948964091;4415.050764085705;4450.354698568705;4468.486124095738;4477.485089214733;4501.639868810487;4249.405083288311;4283;4304.612584867377;4361.694681372305;4364.345348197764;4327.1345730853955;4355.760433176174;4356.128774245164;4398.274284743014;4420.469543654782;4341.06667066579;4376.124775044972;4388.539203383662;4395.714278571914;4430.401895744066;4573.153966516172;4636.235021221494;4702.717836929795;4710.599599034086;4717.740524271164;5128.615353848476;5189.844304670866;5203.739813009334;5206.843794686166;5208.973955130238;5183.377994640629;5189.169732842727;5215.634905556574;5222.2427747976335;5231.503007214346;4637.976810115995;4672.556107169813;4805.1590971579835;4840.951590484121;4841.636877234221;5300.390455097713;5337.466253374631;5384.78460861569;5391.29913111293;5391.757370918318;5113.846584602468;5116.334876466036;5118.846434606968;5159.484051594811;5171.689698618095;4957.553820156203;5085.796568137307;5120.078385890501;5150.845474635767;5227.555657769056;5129.7178655173575;5138.126518491866;5138.640295179376;5148.716820574829;5173.741312934339;5081.5426611605135;5085.389753229562;5094;5103.744812759347;5141.794328226903;4259.97870010648;4301.978490107529;4303.74177549348;4360;4414.668899832525;3803;3823.5411750590106;3839.3665045267776;3841.8655347063277;3842.865499707497;4324.156789426094;4365.170617582649;4365.956340436555;4411.448568928884;4423.646108311327;5055.216441451581;5096.51583099605;5103.413107492612;5109.054824857413;5166.715830629276;4369.781510924441;4371;4373.212821692063;4380.167768124046;4414.381986521889;4482.843100491533;4568.360429539867;4603.355530225771;4604.953950460453;4610.331501932201;4799.424069111729;4802.135615589157;4803.783829727601;4811.831585894617;4852.490488498657;4978.128827455109;5104.183330667075;5112.590992720648;5118.795248190179;5124.256982737556;4820.060088282751;4866.391701037371;4874.512548745097;4880.780364883518;4880.975595122001;5079.9238011429115;5105.4384017757275;5108.386993560796;5111.361079865017;5157.458466861076;4925.236588328815;5070.3155074064525;5154.453663900889;5166.535011848951;5192.480751924777;4947.455779864284;4981.775820088033;4999.65002449825;5006.524380183877;5057.216131499624;4975.900481990412;4987.750612469289;4993.925091123563;4999;5041.495850414929;4794.352762377034;4858.975705121452;4907.043126590281;4915.65590408668;4960.305557222064;4988.750562471934;5027.49725027509;5030.597552195889;5043;5070.4676009019995;4921.532454416824;4922.975385123052;4928.21148616234;4930.531599498042;4966.478519755374 06:17:48 INFO - PROCESS | 15335 | |1;ext.html;564.2946317103621;585.2508788750399;606.751231994882;608.4432744039204;608.5800797449757;41806.37290440642;43456.348154777625;43458.34812477815;43560.56439435605;48125.759371203094;43422;43951;43976.3403548947;44026.779866100704;44037.33943990843;8064.435489515751;8205.630746616387;8205.917940820606;8207.179282071775;8212.260896519312;7952.20477952206;8048.758537243892;8053.798655033613;8055.234752698513;8061.314788243007;8023.759287221393;8054.51672899625;8059.5089908366845;8064.395170362217;8065.354771618257;8004.799880003017;8020.077691065544;8020.478668886562;8047.315978141865;8054.114047454776;7950.681972721084;8031.116577176506;8031.357491400674;8035.799105022363;8036.799080022988;41202.38196427056;41547.58452415467;41563;41602.583974160174;41779.1644167118;3245.8701651933893;3372.7976321420547;3394.5077963695126;3420.350133474632;3466.480027995821;29730.40539189204;30309.680686788903;30578;30698.386032279454;30920.69079309223;3446.638102999174;3451.20479234654;3538.8938331850086;3580.4629305604108;3596.118950857057;259038;259384;259489;259741;259963;31015.68984310128;57901.42098579044;58029;58335.70832145812;58378;32865.342693146005;34770.652293477244;34790;34806.825965870514;34813.82593087069;13850.515231966832;14103.224322662352;14118.364673589713;14125.505607303901;14131.222782747047;11521.769564608661;11570.074394048455;11572.247803892888;11574.074074074222;11578.305301681927;8424.78938026542;8466.40735148546;8480.53357065355;8493;8563.785905352292;3217.758668099855;3274.705276525124;3299.6700329967293;3321.6678332167075;3354.446516324828;908.2506931781306;919.852823548229;939.699296225215;970.0202795176922;1022.9130523905402;29271.560926586117;29779.851100744792;30234;30632;30656.69343306583;950.4867371619387;970.6748239339901;988.1748739802202;997.0378584665832;1064.6007747094839;15454.304556294994;15988.76016859748;16004.199790010685;16069.116198608956;16260;376346;376758;378760;379233;379311;53045.204321935205;53639.73180134074;53688.73155634197;53702.46297537053;53736.46263537393;1196.5273716881784;1219.9939000304942;1232.5254776910774;1240.1690867119053;1256.114439320277;28212.576811347437;29179.85410072936;29269.41461170807;29741.256468588457;29862.701372985994;47035.764821175675;47427.525724742314;47447;47488;47538.76230618825;320035;326452;327147;328200;328288;23142.190023349103;25634.871825640752;26417;26798.464030719668;26957.3260668477;44252;44374.3343849849;44842;44851.775741121084;45747.771261144815;38226.617733822306;38577.80711096426;39533.604663954146;39906.401403979544;40219.798901005306;38393.23213535769;38705.4194187093;38991;39309.2138157241;39322.21355572815;38779;38857.22285554217;39477.40783888302;39510.40734388929;39517.209655806146;33834.323313533096;35035.29929401448;35753.46369804507;35885.820570896976;36069.63930360663;26922.730772692023;27185.823037563958;27456.176314710592;27527;27663.446731064865 06:17:48 INFO - PROCESS | 15335 | |2;jquery.html;359.27785151844785;381.32879181334744;383.60871910651156;383.9328117579424;410.94452248946385;12389.752204955896;16128;17257.56856078597;18247.087645617732;18272.086395680195;17102.572435689115;17198.484045478624;17945.75678040245;17968.101594920267;17976.191071401787;5027.8240261590945;5190.584753219733;5292.497212764801;5299.099153143975;5322.920156197641;3718.553773547178;5205.37535495741;5719.485246327829;6021.789237376693;6030.33666296707;6051.576389652704;6059.394060593927;6063.6361818290825;6092.969535152318;6093.116498107772;5312.787488500475;5617.494425501724;5649.717514124277;5655.688937108499;5662.263905692254;5322.893542129174;5459.12653975362;5470.480304371078;5486.862828429281;5565.888682226333;11912.404379781063;11977.101717371232;11995.16033877629;12498.375081245902;12527.498900043987;1759.1028575426496;2016.0826823795137;2104.326615483046;2401.483681008574;2445.364205306615;8717.825643487158;9231.538423078886;9441.15029647328;9463.337566370357;9689.757756056084;1580.162513867652;1715.082430899463;1758.7977382601036;1782.1000394800672;1812.664657038439;66283;68750;69541.30458695449;70095.2990470094;70977.29022709759;9001.504917229615;9446.622135114518;10243.641472548425;10280.845787313196;10285.640002600023;14031.649208769863;14448;14542.927285363505;14544.781828272584;14551.92724036373;7614.923850761532;7678.616069196518;7682.1549629540705;7785.104712957969;7825.256600622932;7164.104486939133;7206.7117315306805;7346.449016323797;7370.963145184347;7493.3630641395;4453.532379100213;4506.616937560344;4613.723176609415;4627.056636212798;4691.085238378551;1865.860060495441;1915.6647586672277;1951.1512492065997;1960.9313674021626;1983.4148926066846;778.2567647896245;880.5817236812591;915.1900567997237;932.8274269260208;1008.1833714691123;16571.337146514004;17299.82700172982;17311.740323895152;17444.563885902953;17839.643207135785;879.7404765594165;897.3270047464401;908.2506931781174;922.3635939415839;938.3150300280834;9781.706548803548;9825.213982881352;9863.112319891245;9898.406095634286;9963.80072398548;345195;346851;349409;352909;360385;80717;84008.57995710104;84053.57973210217;84152.57923710342;85097;936.2603543200931;953.1278879824882;991.5587563534158;995.4624502768424;1002.283367392318;15278.312475938832;15292.235388230767;15587.220638968232;15802.20988950525;16054.117023563816;25694.357641058374;26402.86798565995;32220;32282.677173228905;35350.46974295439;48265;49886.50113498818;49927;49935.75032124816;50697.49302506928;6970.337817907291;7157.928420715726;7372.189059203591;7850.725224617111;8003.279704826594;11151;11948.522059117538;12020.819687704867;12164.635060948185;12193.451294691937;10365.481725913825;10453.216008799523;10721.892781072089;10744.355338679705;10833.729156770829;7809.609519523888;10185.33795303303;10257.9487102567;10260.897391025994;10601.681949541526;10321.936112290457;10375;10486.318389304672;10508;10661;7464.365528930101;7485.588292643957;7509.324160825552;7658.961705191661;7820.84358312842;7239.312265334785;8670.219680228558;9605.37565058269;9617.951910240405;9630.903690963001 06:17:48 INFO - PROCESS | 15335 | |3;mootools.html;1172.3844981384777;1515.1288009394598;1551.1623723189477;1724.586099336159;1881.2686094472397;7686.654100565474;8032.116467188612;8075.717349892762;8347.16528347165;8361.122082181375;8093.878591821127;8188.549629770375;8239.176082391758;8268.255856972872;8281.420300578962;2183.9781602183975;2233.106757297086;2234.6871437998693;2235.564065007316;2237.865728056314;2169.056460439706;2169.457635591102;2255.560165767676;2257.413072601119;2259.435141214696;2184.432047667602;2188.73735151782;2211.060299372768;2213.1147540983575;2224.7219097612797;2165.8483906126576;2174.7390313162364;2185.2460900989136;2192.6162921488753;2194.462356722597;2116.534362440261;2125.1499400239873;2125.553633736917;2126.032655141922;2127.7872212778752;7966.721164759264;8097.109317975077;8141.43009989301;8157.347412207068;8218.753437396888;4606.953930460686;4707.882302942419;4712.858614241544;4714.905701885978;4719.693219940693;2942.602748628929;2959.5708622249867;2976.374961258117;3003.279212988889;3057.8471076446313;857.2884505860121;883.439016224702;888.2893685051932;896.3546246702364;904.5432056811334;10351.63769268072;10366.015228553351;10383.94808025955;10392.116670083053;10401.635942741968;3957.604239576019;4029.3553031514816;4091.3453847384276;4100.384942258625;4103.548609652936;8281.585920703941;8313.210245026712;8336.66653333872;8342.16578342161;8342.791430214173;4627.629789616823;4635.096156249567;4636.2581986882615;4640.814367425332;4641.234196357564;3881.631245031774;4160.2303573838935;4259.169461954889;4264.87205383839;4432.224360736858;3454.2227998700596;3457.11843479911;3529.5588051493564;3545.989393023028;3667.339878821838;995.4873240281261;1019.1337363241333;1022.1311884897926;1024.2522958240377;1028.4703377760459;732.0739264829995;798.6086817459519;843.4559708987791;856.6573370651664;867.2888231650113;5363.785448582091;5540.861478463071;5603.411641777636;5777.826665200051;5837.67892765902;854.773485026456;884.5046773806689;925.2967744514218;926.8424367857481;941.6939494664261;3723.1250656095795;3802.8288727006798;3826.445165450994;3856.9035774105873;3924.2151569686175;9796.412215267106;10068.39589624625;10200.591976321013;10209.183265338903;10220.540075696612;9964.05341492557;10030.247731420026;10045.899541004643;10049.839284553856;10053.195744340435;7134.821629459305;7429.216987922751;7523.9623801881735;7753.4960227585025;7760.262775036363;5640.464155905182;5662.292213473316;5767.423257674199;5803.158542011469;5868.706564671835;8787.428817126865;9388.202002829836;9469.384490008128;9478.668246611336;9603;9255.213306868991;9408.76478088026;9444.197243234403;9478.052194780743;9491.098345657152;6082.148499210202;6262.655553944577;6419.839504012437;6938.757143499954;7083.185433675193;7240.167380751281;7409.222031686595;7497.512661676974;7505.66224519887;7513.4740568159705;6602.372774586406;6677.899831502435;6699.799006029827;6708.295628958889;6865.141857267841;6740.191177058784;6752.223494298219;6781;6825.761098361533;6846.965765171142;6404;6419.486441084796;6503;6508.186476690414;6510.153680021567;4562.270036794097;4636.3045543167445;4708.905821883612;4714.29285607148;4715.764211789466;4666.696664716783;4729.5034021427255;4754.97767979886;4813.78337974799;4822.807087716452 06:17:48 INFO - PROCESS | 15335 | |4;prototype.html;296.6306947849927;302.17958243369253;306.7591940326844;309.07124092103226;313.7364613724471;4846.612271018319;4897.6816506927025;4905.117078925797;4940.802367905279;4944.307796908436;4649.6047835933905;4692.741899195543;4764.166270902596;4882.340883980662;4888.902221955559;3853.7495062820826;3870.6903447724117;3888.5333759948844;3906.609339066099;3907.902302442433;3899.863504777333;3903.8243279052513;3913.5695073541888;3913.8043097845134;3920.84316627336;3646.817659117047;3692.280005398948;3793.924121517568;3825.101101241206;3840;3803.3376636354665;3810.923781524354;3816.332141875175;3817.179306449099;3830.3488406970882;3395.6774106459848;3399.2351720862857;3405.5743032120986;3406.5912090549045;3420.846061927219;4423.159599676052;4694.647901407408;4704.694194877322;4710.29345598163;4780.661414803861;4212.620864122244;4246.426732391118;4252.107057517925;4265.168292183025;4284.5715428457215;5059.62052846038;5064.657865665602;5099.668521546125;5103.132467480537;5107.3360463139925;3584.946225806615;3589.7128229741556;3595.7123430125525;3596.6403359664087;3605.3330133925306;5072.771725272371;5299.311089558371;5300.337457817773;5311.176767601028;5358.223057656618;3692.8338224779413;3709.109813644706;3714.275716235308;3725.9254814904093;3726.366517691999;3763.6048214937587;3797.867074652374;3798.8100594970692;3806.6764325032127;3818.293615681108;4095.201435720006;4218.936715949263;4250.452016342484;4337.677008512434;4366.454193225847;5083.161278389024;5084.3644544431945;5086.92369614456;5141.228815677603;5145.511176438233;1231.6859200903891;1267.7781388257017;1277.7444511097817;1285.1517998121194;1310.9868901310865;831.538496134639;835.3150416658403;841.7979684875709;845.4842546046906;846.9836196564148;4083.774867539726;4088.5911408858874;4099.221147981874;4123.237201117803;4128.566500517462;4694.474295853861;4719.764011799396;4746.216874215785;4749.097671442415;4773.188557945157;4055.634992850599;4072.1855628874346;4089.6523795477124;4095.5494895561465;4111.403846442249;2349.765023497637;2516.6476693262957;2531.5063562605114;2532.873356332176;2553.157458038843;4436.711613745097;4447.844325448594;4481.305397663367;4486.147631949919;4520.276755719069;4702.365180700562;4753.453352864396;4793.784279707422;4794.808207671654;4808.687435316693;4444.977775111104;4452.243118669834;4599;5029.673071250357;5072.163093089599;5313;5326.25432439451;5326.680399176062;5329.840104796862;5332.653377530603;5215.478452154754;5235.869103272448;5245.291885595396;5252.816151434681;5267.657602255841;4709.529047095263;4944.629152813625;5034.320366750442;5042.495750424928;5046.823361182341;3716.4611131386337;3724.329620668306;3734.1971476132762;3738.5887552369763;3739.2521495700425;5122.948770512247;5332.253484512249;5344.893102138013;5359.526130314195;5372.355317361941;5020.974895125501;5153.7680804364645;5167.457416971314;5170.689758614495;5188.351456067991;5114.360704911886;5126.436781609195;5151.381834179922;5171.767270472763;5175.792968281226;4866.270059491105;5043.9747801260755;5072.67027643202;5093.643444958817;5096.847094587169;5128.640995130305;5142.1772516397195;5145.276332428678;5189.091908915849;5192.039472697563;5040.361882388312;5041.445441001413;5131.127708289674;5141.511556402136;5146.562542183807 06:17:48 INFO - PROCESS | 15335 | |5;yui.html;647.3817504283409;743.323575546253;762.5386641082149;778.2917545034019;788.5387048576582;12502.624921252365;12622.116451848362;12657.493700252002;12680.112392132554;12691.36543172841;12595.3072581008;12762;13341.53304634338;13763.518276860312;13801.585952421417;681.2710399872138;859.8065435277075;892.9464232146075;899.0829354058889;901.179926267097;881.3257857738803;888.3381880499005;889.3596610440472;889.4440974391006;889.5774507109136;926.7590426489094;931.0549791961165;931.0828833598933;931.5109567477061;931.9627214911429;705.8658854817568;906.7143849687327;920.7974245665943;921.2077613252598;931.2829121576416;689.0766373060123;689.6000319814495;691.215470441048;691.4606606846668;692.0864458914235;13150.868491315061;13172.6706832329;13226.801597976038;13254.40355184019;13269.86730132696;11562.595309164139;11876.703082423008;11986.220895641756;12095.697607559794;12403;10068.949655251678;10217.591296348137;10260;10498.212634052477;11364.48859801311;3331.217163966466;3395.2021275000357;3396.9660303396895;3499.3876071687355;3525.2773181497732;47712;47889.04221915577;48531.757341213066;48840;49912.999999999636;9830.066143716336;9953.601855925826;10029.64896228643;10143.949280253699;10196.643117490852;17390.3043878246;17569.385071522436;17577.648447031243;17611.55971100733;17785.911070444567;6569;6640.63476508787;6724.193096828412;6726.159230096238;6785.287544807724;3773.2076263984873;3884.5726970033274;3947.8618248361167;3974.364101743707;3983.9601603983588;2845.3882415280814;2917.2706823294175;2924.883004679789;2931.120663800851;2934.8972785952815;508.2477932659684;513.0303725957942;514.2697369734985;516.5118962580401;517.6997341541896;520.2872065270603;544.9618526703093;563.8223959452841;609.9054646529795;610.1488423649073;7673.76978690629;8132.837343253102;8177.4684645497855;8251.803488494255;8402.453840500348;585.4145854145854;620.0637038072543;626.6553395632475;627.7143899525705;633.4647223096476;3936.271789718854;3937.547182074098;4095.4061661059577;4164.646005089541;4179.247735407595;49436;51022.234666480035;51153.23270150951;53585;56657.78462122969;50585.747071264406;51057.234141487905;51123.233151502754;52739.73630131825;52998.73500632549;45602.543974560496;45770.771146144056;45902;45934.36235576216;47825.760871196115;8653.317005696625;8757.91242087571;8782.516961567175;8813.60338784769;8929.776755581162;31316.530252046694;31835.840820795747;32634.673653263162;32907.17732056622;32968.67031329656;39803.80098099491;40970;41362.58637413587;41753.373699393924;41979;10575.36547807134;10596.70730551017;10715.464226788474;10929.836052459379;11040.33757974524;11973.401329933642;12074.154809163274;12078.698032549257;12112.576059837864;12853.036022298553;11166.720831979266;11507.94246028798;11804.70488237801;11983.101267404805;12089;11192.608258711232;11254;11765.470553824927;11768.94115529417;11795.410229488663;11200.271982321123;11209.383483908137;11543.191976561897;11773.05815534738;11849.466773995364;9804.1666458349;9828.705138845846;9867.555959981675;10095.394276343442;10248.846267306146;9604.183644390305;9724.951375243361;9744.366616169926;9756.512174391393;9768.267379946674 06:17:48 INFO - PROCESS | 15335 | __end_tp_report 06:17:48 INFO - PROCESS | 15335 | __start_cc_report 06:17:48 INFO - PROCESS | 15335 | _x_x_mozilla_cycle_collect,942 06:17:48 INFO - PROCESS | 15335 | __end_cc_report 06:17:48 INFO - PROCESS | 15335 | __startTimestamp1463491068549__endTimestamp 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | ------- Summary: start ------- 06:17:48 INFO - PROCESS | 15335 | Number of tests: 6 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | [#0] dojo.html Cycles:165 Average:4736.12 Median:4864.46 stddev:507.37 (10.4%) stddev-sans-first:481.81 06:17:48 INFO - PROCESS | 15335 | Values: 2649.9 2658.8 2695.4 2696.0 2704.9 4642.5 4737.2 4742.9 4811.7 4864.5 4762.2 4768.3 4787.6 4831.4 4836.0 4341.7 4354.0 4411.5 4440.4 4525.6 4415.1 4450.4 4468.5 4477.5 4501.6 4249.4 4283.0 4304.6 4361.7 4364.3 4327.1 4355.8 4356.1 4398.3 4420.5 4341.1 4376.1 4388.5 4395.7 4430.4 4573.2 4636.2 4702.7 4710.6 4717.7 5128.6 5189.8 5203.7 5206.8 5209.0 5183.4 5189.2 5215.6 5222.2 5231.5 4638.0 4672.6 4805.2 4841.0 4841.6 5300.4 5337.5 5384.8 5391.3 5391.8 5113.8 5116.3 5118.8 5159.5 5171.7 4957.6 5085.8 5120.1 5150.8 5227.6 5129.7 5138.1 5138.6 5148.7 5173.7 5081.5 5085.4 5094.0 5103.7 5141.8 4260.0 4302.0 4303.7 4360.0 4414.7 3803.0 3823.5 3839.4 3841.9 3842.9 4324.2 4365.2 4366.0 4411.4 4423.6 5055.2 5096.5 5103.4 5109.1 5166.7 4369.8 4371.0 4373.2 4380.2 4414.4 4482.8 4568.4 4603.4 4605.0 4610.3 4799.4 4802.1 4803.8 4811.8 4852.5 4978.1 5104.2 5112.6 5118.8 5124.3 4820.1 4866.4 4874.5 4880.8 4881.0 5079.9 5105.4 5108.4 5111.4 5157.5 4925.2 5070.3 5154.5 5166.5 5192.5 4947.5 4981.8 4999.7 5006.5 5057.2 4975.9 4987.8 4993.9 4999.0 5041.5 4794.4 4859.0 4907.0 4915.7 4960.3 4988.8 5027.5 5030.6 5043.0 5070.5 4921.5 4923.0 4928.2 4930.5 4966.5 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | [#1] ext.html Cycles:180 Average:47947.89 Median:38641.61 stddev:85485.44 (221.2%) stddev-sans-first:85651.21 06:17:48 INFO - PROCESS | 15335 | Values: 564.3 585.3 606.8 608.4 608.6 41806.4 43456.3 43458.3 43560.6 48125.8 43422.0 43951.0 43976.3 44026.8 44037.3 8064.4 8205.6 8205.9 8207.2 8212.3 7952.2 8048.8 8053.8 8055.2 8061.3 8023.8 8054.5 8059.5 8064.4 8065.4 8004.8 8020.1 8020.5 8047.3 8054.1 7950.7 8031.1 8031.4 8035.8 8036.8 41202.4 41547.6 41563.0 41602.6 41779.2 3245.9 3372.8 3394.5 3420.4 3466.5 29730.4 30309.7 30578.0 30698.4 30920.7 3446.6 3451.2 3538.9 3580.5 3596.1 259038.0 259384.0 259489.0 259741.0 259963.0 31015.7 57901.4 58029.0 58335.7 58378.0 32865.3 34770.7 34790.0 34806.8 34813.8 13850.5 14103.2 14118.4 14125.5 14131.2 11521.8 11570.1 11572.2 11574.1 11578.3 8424.8 8466.4 8480.5 8493.0 8563.8 3217.8 3274.7 3299.7 3321.7 3354.4 908.3 919.9 939.7 970.0 1022.9 29271.6 29779.9 30234.0 30632.0 30656.7 950.5 970.7 988.2 997.0 1064.6 15454.3 15988.8 16004.2 16069.1 16260.0 376346.0 376758.0 378760.0 379233.0 379311.0 53045.2 53639.7 53688.7 53702.5 53736.5 1196.5 1220.0 1232.5 1240.2 1256.1 28212.6 29179.9 29269.4 29741.3 29862.7 47035.8 47427.5 47447.0 47488.0 47538.8 320035.0 326452.0 327147.0 328200.0 328288.0 23142.2 25634.9 26417.0 26798.5 26957.3 44252.0 44374.3 44842.0 44851.8 45747.8 38226.6 38577.8 39533.6 39906.4 40219.8 38393.2 38705.4 38991.0 39309.2 39322.2 38779.0 38857.2 39477.4 39510.4 39517.2 33834.3 35035.3 35753.5 35885.8 36069.6 26922.7 27185.8 27456.2 27527.0 27663.4 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | [#2] jquery.html Cycles:180 Average:23042.79 Median:49075.75 stddev:58374.76 (118.9%) stddev-sans-first:58513.67 06:17:48 INFO - PROCESS | 15335 | Values: 359.3 381.3 383.6 383.9 410.9 12389.8 16128.0 17257.6 18247.1 18272.1 17102.6 17198.5 17945.8 17968.1 17976.2 5027.8 5190.6 5292.5 5299.1 5322.9 3718.6 5205.4 5719.5 6021.8 6030.3 6051.6 6059.4 6063.6 6093.0 6093.1 5312.8 5617.5 5649.7 5655.7 5662.3 5322.9 5459.1 5470.5 5486.9 5565.9 11912.4 11977.1 11995.2 12498.4 12527.5 1759.1 2016.1 2104.3 2401.5 2445.4 8717.8 9231.5 9441.2 9463.3 9689.8 1580.2 1715.1 1758.8 1782.1 1812.7 66283.0 68750.0 69541.3 70095.3 70977.3 9001.5 9446.6 10243.6 10280.8 10285.6 14031.6 14448.0 14542.9 14544.8 14551.9 7614.9 7678.6 7682.2 7785.1 7825.3 7164.1 7206.7 7346.4 7371.0 7493.4 4453.5 4506.6 4613.7 4627.1 4691.1 1865.9 1915.7 1951.2 1960.9 1983.4 778.3 880.6 915.2 932.8 1008.2 16571.3 17299.8 17311.7 17444.6 17839.6 879.7 897.3 908.3 922.4 938.3 9781.7 9825.2 9863.1 9898.4 9963.8 345195.0 346851.0 349409.0 352909.0 360385.0 80717.0 84008.6 84053.6 84152.6 85097.0 936.3 953.1 991.6 995.5 1002.3 15278.3 15292.2 15587.2 15802.2 16054.1 25694.4 26402.9 32220.0 32282.7 35350.5 48265.0 49886.5 49927.0 49935.8 50697.5 6970.3 7157.9 7372.2 7850.7 8003.3 11151.0 11948.5 12020.8 12164.6 12193.5 10365.5 10453.2 10721.9 10744.4 10833.7 7809.6 10185.3 10257.9 10260.9 10601.7 10321.9 10375.0 10486.3 10508.0 10661.0 7464.4 7485.6 7509.3 7659.0 7820.8 7239.3 8670.2 9605.4 9618.0 9630.9 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | [#3] mootools.html Cycles:180 Average:5232.99 Median:4818.30 stddev:2940.71 (61.0%) stddev-sans-first:2933.12 06:17:48 INFO - PROCESS | 15335 | Values: 1172.4 1515.1 1551.2 1724.6 1881.3 7686.7 8032.1 8075.7 8347.2 8361.1 8093.9 8188.5 8239.2 8268.3 8281.4 2184.0 2233.1 2234.7 2235.6 2237.9 2169.1 2169.5 2255.6 2257.4 2259.4 2184.4 2188.7 2211.1 2213.1 2224.7 2165.8 2174.7 2185.2 2192.6 2194.5 2116.5 2125.1 2125.6 2126.0 2127.8 7966.7 8097.1 8141.4 8157.3 8218.8 4607.0 4707.9 4712.9 4714.9 4719.7 2942.6 2959.6 2976.4 3003.3 3057.8 857.3 883.4 888.3 896.4 904.5 10351.6 10366.0 10383.9 10392.1 10401.6 3957.6 4029.4 4091.3 4100.4 4103.5 8281.6 8313.2 8336.7 8342.2 8342.8 4627.6 4635.1 4636.3 4640.8 4641.2 3881.6 4160.2 4259.2 4264.9 4432.2 3454.2 3457.1 3529.6 3546.0 3667.3 995.5 1019.1 1022.1 1024.3 1028.5 732.1 798.6 843.5 856.7 867.3 5363.8 5540.9 5603.4 5777.8 5837.7 854.8 884.5 925.3 926.8 941.7 3723.1 3802.8 3826.4 3856.9 3924.2 9796.4 10068.4 10200.6 10209.2 10220.5 9964.1 10030.2 10045.9 10049.8 10053.2 7134.8 7429.2 7524.0 7753.5 7760.3 5640.5 5662.3 5767.4 5803.2 5868.7 8787.4 9388.2 9469.4 9478.7 9603.0 9255.2 9408.8 9444.2 9478.1 9491.1 6082.1 6262.7 6419.8 6938.8 7083.2 7240.2 7409.2 7497.5 7505.7 7513.5 6602.4 6677.9 6699.8 6708.3 6865.1 6740.2 6752.2 6781.0 6825.8 6847.0 6404.0 6419.5 6503.0 6508.2 6510.2 4562.3 4636.3 4708.9 4714.3 4715.8 4666.7 4729.5 4755.0 4813.8 4822.8 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | [#4] prototype.html Cycles:180 Average:4170.80 Median:4693.61 stddev:1220.74 (26.0%) stddev-sans-first:1189.03 06:17:48 INFO - PROCESS | 15335 | Values: 296.6 302.2 306.8 309.1 313.7 4846.6 4897.7 4905.1 4940.8 4944.3 4649.6 4692.7 4764.2 4882.3 4888.9 3853.7 3870.7 3888.5 3906.6 3907.9 3899.9 3903.8 3913.6 3913.8 3920.8 3646.8 3692.3 3793.9 3825.1 3840.0 3803.3 3810.9 3816.3 3817.2 3830.3 3395.7 3399.2 3405.6 3406.6 3420.8 4423.2 4694.6 4704.7 4710.3 4780.7 4212.6 4246.4 4252.1 4265.2 4284.6 5059.6 5064.7 5099.7 5103.1 5107.3 3584.9 3589.7 3595.7 3596.6 3605.3 5072.8 5299.3 5300.3 5311.2 5358.2 3692.8 3709.1 3714.3 3725.9 3726.4 3763.6 3797.9 3798.8 3806.7 3818.3 4095.2 4218.9 4250.5 4337.7 4366.5 5083.2 5084.4 5086.9 5141.2 5145.5 1231.7 1267.8 1277.7 1285.2 1311.0 831.5 835.3 841.8 845.5 847.0 4083.8 4088.6 4099.2 4123.2 4128.6 4694.5 4719.8 4746.2 4749.1 4773.2 4055.6 4072.2 4089.7 4095.5 4111.4 2349.8 2516.6 2531.5 2532.9 2553.2 4436.7 4447.8 4481.3 4486.1 4520.3 4702.4 4753.5 4793.8 4794.8 4808.7 4445.0 4452.2 4599.0 5029.7 5072.2 5313.0 5326.3 5326.7 5329.8 5332.7 5215.5 5235.9 5245.3 5252.8 5267.7 4709.5 4944.6 5034.3 5042.5 5046.8 3716.5 3724.3 3734.2 3738.6 3739.3 5122.9 5332.3 5344.9 5359.5 5372.4 5021.0 5153.8 5167.5 5170.7 5188.4 5114.4 5126.4 5151.4 5171.8 5175.8 4866.3 5044.0 5072.7 5093.6 5096.8 5128.6 5142.2 5145.3 5189.1 5192.0 5040.4 5041.4 5131.1 5141.5 5146.6 06:17:48 INFO - PROCESS | 15335 | 06:17:48 INFO - PROCESS | 15335 | [#5] yui.html Cycles:180 Average:13433.43 Median:45686.66 stddev:15360.05 (33.6%) stddev-sans-first:15373.12 06:17:48 INFO - PROCESS | 15335 | Values: 647.4 743.3 762.5 778.3 788.5 12502.6 12622.1 12657.5 12680.1 12691.4 12595.3 12762.0 13341.5 13763.5 13801.6 681.3 859.8 892.9 899.1 901.2 881.3 888.3 889.4 889.4 889.6 926.8 931.1 931.1 931.5 932.0 705.9 906.7 920.8 921.2 931.3 689.1 689.6 691.2 691.5 692.1 13150.9 13172.7 13226.8 13254.4 13269.9 11562.6 11876.7 11986.2 12095.7 12403.0 10068.9 10217.6 10260.0 10498.2 11364.5 3331.2 3395.2 3397.0 3499.4 3525.3 47712.0 47889.0 48531.8 48840.0 49913.0 9830.1 9953.6 10029.6 10143.9 10196.6 17390.3 17569.4 17577.6 17611.6 17785.9 6569.0 6640.6 6724.2 6726.2 6785.3 3773.2 3884.6 3947.9 3974.4 3984.0 2845.4 2917.3 2924.9 2931.1 2934.9 508.2 513.0 514.3 516.5 517.7 520.3 545.0 563.8 609.9 610.1 7673.8 8132.8 8177.5 8251.8 8402.5 585.4 620.1 626.7 627.7 633.5 3936.3 3937.5 4095.4 4164.6 4179.2 49436.0 51022.2 51153.2 53585.0 56657.8 50585.7 51057.2 51123.2 52739.7 52998.7 45602.5 45770.8 45902.0 45934.4 47825.8 8653.3 8757.9 8782.5 8813.6 8929.8 31316.5 31835.8 32634.7 32907.2 32968.7 39803.8 40970.0 41362.6 41753.4 41979.0 10575.4 10596.7 10715.5 10929.8 11040.3 11973.4 12074.2 12078.7 12112.6 12853.0 11166.7 11507.9 11804.7 11983.1 12089.0 11192.6 11254.0 11765.5 11768.9 11795.4 11200.3 11209.4 11543.2 11773.1 11849.5 9804.2 9828.7 9867.6 10095.4 10248.8 9604.2 9725.0 9744.4 9756.5 9768.3 06:17:48 INFO - PROCESS | 15335 | -------- Summary: end -------- 06:17:48 INFO - PROCESS | 15335 | 06:17:49 INFO - TEST-INFO | 15335: exit 0 06:17:49 INFO - TEST-OK | dromaeo_css | took 1119599ms 06:17:49 INFO - TEST-START | kraken 06:17:49 INFO - operating with platform_type : linux_ 06:17:49 INFO - Initialising browser for kraken test... 06:17:49 INFO - TEST-INFO | started process 15514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD97lTM/profile http://localhost:40144/getInfo.html) 06:17:53 INFO - PROCESS | 15514 | __metrics Screen width/height:1600/1200 06:17:53 INFO - PROCESS | 15514 | colorDepth:24 06:17:53 INFO - PROCESS | 15514 | Browser inner width/height: 1024/697 06:17:53 INFO - PROCESS | 15514 | __metrics 06:17:54 ERROR - PROCESS | 15514 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:55 INFO - TEST-INFO | 15514: exit 0 06:17:55 INFO - Browser initialized. 06:17:55 INFO - Running cycle 1/1 for kraken test... 06:17:55 INFO - TEST-INFO | started process 15595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD97lTM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:07 INFO - PROCESS | 15595 | RSS: Main: 154828800 06:18:07 INFO - PROCESS | 15595 | 06:18:10 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40144/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:11 INFO - PROCESS | 15595 | RSS: Main: 210579456 06:18:11 INFO - PROCESS | 15595 | 06:18:14 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40144/tests/kraken/driver.html?testName=audio-dft) 06:18:14 INFO - PROCESS | 15595 | RSS: Main: 198733824 06:18:14 INFO - PROCESS | 15595 | 06:18:18 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40144/tests/kraken/driver.html?testName=audio-fft) 06:18:18 INFO - PROCESS | 15595 | RSS: Main: 266915840 06:18:18 INFO - PROCESS | 15595 | 06:18:20 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40144/tests/kraken/driver.html?testName=audio-oscillator) 06:18:21 INFO - PROCESS | 15595 | RSS: Main: 175603712 06:18:21 INFO - PROCESS | 15595 | 06:18:23 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:24 INFO - PROCESS | 15595 | RSS: Main: 179544064 06:18:24 INFO - PROCESS | 15595 | 06:18:27 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40144/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:28 INFO - PROCESS | 15595 | RSS: Main: 216207360 06:18:28 INFO - PROCESS | 15595 | 06:18:32 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40144/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:32 INFO - PROCESS | 15595 | RSS: Main: 214618112 06:18:32 INFO - PROCESS | 15595 | 06:18:35 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40144/tests/kraken/driver.html?testName=json-parse-financial) 06:18:36 INFO - PROCESS | 15595 | RSS: Main: 215273472 06:18:36 INFO - PROCESS | 15595 | 06:18:38 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:38 INFO - PROCESS | 15595 | RSS: Main: 204849152 06:18:38 INFO - PROCESS | 15595 | 06:18:40 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:41 INFO - PROCESS | 15595 | RSS: Main: 207605760 06:18:41 INFO - PROCESS | 15595 | 06:18:43 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:44 INFO - PROCESS | 15595 | RSS: Main: 217772032 06:18:44 INFO - PROCESS | 15595 | 06:18:47 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:47 INFO - PROCESS | 15595 | RSS: Main: 225845248 06:18:47 INFO - PROCESS | 15595 | 06:18:50 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:51 INFO - PROCESS | 15595 | RSS: Main: 219996160 06:18:51 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | Cycle 1(1): loaded http://localhost:40144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40144/tests/kraken/driver.html?testName=ai-astar) 06:18:53 INFO - PROCESS | 15595 | RSS: Main: 266076160 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | __start_tp_report 06:18:53 INFO - PROCESS | 15595 | _x_x_mozilla_page_load 06:18:53 INFO - PROCESS | 15595 | _x_x_mozilla_page_load_details 06:18:53 INFO - PROCESS | 15595 | |i|pagename|runs| 06:18:53 INFO - PROCESS | 15595 | |0;ai-astar;114;111;113;117;117;115;114;114;113;114 06:18:53 INFO - PROCESS | 15595 | |1;audio-beat-detection;167;130;152;212;130;155;155;130;196;137 06:18:53 INFO - PROCESS | 15595 | |2;audio-dft;161;161;161;162;162;161;161;160;162;160 06:18:53 INFO - PROCESS | 15595 | |3;audio-fft;77;75;76;155;76;75;78;79;138;75 06:18:53 INFO - PROCESS | 15595 | |4;audio-oscillator;93;94;148;92;94;91;123;92;92;121 06:18:53 INFO - PROCESS | 15595 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;117;117 06:18:53 INFO - PROCESS | 15595 | |6;imaging-darkroom;145;146;146;146;147;146;146;147;146;146 06:18:53 INFO - PROCESS | 15595 | |7;imaging-desaturate;94;94;95;94;95;95;95;95;96;96 06:18:53 INFO - PROCESS | 15595 | |8;json-parse-financial;64;64;64;66;63;63;63;115;61;61 06:18:53 INFO - PROCESS | 15595 | |9;json-stringify-tinderbox;63;64;64;64;64;63;63;64;64;65 06:18:53 INFO - PROCESS | 15595 | |10;stanford-crypto-aes;88;83;83;88;89;86;84;84;90;90 06:18:53 INFO - PROCESS | 15595 | |11;stanford-crypto-ccm;138;132;131;130;148;143;128;131;200;132 06:18:53 INFO - PROCESS | 15595 | |12;stanford-crypto-pbkdf2;176;175;176;178;174;172;175;172;178;172 06:18:53 INFO - PROCESS | 15595 | |13;stanford-crypto-sha256-iterative;67;68;70;67;67;66;66;67;66;66 06:18:53 INFO - PROCESS | 15595 | __end_tp_report 06:18:53 INFO - PROCESS | 15595 | __start_cc_report 06:18:53 INFO - PROCESS | 15595 | _x_x_mozilla_cycle_collect,2125 06:18:53 INFO - PROCESS | 15595 | __end_cc_report 06:18:53 INFO - PROCESS | 15595 | __startTimestamp1463491133630__endTimestamp 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | ------- Summary: start ------- 06:18:53 INFO - PROCESS | 15595 | Number of tests: 14 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.92 06:18:53 INFO - PROCESS | 15595 | Values: 114.0 111.0 113.0 117.0 117.0 115.0 114.0 114.0 113.0 114.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:155.00 stddev:28.41 (18.3%) stddev-sans-first:29.87 06:18:53 INFO - PROCESS | 15595 | Values: 167.0 130.0 152.0 212.0 130.0 155.0 155.0 130.0 196.0 137.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:18:53 INFO - PROCESS | 15595 | Values: 161.0 161.0 161.0 162.0 162.0 161.0 161.0 160.0 162.0 160.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#3] audio-fft Cycles:10 Average:90.40 Median:76.00 stddev:29.87 (39.3%) stddev-sans-first:31.28 06:18:53 INFO - PROCESS | 15595 | Values: 77.0 75.0 76.0 155.0 76.0 75.0 78.0 79.0 138.0 75.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:19.74 (21.5%) stddev-sans-first:20.54 06:18:53 INFO - PROCESS | 15595 | Values: 93.0 94.0 148.0 92.0 94.0 91.0 123.0 92.0 92.0 121.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:18:53 INFO - PROCESS | 15595 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 06:18:53 INFO - PROCESS | 15595 | Values: 145.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 06:18:53 INFO - PROCESS | 15595 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 96.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:63.50 stddev:16.44 (25.9%) stddev-sans-first:17.36 06:18:53 INFO - PROCESS | 15595 | Values: 64.0 64.0 64.0 66.0 63.0 63.0 63.0 115.0 61.0 61.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 06:18:53 INFO - PROCESS | 15595 | Values: 63.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 64.0 65.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:88.00 stddev:2.84 (3.2%) stddev-sans-first:2.96 06:18:53 INFO - PROCESS | 15595 | Values: 88.0 83.0 83.0 88.0 89.0 86.0 84.0 84.0 90.0 90.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:135.00 stddev:21.59 (16.0%) stddev-sans-first:22.86 06:18:53 INFO - PROCESS | 15595 | Values: 138.0 132.0 131.0 130.0 148.0 143.0 128.0 131.0 200.0 132.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:2.30 (1.3%) stddev-sans-first:2.40 06:18:53 INFO - PROCESS | 15595 | Values: 176.0 175.0 176.0 178.0 174.0 172.0 175.0 172.0 178.0 172.0 06:18:53 INFO - PROCESS | 15595 | 06:18:53 INFO - PROCESS | 15595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 06:18:53 INFO - PROCESS | 15595 | Values: 67.0 68.0 70.0 67.0 67.0 66.0 66.0 67.0 66.0 66.0 06:18:53 INFO - PROCESS | 15595 | -------- Summary: end -------- 06:18:53 INFO - PROCESS | 15595 | 06:18:54 INFO - TEST-INFO | 15595: exit 0 06:18:54 INFO - TEST-OK | kraken | took 65497ms 06:18:54 INFO - SUITE-END | took 1185s 06:18:54 INFO - Completed test suite (00:19:45) 06:18:54 INFO - javascript benchmark 06:18:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.933751656208, 2658.8404695718273, 2695.4204845958116, 2695.9865200673994, 2704.878280477378, 4642.512536183703, 4737.218358970775, 4742.9288560671575, 4811.711297322163, 4864.464908860023, 4762.214234651287, 4768.284757286408, 4787.6169906407495, 4831.396075490564, 4836.032793441317, 4341.739495630257, 4353.978230108845, 4411.514733379326, 4440.444944381952, 4525.637948964091, 4415.050764085705, 4450.354698568705, 4468.486124095738, 4477.485089214733, 4501.639868810487, 4249.405083288311, 4283.0, 4304.612584867377, 4361.694681372305, 4364.345348197764, 4327.1345730853955, 4355.760433176174, 4356.128774245164, 4398.274284743014, 4420.469543654782, 4341.06667066579, 4376.124775044972, 4388.539203383662, 4395.714278571914, 4430.401895744066, 4573.153966516172, 4636.235021221494, 4702.717836929795, 4710.599599034086, 4717.740524271164, 5128.615353848476, 5189.844304670866, 5203.739813009334, 5206.843794686166, 5208.973955130238, 5183.377994640629, 5189.169732842727, 5215.634905556574, 5222.2427747976335, 5231.503007214346, 4637.976810115995, 4672.556107169813, 4805.1590971579835, 4840.951590484121, 4841.636877234221, 5300.390455097713, 5337.466253374631, 5384.78460861569, 5391.29913111293, 5391.757370918318, 5113.846584602468, 5116.334876466036, 5118.846434606968, 5159.484051594811, 5171.689698618095, 4957.553820156203, 5085.796568137307, 5120.078385890501, 5150.845474635767, 5227.555657769056, 5129.7178655173575, 5138.126518491866, 5138.640295179376, 5148.716820574829, 5173.741312934339, 5081.5426611605135, 5085.389753229562, 5094.0, 5103.744812759347, 5141.794328226903, 4259.97870010648, 4301.978490107529, 4303.74177549348, 4360.0, 4414.668899832525, 3803.0, 3823.5411750590106, 3839.3665045267776, 3841.8655347063277, 3842.865499707497, 4324.156789426094, 4365.170617582649, 4365.956340436555, 4411.448568928884, 4423.646108311327, 5055.216441451581, 5096.51583099605, 5103.413107492612, 5109.054824857413, 5166.715830629276, 4369.781510924441, 4371.0, 4373.212821692063, 4380.167768124046, 4414.381986521889, 4482.843100491533, 4568.360429539867, 4603.355530225771, 4604.953950460453, 4610.331501932201, 4799.424069111729, 4802.135615589157, 4803.783829727601, 4811.831585894617, 4852.490488498657, 4978.128827455109, 5104.183330667075, 5112.590992720648, 5118.795248190179, 5124.256982737556, 4820.060088282751, 4866.391701037371, 4874.512548745097, 4880.780364883518, 4880.975595122001, 5079.9238011429115, 5105.4384017757275, 5108.386993560796, 5111.361079865017, 5157.458466861076, 4925.236588328815, 5070.3155074064525, 5154.453663900889, 5166.535011848951, 5192.480751924777, 4947.455779864284, 4981.775820088033, 4999.65002449825, 5006.524380183877, 5057.216131499624, 4975.900481990412, 4987.750612469289, 4993.925091123563, 4999.0, 5041.495850414929, 4794.352762377034, 4858.975705121452, 4907.043126590281, 4915.65590408668, 4960.305557222064, 4988.750562471934, 5027.49725027509, 5030.597552195889, 5043.0, 5070.4676009019995, 4921.532454416824, 4922.975385123052, 4928.21148616234, 4930.531599498042, 4966.478519755374], "value": 4703.390508507785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2946317103621, 585.2508788750399, 606.751231994882, 608.4432744039204, 608.5800797449757, 41806.37290440642, 43456.348154777625, 43458.34812477815, 43560.56439435605, 48125.759371203094, 43422.0, 43951.0, 43976.3403548947, 44026.779866100704, 44037.33943990843, 8064.435489515751, 8205.630746616387, 8205.917940820606, 8207.179282071775, 8212.260896519312, 7952.20477952206, 8048.758537243892, 8053.798655033613, 8055.234752698513, 8061.314788243007, 8023.759287221393, 8054.51672899625, 8059.5089908366845, 8064.395170362217, 8065.354771618257, 8004.799880003017, 8020.077691065544, 8020.478668886562, 8047.315978141865, 8054.114047454776, 7950.681972721084, 8031.116577176506, 8031.357491400674, 8035.799105022363, 8036.799080022988, 41202.38196427056, 41547.58452415467, 41563.0, 41602.583974160174, 41779.1644167118, 3245.8701651933893, 3372.7976321420547, 3394.5077963695126, 3420.350133474632, 3466.480027995821, 29730.40539189204, 30309.680686788903, 30578.0, 30698.386032279454, 30920.69079309223, 3446.638102999174, 3451.20479234654, 3538.8938331850086, 3580.4629305604108, 3596.118950857057, 259038.0, 259384.0, 259489.0, 259741.0, 259963.0, 31015.68984310128, 57901.42098579044, 58029.0, 58335.70832145812, 58378.0, 32865.342693146005, 34770.652293477244, 34790.0, 34806.825965870514, 34813.82593087069, 13850.515231966832, 14103.224322662352, 14118.364673589713, 14125.505607303901, 14131.222782747047, 11521.769564608661, 11570.074394048455, 11572.247803892888, 11574.074074074222, 11578.305301681927, 8424.78938026542, 8466.40735148546, 8480.53357065355, 8493.0, 8563.785905352292, 3217.758668099855, 3274.705276525124, 3299.6700329967293, 3321.6678332167075, 3354.446516324828, 908.2506931781306, 919.852823548229, 939.699296225215, 970.0202795176922, 1022.9130523905402, 29271.560926586117, 29779.851100744792, 30234.0, 30632.0, 30656.69343306583, 950.4867371619387, 970.6748239339901, 988.1748739802202, 997.0378584665832, 1064.6007747094839, 15454.304556294994, 15988.76016859748, 16004.199790010685, 16069.116198608956, 16260.0, 376346.0, 376758.0, 378760.0, 379233.0, 379311.0, 53045.204321935205, 53639.73180134074, 53688.73155634197, 53702.46297537053, 53736.46263537393, 1196.5273716881784, 1219.9939000304942, 1232.5254776910774, 1240.1690867119053, 1256.114439320277, 28212.576811347437, 29179.85410072936, 29269.41461170807, 29741.256468588457, 29862.701372985994, 47035.764821175675, 47427.525724742314, 47447.0, 47488.0, 47538.76230618825, 320035.0, 326452.0, 327147.0, 328200.0, 328288.0, 23142.190023349103, 25634.871825640752, 26417.0, 26798.464030719668, 26957.3260668477, 44252.0, 44374.3343849849, 44842.0, 44851.775741121084, 45747.771261144815, 38226.617733822306, 38577.80711096426, 39533.604663954146, 39906.401403979544, 40219.798901005306, 38393.23213535769, 38705.4194187093, 38991.0, 39309.2138157241, 39322.21355572815, 38779.0, 38857.22285554217, 39477.40783888302, 39510.40734388929, 39517.209655806146, 33834.323313533096, 35035.29929401448, 35753.46369804507, 35885.820570896976, 36069.63930360663, 26922.730772692023, 27185.823037563958, 27456.176314710592, 27527.0, 27663.446731064865], "value": 17376.55552536391, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.27785151844785, 381.32879181334744, 383.60871910651156, 383.9328117579424, 410.94452248946385, 12389.752204955896, 16128.0, 17257.56856078597, 18247.087645617732, 18272.086395680195, 17102.572435689115, 17198.484045478624, 17945.75678040245, 17968.101594920267, 17976.191071401787, 5027.8240261590945, 5190.584753219733, 5292.497212764801, 5299.099153143975, 5322.920156197641, 3718.553773547178, 5205.37535495741, 5719.485246327829, 6021.789237376693, 6030.33666296707, 6051.576389652704, 6059.394060593927, 6063.6361818290825, 6092.969535152318, 6093.116498107772, 5312.787488500475, 5617.494425501724, 5649.717514124277, 5655.688937108499, 5662.263905692254, 5322.893542129174, 5459.12653975362, 5470.480304371078, 5486.862828429281, 5565.888682226333, 11912.404379781063, 11977.101717371232, 11995.16033877629, 12498.375081245902, 12527.498900043987, 1759.1028575426496, 2016.0826823795137, 2104.326615483046, 2401.483681008574, 2445.364205306615, 8717.825643487158, 9231.538423078886, 9441.15029647328, 9463.337566370357, 9689.757756056084, 1580.162513867652, 1715.082430899463, 1758.7977382601036, 1782.1000394800672, 1812.664657038439, 66283.0, 68750.0, 69541.30458695449, 70095.2990470094, 70977.29022709759, 9001.504917229615, 9446.622135114518, 10243.641472548425, 10280.845787313196, 10285.640002600023, 14031.649208769863, 14448.0, 14542.927285363505, 14544.781828272584, 14551.92724036373, 7614.923850761532, 7678.616069196518, 7682.1549629540705, 7785.104712957969, 7825.256600622932, 7164.104486939133, 7206.7117315306805, 7346.449016323797, 7370.963145184347, 7493.3630641395, 4453.532379100213, 4506.616937560344, 4613.723176609415, 4627.056636212798, 4691.085238378551, 1865.860060495441, 1915.6647586672277, 1951.1512492065997, 1960.9313674021626, 1983.4148926066846, 778.2567647896245, 880.5817236812591, 915.1900567997237, 932.8274269260208, 1008.1833714691123, 16571.337146514004, 17299.82700172982, 17311.740323895152, 17444.563885902953, 17839.643207135785, 879.7404765594165, 897.3270047464401, 908.2506931781174, 922.3635939415839, 938.3150300280834, 9781.706548803548, 9825.213982881352, 9863.112319891245, 9898.406095634286, 9963.80072398548, 345195.0, 346851.0, 349409.0, 352909.0, 360385.0, 80717.0, 84008.57995710104, 84053.57973210217, 84152.57923710342, 85097.0, 936.2603543200931, 953.1278879824882, 991.5587563534158, 995.4624502768424, 1002.283367392318, 15278.312475938832, 15292.235388230767, 15587.220638968232, 15802.20988950525, 16054.117023563816, 25694.357641058374, 26402.86798565995, 32220.0, 32282.677173228905, 35350.46974295439, 48265.0, 49886.50113498818, 49927.0, 49935.75032124816, 50697.49302506928, 6970.337817907291, 7157.928420715726, 7372.189059203591, 7850.725224617111, 8003.279704826594, 11151.0, 11948.522059117538, 12020.819687704867, 12164.635060948185, 12193.451294691937, 10365.481725913825, 10453.216008799523, 10721.892781072089, 10744.355338679705, 10833.729156770829, 7809.609519523888, 10185.33795303303, 10257.9487102567, 10260.897391025994, 10601.681949541526, 10321.936112290457, 10375.0, 10486.318389304672, 10508.0, 10661.0, 7464.365528930101, 7485.588292643957, 7509.324160825552, 7658.961705191661, 7820.84358312842, 7239.312265334785, 8670.219680228558, 9605.37565058269, 9617.951910240405, 9630.903690963001], "value": 8187.385133128783, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1172.3844981384777, 1515.1288009394598, 1551.1623723189477, 1724.586099336159, 1881.2686094472397, 7686.654100565474, 8032.116467188612, 8075.717349892762, 8347.16528347165, 8361.122082181375, 8093.878591821127, 8188.549629770375, 8239.176082391758, 8268.255856972872, 8281.420300578962, 2183.9781602183975, 2233.106757297086, 2234.6871437998693, 2235.564065007316, 2237.865728056314, 2169.056460439706, 2169.457635591102, 2255.560165767676, 2257.413072601119, 2259.435141214696, 2184.432047667602, 2188.73735151782, 2211.060299372768, 2213.1147540983575, 2224.7219097612797, 2165.8483906126576, 2174.7390313162364, 2185.2460900989136, 2192.6162921488753, 2194.462356722597, 2116.534362440261, 2125.1499400239873, 2125.553633736917, 2126.032655141922, 2127.7872212778752, 7966.721164759264, 8097.109317975077, 8141.43009989301, 8157.347412207068, 8218.753437396888, 4606.953930460686, 4707.882302942419, 4712.858614241544, 4714.905701885978, 4719.693219940693, 2942.602748628929, 2959.5708622249867, 2976.374961258117, 3003.279212988889, 3057.8471076446313, 857.2884505860121, 883.439016224702, 888.2893685051932, 896.3546246702364, 904.5432056811334, 10351.63769268072, 10366.015228553351, 10383.94808025955, 10392.116670083053, 10401.635942741968, 3957.604239576019, 4029.3553031514816, 4091.3453847384276, 4100.384942258625, 4103.548609652936, 8281.585920703941, 8313.210245026712, 8336.66653333872, 8342.16578342161, 8342.791430214173, 4627.629789616823, 4635.096156249567, 4636.2581986882615, 4640.814367425332, 4641.234196357564, 3881.631245031774, 4160.2303573838935, 4259.169461954889, 4264.87205383839, 4432.224360736858, 3454.2227998700596, 3457.11843479911, 3529.5588051493564, 3545.989393023028, 3667.339878821838, 995.4873240281261, 1019.1337363241333, 1022.1311884897926, 1024.2522958240377, 1028.4703377760459, 732.0739264829995, 798.6086817459519, 843.4559708987791, 856.6573370651664, 867.2888231650113, 5363.785448582091, 5540.861478463071, 5603.411641777636, 5777.826665200051, 5837.67892765902, 854.773485026456, 884.5046773806689, 925.2967744514218, 926.8424367857481, 941.6939494664261, 3723.1250656095795, 3802.8288727006798, 3826.445165450994, 3856.9035774105873, 3924.2151569686175, 9796.412215267106, 10068.39589624625, 10200.591976321013, 10209.183265338903, 10220.540075696612, 9964.05341492557, 10030.247731420026, 10045.899541004643, 10049.839284553856, 10053.195744340435, 7134.821629459305, 7429.216987922751, 7523.9623801881735, 7753.4960227585025, 7760.262775036363, 5640.464155905182, 5662.292213473316, 5767.423257674199, 5803.158542011469, 5868.706564671835, 8787.428817126865, 9388.202002829836, 9469.384490008128, 9478.668246611336, 9603.0, 9255.213306868991, 9408.76478088026, 9444.197243234403, 9478.052194780743, 9491.098345657152, 6082.148499210202, 6262.655553944577, 6419.839504012437, 6938.757143499954, 7083.185433675193, 7240.167380751281, 7409.222031686595, 7497.512661676974, 7505.66224519887, 7513.4740568159705, 6602.372774586406, 6677.899831502435, 6699.799006029827, 6708.295628958889, 6865.141857267841, 6740.191177058784, 6752.223494298219, 6781.0, 6825.761098361533, 6846.965765171142, 6404.0, 6419.486441084796, 6503.0, 6508.186476690414, 6510.153680021567, 4562.270036794097, 4636.3045543167445, 4708.905821883612, 4714.29285607148, 4715.764211789466, 4666.696664716783, 4729.5034021427255, 4754.97767979886, 4813.78337974799, 4822.807087716452], "value": 4192.829339057768, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6306947849927, 302.17958243369253, 306.7591940326844, 309.07124092103226, 313.7364613724471, 4846.612271018319, 4897.6816506927025, 4905.117078925797, 4940.802367905279, 4944.307796908436, 4649.6047835933905, 4692.741899195543, 4764.166270902596, 4882.340883980662, 4888.902221955559, 3853.7495062820826, 3870.6903447724117, 3888.5333759948844, 3906.609339066099, 3907.902302442433, 3899.863504777333, 3903.8243279052513, 3913.5695073541888, 3913.8043097845134, 3920.84316627336, 3646.817659117047, 3692.280005398948, 3793.924121517568, 3825.101101241206, 3840.0, 3803.3376636354665, 3810.923781524354, 3816.332141875175, 3817.179306449099, 3830.3488406970882, 3395.6774106459848, 3399.2351720862857, 3405.5743032120986, 3406.5912090549045, 3420.846061927219, 4423.159599676052, 4694.647901407408, 4704.694194877322, 4710.29345598163, 4780.661414803861, 4212.620864122244, 4246.426732391118, 4252.107057517925, 4265.168292183025, 4284.5715428457215, 5059.62052846038, 5064.657865665602, 5099.668521546125, 5103.132467480537, 5107.3360463139925, 3584.946225806615, 3589.7128229741556, 3595.7123430125525, 3596.6403359664087, 3605.3330133925306, 5072.771725272371, 5299.311089558371, 5300.337457817773, 5311.176767601028, 5358.223057656618, 3692.8338224779413, 3709.109813644706, 3714.275716235308, 3725.9254814904093, 3726.366517691999, 3763.6048214937587, 3797.867074652374, 3798.8100594970692, 3806.6764325032127, 3818.293615681108, 4095.201435720006, 4218.936715949263, 4250.452016342484, 4337.677008512434, 4366.454193225847, 5083.161278389024, 5084.3644544431945, 5086.92369614456, 5141.228815677603, 5145.511176438233, 1231.6859200903891, 1267.7781388257017, 1277.7444511097817, 1285.1517998121194, 1310.9868901310865, 831.538496134639, 835.3150416658403, 841.7979684875709, 845.4842546046906, 846.9836196564148, 4083.774867539726, 4088.5911408858874, 4099.221147981874, 4123.237201117803, 4128.566500517462, 4694.474295853861, 4719.764011799396, 4746.216874215785, 4749.097671442415, 4773.188557945157, 4055.634992850599, 4072.1855628874346, 4089.6523795477124, 4095.5494895561465, 4111.403846442249, 2349.765023497637, 2516.6476693262957, 2531.5063562605114, 2532.873356332176, 2553.157458038843, 4436.711613745097, 4447.844325448594, 4481.305397663367, 4486.147631949919, 4520.276755719069, 4702.365180700562, 4753.453352864396, 4793.784279707422, 4794.808207671654, 4808.687435316693, 4444.977775111104, 4452.243118669834, 4599.0, 5029.673071250357, 5072.163093089599, 5313.0, 5326.25432439451, 5326.680399176062, 5329.840104796862, 5332.653377530603, 5215.478452154754, 5235.869103272448, 5245.291885595396, 5252.816151434681, 5267.657602255841, 4709.529047095263, 4944.629152813625, 5034.320366750442, 5042.495750424928, 5046.823361182341, 3716.4611131386337, 3724.329620668306, 3734.1971476132762, 3738.5887552369763, 3739.2521495700425, 5122.948770512247, 5332.253484512249, 5344.893102138013, 5359.526130314195, 5372.355317361941, 5020.974895125501, 5153.7680804364645, 5167.457416971314, 5170.689758614495, 5188.351456067991, 5114.360704911886, 5126.436781609195, 5151.381834179922, 5171.767270472763, 5175.792968281226, 4866.270059491105, 5043.9747801260755, 5072.67027643202, 5093.643444958817, 5096.847094587169, 5128.640995130305, 5142.1772516397195, 5145.276332428678, 5189.091908915849, 5192.039472697563, 5040.361882388312, 5041.445441001413, 5131.127708289674, 5141.511556402136, 5146.562542183807], "value": 3784.2222056860082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.3817504283409, 743.323575546253, 762.5386641082149, 778.2917545034019, 788.5387048576582, 12502.624921252365, 12622.116451848362, 12657.493700252002, 12680.112392132554, 12691.36543172841, 12595.3072581008, 12762.0, 13341.53304634338, 13763.518276860312, 13801.585952421417, 681.2710399872138, 859.8065435277075, 892.9464232146075, 899.0829354058889, 901.179926267097, 881.3257857738803, 888.3381880499005, 889.3596610440472, 889.4440974391006, 889.5774507109136, 926.7590426489094, 931.0549791961165, 931.0828833598933, 931.5109567477061, 931.9627214911429, 705.8658854817568, 906.7143849687327, 920.7974245665943, 921.2077613252598, 931.2829121576416, 689.0766373060123, 689.6000319814495, 691.215470441048, 691.4606606846668, 692.0864458914235, 13150.868491315061, 13172.6706832329, 13226.801597976038, 13254.40355184019, 13269.86730132696, 11562.595309164139, 11876.703082423008, 11986.220895641756, 12095.697607559794, 12403.0, 10068.949655251678, 10217.591296348137, 10260.0, 10498.212634052477, 11364.48859801311, 3331.217163966466, 3395.2021275000357, 3396.9660303396895, 3499.3876071687355, 3525.2773181497732, 47712.0, 47889.04221915577, 48531.757341213066, 48840.0, 49912.999999999636, 9830.066143716336, 9953.601855925826, 10029.64896228643, 10143.949280253699, 10196.643117490852, 17390.3043878246, 17569.385071522436, 17577.648447031243, 17611.55971100733, 17785.911070444567, 6569.0, 6640.63476508787, 6724.193096828412, 6726.159230096238, 6785.287544807724, 3773.2076263984873, 3884.5726970033274, 3947.8618248361167, 3974.364101743707, 3983.9601603983588, 2845.3882415280814, 2917.2706823294175, 2924.883004679789, 2931.120663800851, 2934.8972785952815, 508.2477932659684, 513.0303725957942, 514.2697369734985, 516.5118962580401, 517.6997341541896, 520.2872065270603, 544.9618526703093, 563.8223959452841, 609.9054646529795, 610.1488423649073, 7673.76978690629, 8132.837343253102, 8177.4684645497855, 8251.803488494255, 8402.453840500348, 585.4145854145854, 620.0637038072543, 626.6553395632475, 627.7143899525705, 633.4647223096476, 3936.271789718854, 3937.547182074098, 4095.4061661059577, 4164.646005089541, 4179.247735407595, 49436.0, 51022.234666480035, 51153.23270150951, 53585.0, 56657.78462122969, 50585.747071264406, 51057.234141487905, 51123.233151502754, 52739.73630131825, 52998.73500632549, 45602.543974560496, 45770.771146144056, 45902.0, 45934.36235576216, 47825.760871196115, 8653.317005696625, 8757.91242087571, 8782.516961567175, 8813.60338784769, 8929.776755581162, 31316.530252046694, 31835.840820795747, 32634.673653263162, 32907.17732056622, 32968.67031329656, 39803.80098099491, 40970.0, 41362.58637413587, 41753.373699393924, 41979.0, 10575.36547807134, 10596.70730551017, 10715.464226788474, 10929.836052459379, 11040.33757974524, 11973.401329933642, 12074.154809163274, 12078.698032549257, 12112.576059837864, 12853.036022298553, 11166.720831979266, 11507.94246028798, 11804.70488237801, 11983.101267404805, 12089.0, 11192.608258711232, 11254.0, 11765.470553824927, 11768.94115529417, 11795.410229488663, 11200.271982321123, 11209.383483908137, 11543.191976561897, 11773.05815534738, 11849.466773995364, 9804.1666458349, 9828.705138845846, 9867.555959981675, 10095.394276343442, 10248.846267306146, 9604.183644390305, 9724.951375243361, 9744.366616169926, 9756.512174391393, 9768.267379946674], "value": 6204.454529169756, "unit": "score"}], "name": "dromaeo_css", "value": 6355.152965003092, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 117.0, 117.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 130.0, 152.0, 212.0, 130.0, 155.0, 155.0, 130.0, 196.0, 137.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 155.0, 76.0, 75.0, 78.0, 79.0, 138.0, 75.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 148.0, 92.0, 94.0, 91.0, 123.0, 92.0, 92.0, 121.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 66.0, 63.0, 63.0, 63.0, 115.0, 61.0, 61.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 83.0, 88.0, 89.0, 86.0, 84.0, 84.0, 90.0, 90.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 131.0, 130.0, 148.0, 143.0, 128.0, 131.0, 200.0, 132.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 176.0, 178.0, 174.0, 172.0, 175.0, 172.0, 178.0, 172.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1585.6, "alertThreshold": 2.0}]} 06:18:54 INFO - Return code: 0 06:18:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:18:54 ERROR - # TBPL SUCCESS # 06:18:54 INFO - Running post-action listener: _resource_record_post_action 06:18:54 INFO - ##### 06:18:54 INFO - ##### Finished run-tests step (success) 06:18:54 INFO - ##### 06:18:54 INFO - Running post-run listener: _resource_record_post_run 06:18:55 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 530309120; Read time: 0; Write time: 466084 06:18:55 INFO - TinderboxPrint: CPU usage
13.2% 06:18:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:18:55 INFO - TinderboxPrint: I/O write bytes / time
530,309,120 / 466,084 06:18:55 INFO - TinderboxPrint: CPU idle
8,329.7 (86.8%) 06:18:55 INFO - TinderboxPrint: CPU user
1,217.7 (12.7%) 06:18:55 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:55 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 236294144; Read time: 0; Write time: 310376 06:18:55 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 294014976; Read time: 0; Write time: 155708 06:18:55 INFO - Running post-run listener: _upload_blobber_files 06:18:55 INFO - Blob upload gear active. 06:18:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:55 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 06:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:56 INFO - (blobuploader) - INFO - Done attempting. 06:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:02 INFO - (blobuploader) - INFO - Done attempting. 06:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:03 INFO - (blobuploader) - INFO - Done attempting. 06:19:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:03 INFO - Return code: 0 06:19:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/549ab617fdd44aab0029681233e50f091671ecb9d15d3af562f68d516ae06077ec9711b5174ec92fa5d58e589e6f451334b302fda6b38246d893af930dd718ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ed83d13863e9deb9d98b17eecc2f8e551757d8b359ccf5c3ea681d57b0804c395c4a76499afbfb2e057a43636596c0eb6618c94e91d2ddf2f38666b7f84170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c19863cd92d9246d165bc98a25f60104a904ba4c9267605a47b3853f445c824b2dbddf3d810500f98e98a7878cc5ff7272e49a29ecdf978fe2141f74a13d3043"} 06:19:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:03 INFO - Contents: 06:19:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/549ab617fdd44aab0029681233e50f091671ecb9d15d3af562f68d516ae06077ec9711b5174ec92fa5d58e589e6f451334b302fda6b38246d893af930dd718ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ed83d13863e9deb9d98b17eecc2f8e551757d8b359ccf5c3ea681d57b0804c395c4a76499afbfb2e057a43636596c0eb6618c94e91d2ddf2f38666b7f84170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c19863cd92d9246d165bc98a25f60104a904ba4c9267605a47b3853f445c824b2dbddf3d810500f98e98a7878cc5ff7272e49a29ecdf978fe2141f74a13d3043"} 06:19:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:03 INFO - Copying logs to upload dir... 06:19:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.150522 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-17 06:19:02.898941) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 06:19:02.903813) ========= 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=cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/549ab617fdd44aab0029681233e50f091671ecb9d15d3af562f68d516ae06077ec9711b5174ec92fa5d58e589e6f451334b302fda6b38246d893af930dd718ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ed83d13863e9deb9d98b17eecc2f8e551757d8b359ccf5c3ea681d57b0804c395c4a76499afbfb2e057a43636596c0eb6618c94e91d2ddf2f38666b7f84170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c19863cd92d9246d165bc98a25f60104a904ba4c9267605a47b3853f445c824b2dbddf3d810500f98e98a7878cc5ff7272e49a29ecdf978fe2141f74a13d3043"} build_url:https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/bIzLsMhDQsu3wXYwlKluyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/549ab617fdd44aab0029681233e50f091671ecb9d15d3af562f68d516ae06077ec9711b5174ec92fa5d58e589e6f451334b302fda6b38246d893af930dd718ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ed83d13863e9deb9d98b17eecc2f8e551757d8b359ccf5c3ea681d57b0804c395c4a76499afbfb2e057a43636596c0eb6618c94e91d2ddf2f38666b7f84170d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c19863cd92d9246d165bc98a25f60104a904ba4c9267605a47b3853f445c824b2dbddf3d810500f98e98a7878cc5ff7272e49a29ecdf978fe2141f74a13d3043"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 06:19:02.927101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 06:19:02.927386) ========= 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=cbe409c6de289db6ac707de3000001d4-1463489894.480368-342441800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 06:19:03.010515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 06:19:03.010810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 06:19:03.011213) ========= ========= Total master_lag: 0.15 =========