builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1463619678.0 results: success (0) buildid: 20160518172746 builduid: 6061971e4f2143fb821a97bb10053a7f revision: e0fa395e4982a5225e73908a4a0816932043440d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.003959) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.004440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.004760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.039665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.039986) ========= 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=232498196343f89f466a4a9a000001c8-1463618524.165518-826718291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 18:01:18-- 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% 224M=0s 2016-05-18 18:01:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.168028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.168383) ========= 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=232498196343f89f466a4a9a000001c8-1463618524.165518-826718291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018638 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:18.223337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 18:01:18.226816) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0fa395e4982a5225e73908a4a0816932043440d --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 e0fa395e4982a5225e73908a4a0816932043440d --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=232498196343f89f466a4a9a000001c8-1463618524.165518-826718291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 18:01:18,740 truncating revision to first 12 chars 2016-05-18 18:01:18,740 Setting DEBUG logging. 2016-05-18 18:01:18,740 attempt 1/10 2016-05-18 18:01:18,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0fa395e4982?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 18:01:19,797 unpacking tar archive at: fx-team-e0fa395e4982/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 18:01:19.582131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:19.582572) ========= script_repo_revision: e0fa395e4982a5225e73908a4a0816932043440d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:19.583049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:19.583324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 18:01:19.593721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-18 18:01:19.594156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463618524.165518-826718291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:01:20 INFO - MultiFileLogger online at 20160518 18:01:20 in /builds/slave/test 18:01:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:01:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:01:20 INFO - {'append_to_log': False, 18:01:20 INFO - 'base_work_dir': '/builds/slave/test', 18:01:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:01:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:01:20 INFO - 'branch': 'Fx-Team-Non-PGO', 18:01:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:01:20 INFO - 'config_files': ('talos/linux_config.py',), 18:01:20 INFO - 'default_actions': ('clobber', 18:01:20 INFO - 'read-buildbot-config', 18:01:20 INFO - 'download-and-extract', 18:01:20 INFO - 'populate-webroot', 18:01:20 INFO - 'create-virtualenv', 18:01:20 INFO - 'install', 18:01:20 INFO - 'run-tests'), 18:01:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:01:20 INFO - 'download_minidump_stackwalk': True, 18:01:20 INFO - 'download_symbols': 'ondemand', 18:01:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:01:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:01:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:01:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:01:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:01:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:01:20 INFO - 'installer_path': 'installer.exe', 18:01:20 INFO - 'log_level': 'info', 18:01:20 INFO - 'log_name': 'talos', 18:01:20 INFO - 'log_to_console': True, 18:01:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:01:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:01:20 INFO - 'opt_config_files': (), 18:01:20 INFO - 'pip_index': False, 18:01:20 INFO - 'sps_profile': False, 18:01:20 INFO - 'sps_profile_interval': 0, 18:01:20 INFO - 'suite': 'dromaeojs-e10s', 18:01:20 INFO - 'system_bits': '32', 18:01:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:01:20 INFO - 'title': 'talos-linux64-ix-025', 18:01:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:01:20 INFO - 'use_talos_json': True, 18:01:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:01:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:01:20 INFO - 'work_dir': 'build'} 18:01:20 INFO - ##### 18:01:20 INFO - ##### Running clobber step. 18:01:20 INFO - ##### 18:01:20 INFO - Running pre-action listener: _resource_record_pre_action 18:01:20 INFO - Running main action method: clobber 18:01:20 INFO - rmtree: /builds/slave/test/build 18:01:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:01:20 INFO - Running post-action listener: _resource_record_post_action 18:01:20 INFO - ##### 18:01:20 INFO - ##### Finished clobber step (success) 18:01:20 INFO - ##### 18:01:20 INFO - ##### 18:01:20 INFO - ##### Running read-buildbot-config step. 18:01:20 INFO - ##### 18:01:20 INFO - Running pre-action listener: _resource_record_pre_action 18:01:20 INFO - Running main action method: read_buildbot_config 18:01:20 INFO - Using buildbot properties: 18:01:20 INFO - { 18:01:20 INFO - "project": "", 18:01:20 INFO - "product": "firefox", 18:01:20 INFO - "script_repo_revision": "production", 18:01:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:01:20 INFO - "repository": "", 18:01:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:01:20 INFO - "buildid": "20160518172746", 18:01:20 INFO - "pgo_build": "False", 18:01:20 INFO - "basedir": "/builds/slave/test", 18:01:20 INFO - "buildnumber": 1278, 18:01:20 INFO - "slavename": "talos-linux64-ix-025", 18:01:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:01:20 INFO - "platform": "ubuntu64_hw", 18:01:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:01:20 INFO - "branch": "fx-team", 18:01:20 INFO - "repo_path": "integration/fx-team", 18:01:20 INFO - "revision": "e0fa395e4982a5225e73908a4a0816932043440d", 18:01:20 INFO - "stage_platform": "linux64", 18:01:20 INFO - "builduid": "6061971e4f2143fb821a97bb10053a7f", 18:01:20 INFO - "slavebuilddir": "test" 18:01:20 INFO - } 18:01:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:01:20 INFO - Running post-action listener: _resource_record_post_action 18:01:20 INFO - ##### 18:01:20 INFO - ##### Finished read-buildbot-config step (success) 18:01:20 INFO - ##### 18:01:20 INFO - ##### 18:01:20 INFO - ##### Running download-and-extract step. 18:01:20 INFO - ##### 18:01:20 INFO - Running pre-action listener: _resource_record_pre_action 18:01:20 INFO - Running main action method: download_and_extract 18:01:20 INFO - mkdir: /builds/slave/test/build/tests 18:01: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')]} 18:01:20 INFO - https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:21 INFO - Downloaded 1361 bytes. 18:01:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:01:21 INFO - Using the following test package requirements: 18:01:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:01:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:01:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:01:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'jsshell-linux-x86_64.zip'], 18:01:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:01:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:01:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:01:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:01:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:01:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:01:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:01:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:01:21 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')]} 18:01:21 INFO - https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:22 INFO - Downloaded 22812201 bytes. 18:01:22 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'] 18:01:22 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 18:01:24 INFO - Return code: 0 18:01:24 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 18:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:24 INFO - https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:33 INFO - Downloaded 22812201 bytes. 18:01:33 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'] 18:01:33 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 18:01:35 INFO - Return code: 0 18:01: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')]} 18:01:35 INFO - https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:36 INFO - Downloaded 10840194 bytes. 18:01:36 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'] 18:01:36 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 18:01:36 INFO - Return code: 0 18:01:36 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')]} 18:01:36 INFO - https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiiA656fSiGxNVZOsrKubw/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 18:01:37 INFO - Downloaded 54805800 bytes. 18:01:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:01:37 INFO - mkdir: /builds/slave/test/properties 18:01:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:01:37 INFO - Writing to file /builds/slave/test/properties/build_url 18:01:37 INFO - Contents: 18:01:37 INFO - build_url:https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:01:38 INFO - Running post-action listener: _resource_record_post_action 18:01:38 INFO - Running post-action listener: set_extra_try_arguments 18:01:38 INFO - ##### 18:01:38 INFO - ##### Finished download-and-extract step (success) 18:01:38 INFO - ##### 18:01:38 INFO - ##### 18:01:38 INFO - ##### Running populate-webroot step. 18:01:38 INFO - ##### 18:01:38 INFO - Running pre-action listener: _resource_record_pre_action 18:01:38 INFO - Running main action method: populate_webroot 18:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:01:38 INFO - '--tppagecycles', 18:01:38 INFO - '7'], 18:01:38 INFO - 'tests': ['tsvgm']}}, 18:01:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:01:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:01:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:01:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['damp', 'tps']}, 18:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'tests': ['damp', 'tps']}, 18:01:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['dromaeo_dom']}, 18:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:01:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['a11yr', 18:01:38 INFO - 'ts_paint', 18:01:38 INFO - 'tpaint', 18:01:38 INFO - 'sessionrestore', 18:01:38 INFO - 'sessionrestore_no_auto_restore', 18:01:38 INFO - 'tabpaint']}, 18:01:38 INFO - 'other-e10s': {'tests': ['a11yr', 18:01:38 INFO - 'ts_paint', 18:01:38 INFO - 'tpaint', 18:01:38 INFO - 'sessionrestore', 18:01:38 INFO - 'sessionrestore_no_auto_restore', 18:01:38 INFO - 'tabpaint']}, 18:01:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:01:38 INFO - 'ts_paint', 18:01:38 INFO - 'tpaint', 18:01:38 INFO - 'sessionrestore', 18:01:38 INFO - 'sessionrestore_no_auto_restore', 18:01:38 INFO - 'tabpaint']}, 18:01:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:01:38 INFO - 'ts_paint', 18:01:38 INFO - 'tpaint', 18:01:38 INFO - 'sessionrestore', 18:01:38 INFO - 'sessionrestore_no_auto_restore', 18:01:38 INFO - 'tabpaint']}, 18:01:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['a11yr', 18:01:38 INFO - 'ts_paint', 18:01:38 INFO - 'tpaint', 18:01:38 INFO - 'sessionrestore', 18:01:38 INFO - 'sessionrestore_no_auto_restore', 18:01:38 INFO - 'tabpaint']}, 18:01:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['a11yr', 18:01:38 INFO - 'ts_paint', 18:01:38 INFO - 'tpaint', 18:01:38 INFO - 'sessionrestore', 18:01:38 INFO - 'sessionrestore_no_auto_restore', 18:01:38 INFO - 'tabpaint']}, 18:01:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['tsvgx', 18:01:38 INFO - 'tsvgr_opacity', 18:01:38 INFO - 'tart', 18:01:38 INFO - 'tscrollx', 18:01:38 INFO - 'cart']}, 18:01:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:01:38 INFO - 'tsvgr_opacity', 18:01:38 INFO - 'tart', 18:01:38 INFO - 'tscrollx', 18:01:38 INFO - 'cart']}, 18:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'talos_options': ['--disable-e10s'], 18:01:38 INFO - 'tests': ['tp5o']}, 18:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'tests': ['tp5o']}, 18:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'talos_options': ['--disable-e10s', 18:01:38 INFO - '--xperf_path', 18:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:01:38 INFO - 'tests': ['tp5n']}, 18:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:01:38 INFO - 'talos_options': ['--xperf_path', 18:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:01:38 INFO - 'tests': ['tp5n']}}, 18:01:38 INFO - 'talos.zip': {'path': '', 18:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:01:38 INFO - Running post-action listener: _resource_record_post_action 18:01:38 INFO - ##### 18:01:38 INFO - ##### Finished populate-webroot step (success) 18:01:38 INFO - ##### 18:01:38 INFO - ##### 18:01:38 INFO - ##### Running create-virtualenv step. 18:01:38 INFO - ##### 18:01:38 INFO - Running pre-action listener: _resource_record_pre_action 18:01:38 INFO - Running main action method: create_virtualenv 18:01:38 INFO - Creating virtualenv /builds/slave/test/build/venv 18:01:38 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 18:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:01:38 INFO - Using real prefix '/usr' 18:01:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:01:40 INFO - Installing pip.................done. 18:01:40 INFO - Return code: 0 18:01:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:40 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:40 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 18:01:40 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 18:01:40 INFO - Using env: {'DISPLAY': ':0', 18:01:40 INFO - 'HOME': '/home/cltbld', 18:01:40 INFO - 'LANG': 'en_US.UTF-8', 18:01:40 INFO - 'LANGUAGE': 'en_US:en', 18:01:40 INFO - 'LOGNAME': 'cltbld', 18:01:40 INFO - 'MAIL': '/var/mail/cltbld', 18:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:40 INFO - 'MOZ_NO_REMOTE': '1', 18:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:40 INFO - 'NO_EM_RESTART': '1', 18:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:40 INFO - 'PWD': '/builds/slave/test', 18:01:40 INFO - 'SHELL': '/bin/bash', 18:01:40 INFO - 'SHLVL': '1', 18:01:40 INFO - 'TERM': 'linux', 18:01:40 INFO - 'TMOUT': '86400', 18:01:40 INFO - 'USER': 'cltbld', 18:01:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:40 INFO - '_': '/tools/buildbot/bin/python'} 18:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:41 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 18:01:41 INFO - Cleaning up... 18:01:41 INFO - Return code: 0 18:01:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:01:41 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')]} 18:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:41 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')]} 18:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:41 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:41 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 18:01:41 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 18:01:41 INFO - Using env: {'DISPLAY': ':0', 18:01:41 INFO - 'HOME': '/home/cltbld', 18:01:41 INFO - 'LANG': 'en_US.UTF-8', 18:01:41 INFO - 'LANGUAGE': 'en_US:en', 18:01:41 INFO - 'LOGNAME': 'cltbld', 18:01:41 INFO - 'MAIL': '/var/mail/cltbld', 18:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:41 INFO - 'MOZ_NO_REMOTE': '1', 18:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:41 INFO - 'NO_EM_RESTART': '1', 18:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:41 INFO - 'PWD': '/builds/slave/test', 18:01:41 INFO - 'SHELL': '/bin/bash', 18:01:41 INFO - 'SHLVL': '1', 18:01:41 INFO - 'TERM': 'linux', 18:01:41 INFO - 'TMOUT': '86400', 18:01:41 INFO - 'USER': 'cltbld', 18:01:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:41 INFO - '_': '/tools/buildbot/bin/python'} 18:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:41 INFO - Downloading/unpacking psutil>=3.1.1 18:01:41 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 18:01:41 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 18:01:41 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 18:01:41 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 18:01:41 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 18:01:41 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 18:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:01:43 INFO - Installing collected packages: psutil 18:01:43 INFO - Running setup.py install for psutil 18:01:43 INFO - building 'psutil._psutil_linux' extension 18:01:43 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 18:01:43 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 18:01:43 INFO - building 'psutil._psutil_posix' extension 18:01:43 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 18:01:43 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 18:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:01:43 INFO - Successfully installed psutil 18:01:43 INFO - Cleaning up... 18:01:43 INFO - Return code: 0 18:01:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:01:43 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')]} 18:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:43 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')]} 18:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:43 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:43 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 18:01:43 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 18:01:43 INFO - Using env: {'DISPLAY': ':0', 18:01:43 INFO - 'HOME': '/home/cltbld', 18:01:43 INFO - 'LANG': 'en_US.UTF-8', 18:01:43 INFO - 'LANGUAGE': 'en_US:en', 18:01:43 INFO - 'LOGNAME': 'cltbld', 18:01:43 INFO - 'MAIL': '/var/mail/cltbld', 18:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:43 INFO - 'MOZ_NO_REMOTE': '1', 18:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:43 INFO - 'NO_EM_RESTART': '1', 18:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:43 INFO - 'PWD': '/builds/slave/test', 18:01:43 INFO - 'SHELL': '/bin/bash', 18:01:43 INFO - 'SHLVL': '1', 18:01:43 INFO - 'TERM': 'linux', 18:01:43 INFO - 'TMOUT': '86400', 18:01:43 INFO - 'USER': 'cltbld', 18:01:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:43 INFO - '_': '/tools/buildbot/bin/python'} 18:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:01:44 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 18:01:44 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 18:01:44 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 18:01:44 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 18:01:44 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 18:01:44 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 18:01:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:01:46 INFO - Installing collected packages: mozsystemmonitor 18:01:46 INFO - Running setup.py install for mozsystemmonitor 18:01:46 INFO - Successfully installed mozsystemmonitor 18:01:46 INFO - Cleaning up... 18:01:46 INFO - Return code: 0 18:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:01: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')]} 18:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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')]} 18:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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', '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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:01: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 blobuploader==1.2.4 18:01:46 INFO - Using env: {'DISPLAY': ':0', 18:01:46 INFO - 'HOME': '/home/cltbld', 18:01:46 INFO - 'LANG': 'en_US.UTF-8', 18:01:46 INFO - 'LANGUAGE': 'en_US:en', 18:01:46 INFO - 'LOGNAME': 'cltbld', 18:01:46 INFO - 'MAIL': '/var/mail/cltbld', 18:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:46 INFO - 'MOZ_NO_REMOTE': '1', 18:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:46 INFO - 'NO_EM_RESTART': '1', 18:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:46 INFO - 'PWD': '/builds/slave/test', 18:01:46 INFO - 'SHELL': '/bin/bash', 18:01:46 INFO - 'SHLVL': '1', 18:01:46 INFO - 'TERM': 'linux', 18:01:46 INFO - 'TMOUT': '86400', 18:01:46 INFO - 'USER': 'cltbld', 18:01:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:46 INFO - '_': '/tools/buildbot/bin/python'} 18:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:01:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:49 INFO - Downloading docopt-0.6.1.tar.gz 18:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:01:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:01:49 INFO - Running setup.py install for blobuploader 18:01:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:01:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:01:49 INFO - Running setup.py install for requests 18:01:49 INFO - Running setup.py install for docopt 18:01:49 INFO - Successfully installed blobuploader requests docopt 18:01:49 INFO - Cleaning up... 18:01:49 INFO - Return code: 0 18:01:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:49 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:49 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 18:01:49 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 18:01:49 INFO - Using env: {'DISPLAY': ':0', 18:01:49 INFO - 'HOME': '/home/cltbld', 18:01:49 INFO - 'LANG': 'en_US.UTF-8', 18:01:49 INFO - 'LANGUAGE': 'en_US:en', 18:01:49 INFO - 'LOGNAME': 'cltbld', 18:01:49 INFO - 'MAIL': '/var/mail/cltbld', 18:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:49 INFO - 'MOZ_NO_REMOTE': '1', 18:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:49 INFO - 'NO_EM_RESTART': '1', 18:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:49 INFO - 'PWD': '/builds/slave/test', 18:01:49 INFO - 'SHELL': '/bin/bash', 18:01:49 INFO - 'SHLVL': '1', 18:01:49 INFO - 'TERM': 'linux', 18:01:49 INFO - 'TMOUT': '86400', 18:01:49 INFO - 'USER': 'cltbld', 18:01:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:49 INFO - '_': '/tools/buildbot/bin/python'} 18:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:49 INFO - Running setup.py (path:/tmp/pip-CcQ0DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:50 INFO - Running setup.py (path:/tmp/pip-eZ_o4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:50 INFO - Running setup.py (path:/tmp/pip-CDkcya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:50 INFO - Running setup.py (path:/tmp/pip-hF6oag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:50 INFO - Running setup.py (path:/tmp/pip-1mSxu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:50 INFO - Running setup.py (path:/tmp/pip-dRJqMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:50 INFO - Running setup.py (path:/tmp/pip-b1h5on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:50 INFO - Running setup.py (path:/tmp/pip-X28Izh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:50 INFO - Running setup.py (path:/tmp/pip-MSJuSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:50 INFO - Running setup.py (path:/tmp/pip-fSbiv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:50 INFO - Running setup.py (path:/tmp/pip-gU19ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:50 INFO - Running setup.py (path:/tmp/pip-KPzwPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:50 INFO - Running setup.py (path:/tmp/pip-jbLyAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:50 INFO - Running setup.py (path:/tmp/pip-2OFEo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:50 INFO - Running setup.py (path:/tmp/pip-1gPhDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:51 INFO - Running setup.py (path:/tmp/pip-zGcnQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:51 INFO - Running setup.py (path:/tmp/pip-FCuw8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:01:51 INFO - Running setup.py install for manifestparser 18:01:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Running setup.py install for mozcrash 18:01:51 INFO - Running setup.py install for mozdebug 18:01:51 INFO - Running setup.py install for mozdevice 18:01:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Running setup.py install for mozfile 18:01:51 INFO - Running setup.py install for mozhttpd 18:01:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Running setup.py install for mozinfo 18:01:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Running setup.py install for mozInstall 18:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:01:51 INFO - Running setup.py install for mozleak 18:01:52 INFO - Running setup.py install for mozlog 18:01:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Running setup.py install for moznetwork 18:01:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Running setup.py install for mozprocess 18:01:52 INFO - Running setup.py install for mozprofile 18:01:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Running setup.py install for mozrunner 18:01:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Running setup.py install for mozscreenshot 18:01:52 INFO - Running setup.py install for moztest 18:01:52 INFO - Running setup.py install for mozversion 18:01:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:01:52 INFO - Cleaning up... 18:01:52 INFO - Return code: 0 18:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:52 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:52 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 18:01:52 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 18:01:52 INFO - Using env: {'DISPLAY': ':0', 18:01:52 INFO - 'HOME': '/home/cltbld', 18:01:52 INFO - 'LANG': 'en_US.UTF-8', 18:01:52 INFO - 'LANGUAGE': 'en_US:en', 18:01:52 INFO - 'LOGNAME': 'cltbld', 18:01:52 INFO - 'MAIL': '/var/mail/cltbld', 18:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:52 INFO - 'MOZ_NO_REMOTE': '1', 18:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:52 INFO - 'NO_EM_RESTART': '1', 18:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:52 INFO - 'PWD': '/builds/slave/test', 18:01:52 INFO - 'SHELL': '/bin/bash', 18:01:52 INFO - 'SHLVL': '1', 18:01:52 INFO - 'TERM': 'linux', 18:01:52 INFO - 'TMOUT': '86400', 18:01:52 INFO - 'USER': 'cltbld', 18:01:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:52 INFO - '_': '/tools/buildbot/bin/python'} 18:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:53 INFO - Running setup.py (path:/tmp/pip-YnpjCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:53 INFO - Running setup.py (path:/tmp/pip-gzlncZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:53 INFO - Running setup.py (path:/tmp/pip-LyI4Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:53 INFO - Running setup.py (path:/tmp/pip-imw6P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:53 INFO - Running setup.py (path:/tmp/pip-fr3_FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:53 INFO - Running setup.py (path:/tmp/pip-HQUy7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:53 INFO - Running setup.py (path:/tmp/pip-Rq4cV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:53 INFO - Running setup.py (path:/tmp/pip-HsM1E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:53 INFO - Running setup.py (path:/tmp/pip-d6daoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:53 INFO - Running setup.py (path:/tmp/pip-Y7PdUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:53 INFO - Running setup.py (path:/tmp/pip-LIkuqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:53 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)) 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:53 INFO - Running setup.py (path:/tmp/pip-ZEuA8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:54 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)) 18:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:54 INFO - Running setup.py (path:/tmp/pip-a0zjKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:54 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)) 18:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:54 INFO - Running setup.py (path:/tmp/pip-X_RsA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:54 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)) 18:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:54 INFO - Running setup.py (path:/tmp/pip-Lc4jvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:54 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)) 18:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:54 INFO - Running setup.py (path:/tmp/pip-hXf74R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:54 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)) 18:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:54 INFO - Running setup.py (path:/tmp/pip-FvFaXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:54 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)) 18:01:54 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)) 18:01:54 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)) 18:01:54 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)) 18:01:54 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)) 18:01:54 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)) 18:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:56 INFO - Downloading blessings-1.6.tar.gz 18:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:01:56 INFO - Installing collected packages: blessings 18:01:56 INFO - Running setup.py install for blessings 18:01:56 INFO - Successfully installed blessings 18:01:56 INFO - Cleaning up... 18:01:56 INFO - Return code: 0 18:01:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:56 INFO - Reading from file tmpfile_stdout 18:01:56 INFO - Current package versions: 18:01:56 INFO - argparse == 1.2.1 18:01:56 INFO - blessings == 1.6 18:01:56 INFO - blobuploader == 1.2.4 18:01:56 INFO - docopt == 0.6.1 18:01:56 INFO - manifestparser == 1.1 18:01:56 INFO - mozInstall == 1.12 18:01:56 INFO - mozcrash == 0.17 18:01:56 INFO - mozdebug == 0.1 18:01:56 INFO - mozdevice == 0.48 18:01:56 INFO - mozfile == 1.2 18:01:56 INFO - mozhttpd == 0.7 18:01:56 INFO - mozinfo == 0.9 18:01:56 INFO - mozleak == 0.1 18:01:56 INFO - mozlog == 3.2 18:01:56 INFO - moznetwork == 0.27 18:01:56 INFO - mozprocess == 0.22 18:01:56 INFO - mozprofile == 0.28 18:01:56 INFO - mozrunner == 6.11 18:01:56 INFO - mozscreenshot == 0.1 18:01:56 INFO - mozsystemmonitor == 0.3 18:01:56 INFO - moztest == 0.7 18:01:56 INFO - mozversion == 1.4 18:01:56 INFO - psutil == 3.1.1 18:01:56 INFO - requests == 1.2.3 18:01:56 INFO - wsgiref == 0.1.2 18:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:56 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')]} 18:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:56 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')]} 18:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:56 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:56 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 18:01:56 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 18:01:56 INFO - Using env: {'DISPLAY': ':0', 18:01:56 INFO - 'HOME': '/home/cltbld', 18:01:56 INFO - 'LANG': 'en_US.UTF-8', 18:01:56 INFO - 'LANGUAGE': 'en_US:en', 18:01:56 INFO - 'LOGNAME': 'cltbld', 18:01:56 INFO - 'MAIL': '/var/mail/cltbld', 18:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:56 INFO - 'MOZ_NO_REMOTE': '1', 18:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:56 INFO - 'NO_EM_RESTART': '1', 18:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:56 INFO - 'PWD': '/builds/slave/test', 18:01:56 INFO - 'SHELL': '/bin/bash', 18:01:56 INFO - 'SHLVL': '1', 18:01:56 INFO - 'TERM': 'linux', 18:01:56 INFO - 'TMOUT': '86400', 18:01:56 INFO - 'USER': 'cltbld', 18:01:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:56 INFO - '_': '/tools/buildbot/bin/python'} 18:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 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)) 18:01:56 INFO - Cleaning up... 18:01:57 INFO - Return code: 0 18:01:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:01:57 INFO - Using env: {'DISPLAY': ':0', 18:01:57 INFO - 'HOME': '/home/cltbld', 18:01:57 INFO - 'LANG': 'en_US.UTF-8', 18:01:57 INFO - 'LANGUAGE': 'en_US:en', 18:01:57 INFO - 'LOGNAME': 'cltbld', 18:01:57 INFO - 'MAIL': '/var/mail/cltbld', 18:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:57 INFO - 'MOZ_NO_REMOTE': '1', 18:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:57 INFO - 'NO_EM_RESTART': '1', 18:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:57 INFO - 'PWD': '/builds/slave/test', 18:01:57 INFO - 'SHELL': '/bin/bash', 18:01:57 INFO - 'SHLVL': '1', 18:01:57 INFO - 'TERM': 'linux', 18:01:57 INFO - 'TMOUT': '86400', 18:01:57 INFO - 'USER': 'cltbld', 18:01:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:57 INFO - '_': '/tools/buildbot/bin/python'} 18:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:57 INFO - Downloading/unpacking jsonschema 18:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:01:59 INFO - Downloading/unpacking functools32 (from jsonschema) 18:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:59 INFO - Downloading functools32-3.2.3-2.tar.gz 18:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:01:59 INFO - warning: no files found matching '*.txt' 18:01:59 INFO - no previously-included directories found matching 'build' 18:01:59 INFO - no previously-included directories found matching 'dist' 18:01:59 INFO - no previously-included directories found matching '.git*' 18:01:59 INFO - Installing collected packages: jsonschema, functools32 18:01:59 INFO - Running setup.py install for functools32 18:01:59 INFO - warning: no files found matching '*.txt' 18:01:59 INFO - no previously-included directories found matching 'build' 18:01:59 INFO - no previously-included directories found matching 'dist' 18:01:59 INFO - no previously-included directories found matching '.git*' 18:01:59 INFO - Successfully installed jsonschema functools32 18:01:59 INFO - Cleaning up... 18:01:59 INFO - Return code: 0 18:01:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:01:59 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')]} 18:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:59 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')]} 18:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:59 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 0x7f5e8d658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, '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': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', '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 18:01:59 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 18:01:59 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 18:01:59 INFO - Using env: {'DISPLAY': ':0', 18:01:59 INFO - 'HOME': '/home/cltbld', 18:01:59 INFO - 'LANG': 'en_US.UTF-8', 18:01:59 INFO - 'LANGUAGE': 'en_US:en', 18:01:59 INFO - 'LOGNAME': 'cltbld', 18:01:59 INFO - 'MAIL': '/var/mail/cltbld', 18:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:59 INFO - 'MOZ_NO_REMOTE': '1', 18:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:59 INFO - 'NO_EM_RESTART': '1', 18:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:59 INFO - 'PWD': '/builds/slave/test', 18:01:59 INFO - 'SHELL': '/bin/bash', 18:01:59 INFO - 'SHLVL': '1', 18:01:59 INFO - 'TERM': 'linux', 18:01:59 INFO - 'TMOUT': '86400', 18:01:59 INFO - 'USER': 'cltbld', 18:01:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:59 INFO - '_': '/tools/buildbot/bin/python'} 18:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:59 INFO - Downloading/unpacking flake8 18:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:02:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:02:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:02:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 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 18:02:01 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 18:02:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:02:02 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 18:02:02 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 18:02:02 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 18:02:02 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 18:02:02 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 18:02:02 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 18:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:02:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:02:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:02:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:02:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:02:02 INFO - no previously-included directories found matching 'docs/_build' 18:02:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:02:02 INFO - Running setup.py install for pep8 18:02:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:02:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:02:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:02:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:02:02 INFO - no previously-included directories found matching 'docs/_build' 18:02:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:02:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:02:02 INFO - Cleaning up... 18:02:02 INFO - Return code: 0 18:02:02 INFO - Running post-action listener: _resource_record_post_action 18:02:02 INFO - Running post-action listener: _start_resource_monitoring 18:02:02 INFO - Starting resource monitoring. 18:02:02 INFO - ##### 18:02:02 INFO - ##### Finished create-virtualenv step (success) 18:02:02 INFO - ##### 18:02:02 INFO - ##### 18:02:02 INFO - ##### Running install step. 18:02:02 INFO - ##### 18:02:02 INFO - Running pre-action listener: _resource_record_pre_action 18:02:02 INFO - Running main action method: install 18:02:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:02:02 INFO - Reading from file tmpfile_stdout 18:02:02 INFO - Detecting whether we're running mozinstall >=1.0... 18:02:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:02:02 INFO - Reading from file tmpfile_stdout 18:02:02 INFO - Output received: 18:02:02 INFO - Usage: mozinstall [options] installer 18:02:02 INFO - Options: 18:02:02 INFO - -h, --help show this help message and exit 18:02:02 INFO - -d DEST, --destination=DEST 18:02:02 INFO - Directory to install application into. [default: 18:02:02 INFO - "/builds/slave/test"] 18:02:02 INFO - --app=APP Application being installed. [default: firefox] 18:02:02 INFO - mkdir: /builds/slave/test/build/application 18:02:02 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'] 18:02:02 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 18:02:18 INFO - Reading from file tmpfile_stdout 18:02:18 INFO - Output received: 18:02:18 INFO - /builds/slave/test/build/application/firefox/firefox 18:02:18 INFO - Running post-action listener: _resource_record_post_action 18:02:18 INFO - ##### 18:02:18 INFO - ##### Finished install step (success) 18:02:18 INFO - ##### 18:02:18 INFO - ##### 18:02:18 INFO - ##### Running run-tests step. 18:02:18 INFO - ##### 18:02:18 INFO - Running pre-action listener: _resource_record_pre_action 18:02:18 INFO - Running main action method: run_tests 18:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:02:18 INFO - Python 2.7.3 18:02:18 INFO - Return code: 0 18:02:18 INFO - grabbing minidump binary from tooltool 18:02:18 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')]} 18:02:18 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 0x28889c0>, '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 0x28898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2889d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:02:18 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 18:02:18 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 18:02:18 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 18:02:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:02:18 INFO - Return code: 0 18:02:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:02:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:02:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:02:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:02:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:02:19 INFO - Return code: 0 18:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:02:19 INFO - Using env: {'DISPLAY': ':0', 18:02:19 INFO - 'HOME': '/home/cltbld', 18:02:19 INFO - 'LANG': 'en_US.UTF-8', 18:02:19 INFO - 'LANGUAGE': 'en_US:en', 18:02:19 INFO - 'LOGNAME': 'cltbld', 18:02:19 INFO - 'MAIL': '/var/mail/cltbld', 18:02:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:02:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:19 INFO - 'MOZ_NO_REMOTE': '1', 18:02:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:19 INFO - 'NO_EM_RESTART': '1', 18:02:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:19 INFO - 'PWD': '/builds/slave/test', 18:02:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:02:19 INFO - 'SHELL': '/bin/bash', 18:02:19 INFO - 'SHLVL': '1', 18:02:19 INFO - 'TERM': 'linux', 18:02:19 INFO - 'TMOUT': '86400', 18:02:19 INFO - 'USER': 'cltbld', 18:02:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463618524.165518-826718291', 18:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:19 INFO - '_': '/tools/buildbot/bin/python'} 18:02:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:02:19 INFO - mozversion application_buildid: 20160518172746 18:02:19 INFO - mozversion application_changeset: e0fa395e4982a5225e73908a4a0816932043440d 18:02:19 INFO - mozversion application_display_name: Nightly 18:02:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:02:19 INFO - mozversion application_name: Firefox 18:02:19 INFO - mozversion application_remotingname: firefox 18:02:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:02:19 INFO - mozversion application_vendor: Mozilla 18:02:19 INFO - mozversion application_version: 49.0a1 18:02:19 INFO - mozversion platform_buildid: 20160518172746 18:02:19 INFO - mozversion platform_changeset: e0fa395e4982a5225e73908a4a0816932043440d 18:02:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:02:19 INFO - mozversion platform_version: 49.0a1 18:02:19 INFO - using testdate: 1463619739 18:02:19 INFO - actual date: 1463619739 18:02:19 INFO - starting webserver on 'localhost:48288' 18:02:19 INFO - SUITE-START | Running 2 tests 18:02:19 INFO - TEST-START | dromaeo_css 18:02:19 INFO - operating with platform_type : linux_ 18:02:19 INFO - Initialising browser for dromaeo_css test... 18:02:19 INFO - TEST-INFO | started process 5279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnSQpaC/profile http://localhost:48288/getInfo.html) 18:02:23 INFO - PROCESS | 5279 | 18:02:23 INFO - PROCESS | 5279 | (process:5345): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:02:24 INFO - PROCESS | 5279 | __metrics Screen width/height:1600/1200 18:02:24 INFO - PROCESS | 5279 | colorDepth:24 18:02:24 INFO - PROCESS | 5279 | Browser inner width/height: 1024/697 18:02:24 INFO - PROCESS | 5279 | __metrics 18:02:25 ERROR - PROCESS | 5279 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 18:02:26 INFO - TEST-INFO | 5279: exit 0 18:02:26 INFO - Browser initialized. 18:02:26 INFO - Running cycle 1/1 for dromaeo_css test... 18:02:26 INFO - TEST-INFO | started process 5396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnSQpaC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:28 INFO - PROCESS | 5396 | 18:02:28 INFO - PROCESS | 5396 | (process:5455): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:02:38 INFO - PROCESS | 5396 | RSS: Main: 164835328 18:02:38 INFO - PROCESS | 5396 | 18:03:28 INFO - PROCESS | 5396 | 1463619808119 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] 18:05:39 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:48288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48288/tests/dromaeo/cssquery-ext.html) 18:05:40 INFO - PROCESS | 5396 | RSS: Main: 167587840 18:05:40 INFO - PROCESS | 5396 | 18:08:42 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:48288/tests/dromaeo/cssquery-ext.html (next: http://localhost:48288/tests/dromaeo/cssquery-jquery.html) 18:08:43 INFO - PROCESS | 5396 | RSS: Main: 167178240 18:08:43 INFO - PROCESS | 5396 | 18:11:45 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:48288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48288/tests/dromaeo/cssquery-mootools.html) 18:11:45 INFO - PROCESS | 5396 | RSS: Main: 168554496 18:11:45 INFO - PROCESS | 5396 | 18:14:47 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:48288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48288/tests/dromaeo/cssquery-prototype.html) 18:14:48 INFO - PROCESS | 5396 | RSS: Main: 166715392 18:14:48 INFO - PROCESS | 5396 | 18:17:51 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:48288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48288/tests/dromaeo/cssquery-yui.html) 18:17:51 INFO - PROCESS | 5396 | RSS: Main: 167518208 18:17:51 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | Cycle 1(1): loaded http://localhost:48288/tests/dromaeo/cssquery-yui.html (next: http://localhost:48288/tests/dromaeo/cssquery-dojo.html) 18:20:54 INFO - PROCESS | 5396 | RSS: Main: 169156608 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | __start_tp_report 18:20:54 INFO - PROCESS | 5396 | _x_x_mozilla_page_load 18:20:54 INFO - PROCESS | 5396 | _x_x_mozilla_page_load_details 18:20:54 INFO - PROCESS | 5396 | |i|pagename|runs| 18:20:54 INFO - PROCESS | 5396 | |0;dojo.html;2676.7323267673237;2707.783377329814;2719.2657982344754;2722.9863850680745;2737.3019879930625;4692.741899195543;4698.64760142989;4727.929081063787;4818.566329030386;4876.512348765122;4697.271922851964;4721.693089949151;4726.503717109697;4739.763011849403;4818.494058123891;4356.0198955235055;4398.714083584573;4474.082813023322;4474.194644963905;4508.5491450854815;4178.623923846853;4451.755153466558;4464.553544645542;4534.659900507459;4546.795394207269;4325.178216138924;4326.134773045404;4377.474703035656;4405.867823965286;4455.46534415869;4383.473983122014;4389.626881715058;4446.57757513039;4449.7330160190495;4462.085272519126;4408.426904502427;4410.184115938529;4423.955760442386;4461.754603496806;4473.038296766211;4643.8374656886845;4725.267583524559;4744.881377965544;4757.738324392157;4769.332293478916;5157.8452646420665;5163.948360516384;5178.430372659004;5182.611304152204;5239.187925871496;5061.924071138936;5146.176611742141;5206.609504287194;5207.4792520748;5216.2958000669805;4854.101991131652;4858.902821943612;4882.2432522959;4892.412910450768;4930.77811498487;5353.785848566014;5365.597580181424;5366.463353664681;5374.462553744673;5421.484958928895;4945.975270123627;5011.123053465629;5048.899022019539;5136.1525348317855;5143.537081662668;5048.848534543969;5148.56237219833;5150.48495150482;5152.0726269271145;5190.55880250183;5042.117629414838;5066.873328166826;5112.6421150519855;5130.538251557377;5148.742562871917;4962.8759281018265;4969.254611808257;5079.847604571869;5090.541851233407;5141.408737995103;4279.507856596469;4285.849995250152;4295.8496452624;4315.3095504719095;4330.025744207528;3753.3431649461236;3770.6606405423645;3777.8111094445167;3793.279276937373;3801.3157631626573;4437.0460351024685;4473.4408198975125;4488.753118578509;4536.8638940831825;4551.112533056088;5130.87172820675;5142.897142057138;5182.974085129626;5203.843884683465;5238.423773384925;4494.4606647202545;4513.390692256503;4526.79629416677;4543.636509079266;4566;4534.909301813946;4601.907961840811;4636.5131661175765;4667.439907211088;4672.322513235562;4902.828401005948;4911.852644420673;4912.410510738591;4916.459189489225;4970.900581988412;5078.21287700407;5227.895442091213;5228.3987341454695;5243.449437808975;5278.313819203479;4802.327674125555;4839.903201936012;4846.684965477232;4847.757612119451;4848.515148485264;5057.140286151437;5075.87310317245;5080.898382032265;5087.186050231945;5118.3090282811345;4989.25161225819;5067.746612669278;5126.53861152498;5137.537621614073;5138.717370544656;4828.806847726051;4921.63087768426;4942.5304596063315;5005.349304590525;5051.696898186121;5010.298558201927;5013.2981382607195;5015.247712842956;5024.824131155392;5066.113430149635;4837.830675926326;4916.434610019751;4940.456549779449;4942.703437793743;4972;5003.524665156804;5016.297718319511;5051.1160546904875;5057.064443078042;5060.84817455477;4914.115459217375;4952.356193694796;4965.0318187953;4968.056069346812;5009.699418034929 18:20:54 INFO - PROCESS | 5396 | |1;ext.html;565.1268789719883;590.6898878089;597.880423915217;611.0864257934386;617.2592888533759;40268.1946361073;41326.793366033125;41365.58634413655;41643.79178104113;45294.32058519116;42981.35527967083;43813.34279985803;43836.34245486312;43872;43914.56085439145;7878.172791856859;7928.9603551982445;8035.316998055172;8044.6782128714785;8047.718329858456;7991.600419979007;8041.597920104001;8096.352291816641;8105.432619716622;8111.513309201438;8129.430939834214;8148.959255203716;8150.184981501832;8176.059753128407;8197.05733840607;8049.798755031113;8107.148749381289;8118.512889226666;8135.186481351877;8135.511869287861;7939.483933544301;8009.038915330198;8033.598320084031;8037;8084.636191371403;39920.80039599812;40189;40191.397129043085;40200.39699404511;40242.79878600618;2963.866626001835;2987.7543732609715;3049.7560195184333;3087.768417368684;3304.2235074757414;29877.40245195084;30422;30563.541546876815;30845;31291.843540782378;3423.3495635829113;3433.725301975836;3467.8959631211105;3481.619012253992;3516.542849429558;278220;279427;279903;281186;282396;51362;57581.424185757605;57741;57879;58262;34948.65051349505;35725.64274357275;61766.38233617696;62393;62635;15499.690006199813;15532.611684707746;15565;15658;15685.686286274438;11899.286042837457;11911.344876031728;11941.462634181482;12005.219660722025;12019.87980120205;19769.209231630863;19775;19890.204391824165;19955.800441995394;20012.799872001386;7161.319674630901;7254.202037775841;7270;7417.703291868373;7447.5531468111;842.9030661474009;935.209747763139;948.2887834124407;980.4362491567377;1042.6976176908763;29240;29435.411291774046;29464.852675736915;29823.701762982528;29923.850380748394;915.6154415145655;1042.9530671119817;1056.144522936424;1063.2875973098044;1125.1111621818673;14703.41186352534;14885.70228595422;15144.697106057818;15389.230538473255;15423.383064677511;398714;399668;400644;401991;403797;51292.48707512952;51379.22931156035;51658.48341516537;51867.48132518702;51978;1251.5306759965013;1280.6926337679076;1288.8002359634272;1315.2174456198547;1315.3226088564397;26801.329966750207;28004.85997569999;28014.719852801212;28047.71952280451;28545.857270713514;43765;44132.33801492916;44231.33652995143;44427.77786111049;44501.777491112334;356426;359498.81002380326;360016;361129;361509;26237.34406639773;26487.07295244657;26755.598666019636;26818.865905670347;27219.31951701144;44450.77774611106;44660.33009504925;45344.31983520316;45429;45703.77148114238;38082.2383552333;38097.23805523929;38183;38415.807920960215;38505.807470963584;37338.81330593438;37486.812565937;37713;37734.62265377311;38068.42897356597;32621.673783261864;36892.446613300286;37058.629413705516;38005.23989520139;38215;29506.409871802873;33800.66199337975;33883.3223335527;33963;34194.82902585471;26164.60753088743;26370.20889373322;26498.735012649628;26545.203643890713;26717.732822671525 18:20:54 INFO - PROCESS | 5396 | |2;jquery.html;376.64595280436373;380.89525380520354;388.39022734307133;394.2391185012924;402.19360182833435;15411.768823467657;16392.75410868838;17072.743908841363;17129.229184686686;17140.82859171408;16130.435434759785;16741.665166696657;17083.231254593542;17366.913165434155;17428.3028678853;5112.821051263198;5240.895182096356;5270.49930256625;5299.5230429261355;5304.257403963448;3678.5401824771902;5715.2855893013375;5973.432523910222;5980.31226408962;6106;4961.702297862122;6069.059295809135;6073.51411887048;6078.331383547807;6085.330613632497;5165.457626949173;5260.079486089919;5272.866333738265;5282.445343238962;5296.735163241842;4960;5247.291615631879;5267.868303292448;5271.841844744664;5277.973610131925;11809.23239989398;12095.697607559794;12127.39363031845;14992.550223493312;20049.398518044483;1949.1618604000273;1965.665836807732;2038.3986723916332;2043.4176259765895;2050.487378155461;9272.258219342504;9675.419474831462;10097.394156350643;12131.73999420969;13138.014648901275;1805.8013618501955;1860.4697661166504;1862.962740745191;1963.2441510018602;1991.4025792262264;70323;72831.63584182045;72880.99999999948;73084;73166;10086.697399078039;10167.135793457492;10255.7436064099;10260.486975651187;10276.280660353854;14037.71924561503;14046.735793778405;14101.576952691436;14148.434062637585;14191.290435478184;7071.646417679199;7377.852442951111;7405.481616286808;7476.3271305581675;7544.471886967969;6913.3777959983845;6957.130358705162;7132.643367831588;7163.283671632795;7164.856702866018;4318.827246910088;4365.716228445141;4473.329000649928;4508.571685689854;4524.072565124142;1651.7852679151633;1697.3210715713567;1775.7336399540172;1866.449397427762;1899.2497963304418;869.2003356911656;912.3567884641312;957.7844984878346;965.1988849255101;969.9960540840196;16296.940698854536;16390.098544580163;16746;16776.496705098867;16899.408520701716;883.4875772052194;899.0919171636695;938.3853575907791;939.7039932421266;954.2270760683869;9188.95405522968;9341.953290233505;9519.666811661558;9523.476208808583;9564.04359564052;364739;380416;382148;382685;385345;73469;74578;75228;75503.62248188833;76674.61662691651;964.2189826240767;970.2674480767117;974.1914211204684;983.5131609853169;985.6303886042734;14836.925815370854;14852.554423367315;14901.776473353126;15157.32119869478;15190.924045379703;34179;34855.82572087225;34891.4766278501;35702.642973569935;35971.82014089913;44758.55241447544;46994.53005469902;48701.512984869696;48987;49042.75478622584;7247.311505406978;7362.815929601803;7476.700931962878;7780.727674531364;7820.061592608923;9747.3664211826;11315.717107072389;11475.655730328104;11785.351805650429;11895.464704088165;9899;10036.849447258151;10204.285700001226;10261.486925653837;10490.05589496949;9811.754706132404;10073.748156296151;10096.141827944706;10312.432816195182;10315.896841031494;10096.495175241062;10117.898821011695;10286.485675716334;10602.522886469973;10645.680629581126;6746.8650626988165;7175.605341706257;7417.740379086706;7526.172121066787;7769.572673503011;10367.274290799873;10433.686989390331;10570.894291057299;10617.575296988343;10786.730331741455 18:20:54 INFO - PROCESS | 5396 | |3;mootools.html;1448.6668066344741;1503.5339044896084;1658.3781082094208;1808.9095545222751;1813.8186181381864;6945;7724.922750772497;7826.5695386753705;8176.427650064498;8203.548804815733;7911.129775724666;8053.838923221532;8067.556284404355;8166.754997350089;8178.263956243937;2267.0931627349028;2320.153144102399;2322.8606283622953;2324.7094113235844;2330.33585428153;2245;2284.680144779732;2286.199830059474;2296.2881506732965;2296.873671948042;2276.9658455123185;2289.599320118981;2293.415179129328;2295.357299956015;2296.2307626944994;2227.409736419842;2245.3376254004943;2274.351809734226;2276.6698828669914;2282.2240438251074;2227.042371780134;2247.4830788918475;2253.4141123307895;2274.056266649355;2274.8976296066553;8027.438079334449;8067.556284404355;8072.636731347104;8080.070791858952;8080.797980050487;4557.817687292504;4617.746023968681;4714.504976977437;4722.126406614787;4730.101280756645;2950.734433900938;3069.6009518762417;3115.79747316426;3127.1400364899605;3153.984230078835;967.6758285974137;974.2303580171656;984.0651381187901;1000.2548101664233;1004.9899501004969;10832.512536935857;10928.836067458995;10980.890191098066;11083.72290692731;11093.889061109367;4257.850975215914;4336.089421221515;4365.2797288447055;4385.846495372647;4394.604485596312;8758.2993360531;8779.29765618749;8789.780255493664;8790.824183516293;8811.20699137068;4691.7888695008805;4761.6904901181315;4763.73799441034;4766;4778.283257511401;3685.207680348738;4280.07978284664;4391.824327026947;4425.114977004612;4428.269335559661;3594.155373487228;3611.2416392557334;3718.8698395556025;3732.4774531565604;3765.002274397287;1093.6718984304837;1094.3215206571977;1134.5802053240354;1140.6007897235902;1146.4668928947913;901.2159421303508;912.4069354919355;924.4129977464224;927.7912469694264;942.0344147248987;5489.890202195934;5627.268455100811;5662.065759149777;5757.5030492072365;5876.44173803488;930.223263574909;943.306669597845;957.2820384711466;958.2334132693957;982.5529384130203;3705.7035437164964;3801.4297855321925;4111.97944010284;4151.647109995684;4172.102997855475;9819.950900245596;10099.293049486465;10114.696559103239;10200.23498237635;10207.438590877573;10067.69796906094;10145.94927025375;10167.847482287623;10200.540975656113;10206.081452669147;7584.4311676624475;7733.41999350051;7752.186020467882;7755.72854950074;7771.339436147878;5506.146547285177;5600.915986260128;5621.8594535136945;5642.407547207484;5717.628354157133;9290.814183716422;9378.859317110386;9441.575129119068;9451.243900487807;9490.620375184915;9356.4386136832;9445.716628501155;9581.664641737505;9607.90392096098;9697.078777516124;5924.437178468039;6478.352164783672;6498.350164983463;6637.933620663925;6690.431313338421;7836.216378362118;7861.410394220342;7865.646045927832;7883.84232315339;7970.4819186752675;6786.321367863372;7026.262242464672;7049.365557099885;7071.646417679199;7139;6983.057287266154;7097.574145551283;7159.642017899188;7200.459965502713;7218.3503484686635;5995.760169593167;6182.381761823782;6234.127222188988;6342.080398342307;6425.036244563166;4575.702579332333;4693.483716791082;4780.139574876555;4900.093482705711;5011.373578302712;4927.260910863399;4982.078315511642;5021.44764075944;5021.623378246573;5055.064813009605 18:20:54 INFO - PROCESS | 5396 | |4;prototype.html;308.8023664854492;312.546807129662;316.14009893090787;328.31054784951607;332.1712327742283;4926.605871530269;5023.271625614293;5049.091163590552;5145.922811157836;5157.277981082647;4837.758112094399;4929.4824043475455;4968.2547617857335;4969.453360130383;4981.203007518798;3914.8042597870135;3930.113545498148;3931.2727145478034;3958.1885713428824;3963.0290578808163;3645.5989841117457;3947.664448521879;3951.6245956634075;3952.861649842256;3955.9802200988956;3800.847966081353;3814;3822.3502004659135;3824.2351529694033;3827.4832897558754;3809.2191100824266;3810.0093975566274;3831.482749828793;3834.8082595870096;3839.3281175794123;3345.7992520448606;3370.3090866372336;3371.106656735967;3372.4098282800655;3372.7470439716876;4650.7442090685;4805.711657300573;4807.134715751164;4811.061842940593;4853.975730121362;4331.631811296043;4365.650747940157;4394.143142087294;4399.450068741407;4405.779711014468;5223.503767142153;5227.151202594595;5233.398159211702;5259.947400525984;5267.604929630293;3597.7661452005536;3669.9633003669887;3687.557493100818;3697.4268988306853;3704.370257056307;5454.972725136388;5464.4262352452815;5476.288082549283;5506.356948664664;5530.419305972895;3808.9809550952623;3822.0827001519433;3838.808059597009;3857.8263978121054;3859.459675645412;3863.7102217333813;3881.243157584244;3882.514685664292;3894.3768996960353;3917.5886531914307;4255.1915136124035;4400.867973960786;4415.933760993587;4425.424694789656;4453.55464453552;5230.973845130826;5231.3199284092825;5233.764480598382;5235.659682120726;5273.945210957747;1257.1577043380958;1299.9025073119553;1340.5856821053687;1341.8322709661293;1347.4946894914408;812.29736278119;842.5281842168405;845.2519520224646;848.7396216618317;850.4387104510993;4176.895577610584;4193.916121677549;4202.327627579633;4210.831566737296;4212.620864122183;4735;4794.328793968847;4800.423949126058;4809.398825146856;4828.903421931542;4180.205760905418;4229.7250678706405;4239.491261048694;4265.210935976854;4265.291539872203;2601.0766178006916;2695.9460810783676;2899.7825163112852;2914.635670541182;2916.5916771651987;5078.542931136141;5130.153524668388;5136.767175877837;5155.484451554815;5169.896602067937;5356.544693701001;5577.9442205577425;5588.86027849307;5593.105103183471;5613.775448982076;5111.821086261963;5119.1553393690365;5144.562712169508;5148.17629179337;5159.148740457783;5431.782728690808;5445.918311225414;5451.127819548853;5474.589405794661;5485.0949593318255;5020.924686129638;5321.574274057989;5333.839984800462;5350.277712508761;5366.892662146657;5100.26046223303;5106.974465127651;5119.74401279927;5144.845654630367;5164.251183578285;3828.4448754930936;3860.652541271299;3865.8840234793;3867.941980870233;3877.495925529663;5153.613478989166;5184.922226166686;5505.779768809202;5506.174073888948;5540.390557038642;5139.640225184201;5248;5264.131418315935;5284.762185701576;5296.788128474818;5249.160134378634;5250.238715386324;5267.868303292448;5269.736513174403;5281.788728450819;4909.5090490950615;5126.256692779601;5166.354205724285;5176.4305926348825;5183.792648294026;5272.78908843642;5311.787528498817;5314.654547454403;5340.973295133499;5344.599155063308;5213.6350455467755;5216.582673386044;5217;5226.510444523293;5236.633435659467 18:20:54 INFO - PROCESS | 5396 | |5;yui.html;689.2797027106673;746.3879618712656;767.3132546370998;771.4676872957659;820.5692011693857;12040.51837926483;12079.396030198499;12270.509179632827;12319.753604927897;12541.435635396407;12657.683557911058;12737.172083814545;12829.42267597958;12841.165324253918;12844.229346239232;851.7317045130795;869.4565896314804;870.5995242188601;873.9388242823005;875.7591662292889;683.6889215407002;846.4667259626458;865.9480431174118;868.917452841979;872.5506364222431;906.1210625693067;913.4017218721748;914.2366124286195;916.2303664921465;919.4942781470164;892.2415946445534;906.1436942089728;906.302147346546;908.2098574240387;910.1080940678106;656.957297775643;659.1332397896798;666.9466442684574;668.8996650502415;670.108755355381;13032.86967130326;13040.934795325962;13082.215067096005;13083.869161308361;13090.14914030585;13071.346432678329;13085.149465284727;13265.933670331684;13394.531191408352;13405.46378144873;10193.847092293621;10415.79168416635;10428.739281518023;10537.947310263477;10633.46832658364;3353.144948038259;3399;3408.7784294020807;3421.4183588789965;3524.4537096750046;46123.53876461226;46425.303620445724;46813.53186468126;47204;47580.7620961893;9960.601575936882;10009.599616015277;10268.537915793659;10382.117520010883;10415.791684166274;18177;18287.908560457112;18345.357912473;18356;18366.632667346577;6456.451201647818;6463.870722585522;6882;6940.201876784134;7096.219415864251;3860.2279544091293;3881.223755248905;3891.630295121959;3894.3963685628773;3989.062570296036;2743.2593199835933;2848;2874.8131371460786;2875.993402309217;2886.6536015678253;503.92944987701753;515.6210185513645;527.053938180966;527.5439786190143;538.3163382504276;498.85283841266914;581.6539159200269;589.1722130406786;597.7220592424543;605.6275390634728;7981.800454988672;8058.556779377191;8247.93627228748;8380.514184132251;8523.829523409497;500.87728506515407;519.3274709251529;590.3270271890049;622.7260005597523;626.614632001316;3976.9602303977167;4167.187398457332;4192.601702838226;4241.7879106044575;4335.176316499855;55357.12500125033;55618;57170.42829571651;57319.71340143356;57407.425925741045;50926.74536627293;52012;52054.47945520572;52129.2180617291;52805.47194528082;47083.764581176874;47696.7615161922;47858;48310;49120.26319605209;8831.955840220759;8918.509481978293;8999.055099214489;9108.453492790453;9291.767705807139;31641.683583164795;31743.36513269768;31921.840390797897;32891.50662740013;33580.664193357756;37995.62004379921;40787.79606101951;41660;41923.37114943339;42849.35725964051;11219.341974077766;11255.549778009115;11358.148138889452;11378.203525753117;11429.485673144894;11430.428478576205;12084.158243029855;12161.148719589544;12406.193597416139;12564.434600442819;11309.773804523698;11504.482298296429;11530.250533715282;11568.190226684052;11571.779403926495;11293.830592540955;11673.474693638636;11834.46744896499;11854.11094167958;11925.165238433226;11273.210875238654;11334.886651133384;11486.712832178928;11616.94191529037;11691.766164676488;9330.906690933276;10005.899941000787;10012.849807253042;10245.795084098425;10513.632022879163;8934.821303573763;9224.492652903886;9326.440413575207;9339.533023348942;9489.145976862115 18:20:54 INFO - PROCESS | 5396 | __end_tp_report 18:20:54 INFO - PROCESS | 5396 | __start_cc_report 18:20:54 INFO - PROCESS | 5396 | _x_x_mozilla_cycle_collect,382 18:20:54 INFO - PROCESS | 5396 | __end_cc_report 18:20:54 INFO - PROCESS | 5396 | __startTimestamp1463620854706__endTimestamp 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | ------- Summary: start ------- 18:20:54 INFO - PROCESS | 5396 | Number of tests: 6 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | [#0] dojo.html Cycles:165 Average:4756.73 Median:4911.85 stddev:500.17 (10.2%) stddev-sans-first:474.34 18:20:54 INFO - PROCESS | 5396 | Values: 2676.7 2707.8 2719.3 2723.0 2737.3 4692.7 4698.6 4727.9 4818.6 4876.5 4697.3 4721.7 4726.5 4739.8 4818.5 4356.0 4398.7 4474.1 4474.2 4508.5 4178.6 4451.8 4464.6 4534.7 4546.8 4325.2 4326.1 4377.5 4405.9 4455.5 4383.5 4389.6 4446.6 4449.7 4462.1 4408.4 4410.2 4424.0 4461.8 4473.0 4643.8 4725.3 4744.9 4757.7 4769.3 5157.8 5163.9 5178.4 5182.6 5239.2 5061.9 5146.2 5206.6 5207.5 5216.3 4854.1 4858.9 4882.2 4892.4 4930.8 5353.8 5365.6 5366.5 5374.5 5421.5 4946.0 5011.1 5048.9 5136.2 5143.5 5048.8 5148.6 5150.5 5152.1 5190.6 5042.1 5066.9 5112.6 5130.5 5148.7 4962.9 4969.3 5079.8 5090.5 5141.4 4279.5 4285.8 4295.8 4315.3 4330.0 3753.3 3770.7 3777.8 3793.3 3801.3 4437.0 4473.4 4488.8 4536.9 4551.1 5130.9 5142.9 5183.0 5203.8 5238.4 4494.5 4513.4 4526.8 4543.6 4566.0 4534.9 4601.9 4636.5 4667.4 4672.3 4902.8 4911.9 4912.4 4916.5 4970.9 5078.2 5227.9 5228.4 5243.4 5278.3 4802.3 4839.9 4846.7 4847.8 4848.5 5057.1 5075.9 5080.9 5087.2 5118.3 4989.3 5067.7 5126.5 5137.5 5138.7 4828.8 4921.6 4942.5 5005.3 5051.7 5010.3 5013.3 5015.2 5024.8 5066.1 4837.8 4916.4 4940.5 4942.7 4972.0 5003.5 5016.3 5051.1 5057.1 5060.8 4914.1 4952.4 4965.0 4968.1 5009.7 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | [#1] ext.html Cycles:180 Average:50642.44 Median:38075.33 stddev:92314.38 (242.5%) stddev-sans-first:92496.78 18:20:54 INFO - PROCESS | 5396 | Values: 565.1 590.7 597.9 611.1 617.3 40268.2 41326.8 41365.6 41643.8 45294.3 42981.4 43813.3 43836.3 43872.0 43914.6 7878.2 7929.0 8035.3 8044.7 8047.7 7991.6 8041.6 8096.4 8105.4 8111.5 8129.4 8149.0 8150.2 8176.1 8197.1 8049.8 8107.1 8118.5 8135.2 8135.5 7939.5 8009.0 8033.6 8037.0 8084.6 39920.8 40189.0 40191.4 40200.4 40242.8 2963.9 2987.8 3049.8 3087.8 3304.2 29877.4 30422.0 30563.5 30845.0 31291.8 3423.3 3433.7 3467.9 3481.6 3516.5 278220.0 279427.0 279903.0 281186.0 282396.0 51362.0 57581.4 57741.0 57879.0 58262.0 34948.7 35725.6 61766.4 62393.0 62635.0 15499.7 15532.6 15565.0 15658.0 15685.7 11899.3 11911.3 11941.5 12005.2 12019.9 19769.2 19775.0 19890.2 19955.8 20012.8 7161.3 7254.2 7270.0 7417.7 7447.6 842.9 935.2 948.3 980.4 1042.7 29240.0 29435.4 29464.9 29823.7 29923.9 915.6 1043.0 1056.1 1063.3 1125.1 14703.4 14885.7 15144.7 15389.2 15423.4 398714.0 399668.0 400644.0 401991.0 403797.0 51292.5 51379.2 51658.5 51867.5 51978.0 1251.5 1280.7 1288.8 1315.2 1315.3 26801.3 28004.9 28014.7 28047.7 28545.9 43765.0 44132.3 44231.3 44427.8 44501.8 356426.0 359498.8 360016.0 361129.0 361509.0 26237.3 26487.1 26755.6 26818.9 27219.3 44450.8 44660.3 45344.3 45429.0 45703.8 38082.2 38097.2 38183.0 38415.8 38505.8 37338.8 37486.8 37713.0 37734.6 38068.4 32621.7 36892.4 37058.6 38005.2 38215.0 29506.4 33800.7 33883.3 33963.0 34194.8 26164.6 26370.2 26498.7 26545.2 26717.7 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | [#2] jquery.html Cycles:180 Average:23766.41 Median:2360.51 stddev:62657.87 (2654.4%) stddev-sans-first:62809.03 18:20:54 INFO - PROCESS | 5396 | Values: 376.6 380.9 388.4 394.2 402.2 15411.8 16392.8 17072.7 17129.2 17140.8 16130.4 16741.7 17083.2 17366.9 17428.3 5112.8 5240.9 5270.5 5299.5 5304.3 3678.5 5715.3 5973.4 5980.3 6106.0 4961.7 6069.1 6073.5 6078.3 6085.3 5165.5 5260.1 5272.9 5282.4 5296.7 4960.0 5247.3 5267.9 5271.8 5278.0 11809.2 12095.7 12127.4 14992.6 20049.4 1949.2 1965.7 2038.4 2043.4 2050.5 9272.3 9675.4 10097.4 12131.7 13138.0 1805.8 1860.5 1863.0 1963.2 1991.4 70323.0 72831.6 72881.0 73084.0 73166.0 10086.7 10167.1 10255.7 10260.5 10276.3 14037.7 14046.7 14101.6 14148.4 14191.3 7071.6 7377.9 7405.5 7476.3 7544.5 6913.4 6957.1 7132.6 7163.3 7164.9 4318.8 4365.7 4473.3 4508.6 4524.1 1651.8 1697.3 1775.7 1866.4 1899.2 869.2 912.4 957.8 965.2 970.0 16296.9 16390.1 16746.0 16776.5 16899.4 883.5 899.1 938.4 939.7 954.2 9189.0 9342.0 9519.7 9523.5 9564.0 364739.0 380416.0 382148.0 382685.0 385345.0 73469.0 74578.0 75228.0 75503.6 76674.6 964.2 970.3 974.2 983.5 985.6 14836.9 14852.6 14901.8 15157.3 15190.9 34179.0 34855.8 34891.5 35702.6 35971.8 44758.6 46994.5 48701.5 48987.0 49042.8 7247.3 7362.8 7476.7 7780.7 7820.1 9747.4 11315.7 11475.7 11785.4 11895.5 9899.0 10036.8 10204.3 10261.5 10490.1 9811.8 10073.7 10096.1 10312.4 10315.9 10096.5 10117.9 10286.5 10602.5 10645.7 6746.9 7175.6 7417.7 7526.2 7769.6 10367.3 10433.7 10570.9 10617.6 10786.7 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | [#3] mootools.html Cycles:180 Average:5339.04 Median:4954.67 stddev:2963.95 (59.8%) stddev-sans-first:2957.84 18:20:54 INFO - PROCESS | 5396 | Values: 1448.7 1503.5 1658.4 1808.9 1813.8 6945.0 7724.9 7826.6 8176.4 8203.5 7911.1 8053.8 8067.6 8166.8 8178.3 2267.1 2320.2 2322.9 2324.7 2330.3 2245.0 2284.7 2286.2 2296.3 2296.9 2277.0 2289.6 2293.4 2295.4 2296.2 2227.4 2245.3 2274.4 2276.7 2282.2 2227.0 2247.5 2253.4 2274.1 2274.9 8027.4 8067.6 8072.6 8080.1 8080.8 4557.8 4617.7 4714.5 4722.1 4730.1 2950.7 3069.6 3115.8 3127.1 3154.0 967.7 974.2 984.1 1000.3 1005.0 10832.5 10928.8 10980.9 11083.7 11093.9 4257.9 4336.1 4365.3 4385.8 4394.6 8758.3 8779.3 8789.8 8790.8 8811.2 4691.8 4761.7 4763.7 4766.0 4778.3 3685.2 4280.1 4391.8 4425.1 4428.3 3594.2 3611.2 3718.9 3732.5 3765.0 1093.7 1094.3 1134.6 1140.6 1146.5 901.2 912.4 924.4 927.8 942.0 5489.9 5627.3 5662.1 5757.5 5876.4 930.2 943.3 957.3 958.2 982.6 3705.7 3801.4 4112.0 4151.6 4172.1 9820.0 10099.3 10114.7 10200.2 10207.4 10067.7 10145.9 10167.8 10200.5 10206.1 7584.4 7733.4 7752.2 7755.7 7771.3 5506.1 5600.9 5621.9 5642.4 5717.6 9290.8 9378.9 9441.6 9451.2 9490.6 9356.4 9445.7 9581.7 9607.9 9697.1 5924.4 6478.4 6498.4 6637.9 6690.4 7836.2 7861.4 7865.6 7883.8 7970.5 6786.3 7026.3 7049.4 7071.6 7139.0 6983.1 7097.6 7159.6 7200.5 7218.4 5995.8 6182.4 6234.1 6342.1 6425.0 4575.7 4693.5 4780.1 4900.1 5011.4 4927.3 4982.1 5021.4 5021.6 5055.1 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | [#4] prototype.html Cycles:180 Average:4315.31 Median:4881.74 stddev:1270.71 (26.0%) stddev-sans-first:1238.18 18:20:54 INFO - PROCESS | 5396 | Values: 308.8 312.5 316.1 328.3 332.2 4926.6 5023.3 5049.1 5145.9 5157.3 4837.8 4929.5 4968.3 4969.5 4981.2 3914.8 3930.1 3931.3 3958.2 3963.0 3645.6 3947.7 3951.6 3952.9 3956.0 3800.8 3814.0 3822.4 3824.2 3827.5 3809.2 3810.0 3831.5 3834.8 3839.3 3345.8 3370.3 3371.1 3372.4 3372.7 4650.7 4805.7 4807.1 4811.1 4854.0 4331.6 4365.7 4394.1 4399.5 4405.8 5223.5 5227.2 5233.4 5259.9 5267.6 3597.8 3670.0 3687.6 3697.4 3704.4 5455.0 5464.4 5476.3 5506.4 5530.4 3809.0 3822.1 3838.8 3857.8 3859.5 3863.7 3881.2 3882.5 3894.4 3917.6 4255.2 4400.9 4415.9 4425.4 4453.6 5231.0 5231.3 5233.8 5235.7 5273.9 1257.2 1299.9 1340.6 1341.8 1347.5 812.3 842.5 845.3 848.7 850.4 4176.9 4193.9 4202.3 4210.8 4212.6 4735.0 4794.3 4800.4 4809.4 4828.9 4180.2 4229.7 4239.5 4265.2 4265.3 2601.1 2695.9 2899.8 2914.6 2916.6 5078.5 5130.2 5136.8 5155.5 5169.9 5356.5 5577.9 5588.9 5593.1 5613.8 5111.8 5119.2 5144.6 5148.2 5159.1 5431.8 5445.9 5451.1 5474.6 5485.1 5020.9 5321.6 5333.8 5350.3 5366.9 5100.3 5107.0 5119.7 5144.8 5164.3 3828.4 3860.7 3865.9 3867.9 3877.5 5153.6 5184.9 5505.8 5506.2 5540.4 5139.6 5248.0 5264.1 5284.8 5296.8 5249.2 5250.2 5267.9 5269.7 5281.8 4909.5 5126.3 5166.4 5176.4 5183.8 5272.8 5311.8 5314.7 5341.0 5344.6 5213.6 5216.6 5217.0 5226.5 5236.6 18:20:54 INFO - PROCESS | 5396 | 18:20:54 INFO - PROCESS | 5396 | [#5] yui.html Cycles:180 Average:13598.14 Median:23545.57 stddev:15683.51 (66.6%) stddev-sans-first:15697.55 18:20:54 INFO - PROCESS | 5396 | Values: 689.3 746.4 767.3 771.5 820.6 12040.5 12079.4 12270.5 12319.8 12541.4 12657.7 12737.2 12829.4 12841.2 12844.2 851.7 869.5 870.6 873.9 875.8 683.7 846.5 865.9 868.9 872.6 906.1 913.4 914.2 916.2 919.5 892.2 906.1 906.3 908.2 910.1 657.0 659.1 666.9 668.9 670.1 13032.9 13040.9 13082.2 13083.9 13090.1 13071.3 13085.1 13265.9 13394.5 13405.5 10193.8 10415.8 10428.7 10537.9 10633.5 3353.1 3399.0 3408.8 3421.4 3524.5 46123.5 46425.3 46813.5 47204.0 47580.8 9960.6 10009.6 10268.5 10382.1 10415.8 18177.0 18287.9 18345.4 18356.0 18366.6 6456.5 6463.9 6882.0 6940.2 7096.2 3860.2 3881.2 3891.6 3894.4 3989.1 2743.3 2848.0 2874.8 2876.0 2886.7 503.9 515.6 527.1 527.5 538.3 498.9 581.7 589.2 597.7 605.6 7981.8 8058.6 8247.9 8380.5 8523.8 500.9 519.3 590.3 622.7 626.6 3977.0 4167.2 4192.6 4241.8 4335.2 55357.1 55618.0 57170.4 57319.7 57407.4 50926.7 52012.0 52054.5 52129.2 52805.5 47083.8 47696.8 47858.0 48310.0 49120.3 8832.0 8918.5 8999.1 9108.5 9291.8 31641.7 31743.4 31921.8 32891.5 33580.7 37995.6 40787.8 41660.0 41923.4 42849.4 11219.3 11255.5 11358.1 11378.2 11429.5 11430.4 12084.2 12161.1 12406.2 12564.4 11309.8 11504.5 11530.3 11568.2 11571.8 11293.8 11673.5 11834.5 11854.1 11925.2 11273.2 11334.9 11486.7 11616.9 11691.8 9330.9 10005.9 10012.8 10245.8 10513.6 8934.8 9224.5 9326.4 9339.5 9489.1 18:20:54 INFO - PROCESS | 5396 | -------- Summary: end -------- 18:20:54 INFO - PROCESS | 5396 | 18:20:55 INFO - TEST-INFO | 5396: exit 0 18:20:55 INFO - TEST-OK | dromaeo_css | took 1115543ms 18:20:55 INFO - TEST-START | kraken 18:20:55 INFO - operating with platform_type : linux_ 18:20:55 INFO - Initialising browser for kraken test... 18:20:55 INFO - TEST-INFO | started process 5633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0YZy4/profile http://localhost:48288/getInfo.html) 18:20:59 INFO - PROCESS | 5633 | 18:20:59 INFO - PROCESS | 5633 | (process:5703): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:21:00 INFO - PROCESS | 5633 | __metrics Screen width/height:1600/1200 18:21:00 INFO - PROCESS | 5633 | colorDepth:24 18:21:00 INFO - PROCESS | 5633 | Browser inner width/height: 1024/697 18:21:00 INFO - PROCESS | 5633 | __metrics 18:21:00 ERROR - PROCESS | 5633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 18:21:01 INFO - TEST-INFO | 5633: exit 0 18:21:01 INFO - Browser initialized. 18:21:01 INFO - Running cycle 1/1 for kraken test... 18:21:01 INFO - TEST-INFO | started process 5754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0YZy4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:03 INFO - PROCESS | 5754 | 18:21:03 INFO - PROCESS | 5754 | (process:5816): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:21:13 INFO - PROCESS | 5754 | RSS: Main: 165089280 18:21:13 INFO - PROCESS | 5754 | 18:21:16 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48288/tests/kraken/driver.html?testName=audio-beat-detection) 18:21:17 INFO - PROCESS | 5754 | RSS: Main: 168394752 18:21:17 INFO - PROCESS | 5754 | 18:21:20 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48288/tests/kraken/driver.html?testName=audio-dft) 18:21:20 INFO - PROCESS | 5754 | RSS: Main: 168259584 18:21:20 INFO - PROCESS | 5754 | 18:21:23 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48288/tests/kraken/driver.html?testName=audio-fft) 18:21:24 INFO - PROCESS | 5754 | RSS: Main: 164610048 18:21:24 INFO - PROCESS | 5754 | 18:21:26 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48288/tests/kraken/driver.html?testName=audio-oscillator) 18:21:27 INFO - PROCESS | 5754 | RSS: Main: 164941824 18:21:27 INFO - PROCESS | 5754 | 18:21:29 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:21:30 INFO - PROCESS | 5754 | RSS: Main: 165552128 18:21:30 INFO - PROCESS | 5754 | 18:21:33 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48288/tests/kraken/driver.html?testName=imaging-darkroom) 18:21:34 INFO - PROCESS | 5754 | RSS: Main: 164782080 18:21:34 INFO - PROCESS | 5754 | 18:21:37 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48288/tests/kraken/driver.html?testName=imaging-desaturate) 18:21:38 INFO - PROCESS | 5754 | RSS: Main: 163307520 18:21:38 INFO - PROCESS | 5754 | 18:21:41 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48288/tests/kraken/driver.html?testName=json-parse-financial) 18:21:42 INFO - PROCESS | 5754 | RSS: Main: 163831808 18:21:42 INFO - PROCESS | 5754 | 18:21:43 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:21:44 INFO - PROCESS | 5754 | RSS: Main: 164274176 18:21:44 INFO - PROCESS | 5754 | 18:21:46 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:21:47 INFO - PROCESS | 5754 | RSS: Main: 165404672 18:21:47 INFO - PROCESS | 5754 | 18:21:49 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:21:50 INFO - PROCESS | 5754 | RSS: Main: 165154816 18:21:50 INFO - PROCESS | 5754 | 18:21:52 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:21:53 INFO - PROCESS | 5754 | RSS: Main: 164302848 18:21:53 INFO - PROCESS | 5754 | 18:21:56 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:21:57 INFO - PROCESS | 5754 | RSS: Main: 165355520 18:21:57 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | Cycle 1(1): loaded http://localhost:48288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48288/tests/kraken/driver.html?testName=ai-astar) 18:21:59 INFO - PROCESS | 5754 | RSS: Main: 166694912 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | __start_tp_report 18:21:59 INFO - PROCESS | 5754 | _x_x_mozilla_page_load 18:21:59 INFO - PROCESS | 5754 | _x_x_mozilla_page_load_details 18:21:59 INFO - PROCESS | 5754 | |i|pagename|runs| 18:21:59 INFO - PROCESS | 5754 | |0;ai-astar;112;113;106;113;114;113;109;113;114;112 18:21:59 INFO - PROCESS | 5754 | |1;audio-beat-detection;159;130;158;209;129;157;157;132;212;129 18:21:59 INFO - PROCESS | 5754 | |2;audio-dft;160;163;165;169;163;163;162;162;161;162 18:21:59 INFO - PROCESS | 5754 | |3;audio-fft;75;86;76;163;75;77;75;76;172;76 18:21:59 INFO - PROCESS | 5754 | |4;audio-oscillator;96;94;178;95;93;94;142;94;94;148 18:21:59 INFO - PROCESS | 5754 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;118;118;118 18:21:59 INFO - PROCESS | 5754 | |6;imaging-darkroom;149;147;148;147;147;147;148;148;148;148 18:21:59 INFO - PROCESS | 5754 | |7;imaging-desaturate;96;95;95;95;95;96;95;96;96;96 18:21:59 INFO - PROCESS | 5754 | |8;json-parse-financial;64;64;63;66;64;64;64;66;64;64 18:21:59 INFO - PROCESS | 5754 | |9;json-stringify-tinderbox;64;65;64;65;65;65;64;64;65;65 18:21:59 INFO - PROCESS | 5754 | |10;stanford-crypto-aes;84;82;85;85;82;84;85;83;137;88 18:21:59 INFO - PROCESS | 5754 | |11;stanford-crypto-ccm;148;130;144;134;144;130;129;143;152;135 18:21:59 INFO - PROCESS | 5754 | |12;stanford-crypto-pbkdf2;173;168;170;172;170;172;173;178;173;172 18:21:59 INFO - PROCESS | 5754 | |13;stanford-crypto-sha256-iterative;67;66;69;69;68;66;69;70;66;67 18:21:59 INFO - PROCESS | 5754 | __end_tp_report 18:21:59 INFO - PROCESS | 5754 | __start_cc_report 18:21:59 INFO - PROCESS | 5754 | _x_x_mozilla_cycle_collect,939 18:21:59 INFO - PROCESS | 5754 | __end_cc_report 18:21:59 INFO - PROCESS | 5754 | __startTimestamp1463620919263__endTimestamp 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | ------- Summary: start ------- 18:21:59 INFO - PROCESS | 5754 | Number of tests: 14 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.51 (2.2%) stddev-sans-first:2.67 18:21:59 INFO - PROCESS | 5754 | Values: 112.0 113.0 106.0 113.0 114.0 113.0 109.0 113.0 114.0 112.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:157.50 stddev:31.01 (19.7%) stddev-sans-first:32.89 18:21:59 INFO - PROCESS | 5754 | Values: 159.0 130.0 158.0 209.0 129.0 157.0 157.0 132.0 212.0 129.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.49 (1.5%) stddev-sans-first:2.40 18:21:59 INFO - PROCESS | 5754 | Values: 160.0 163.0 165.0 169.0 163.0 163.0 162.0 162.0 161.0 162.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:38.36 (50.5%) stddev-sans-first:39.99 18:21:59 INFO - PROCESS | 5754 | Values: 75.0 86.0 76.0 163.0 75.0 77.0 75.0 76.0 172.0 76.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:94.00 stddev:31.18 (33.2%) stddev-sans-first:32.47 18:21:59 INFO - PROCESS | 5754 | Values: 96.0 94.0 178.0 95.0 93.0 94.0 142.0 94.0 94.0 148.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:21:59 INFO - PROCESS | 5754 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 18:21:59 INFO - PROCESS | 5754 | Values: 149.0 147.0 148.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:21:59 INFO - PROCESS | 5754 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 18:21:59 INFO - PROCESS | 5754 | Values: 64.0 64.0 63.0 66.0 64.0 64.0 64.0 66.0 64.0 64.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 18:21:59 INFO - PROCESS | 5754 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:84.50 stddev:16.78 (19.9%) stddev-sans-first:17.68 18:21:59 INFO - PROCESS | 5754 | Values: 84.0 82.0 85.0 85.0 82.0 84.0 85.0 83.0 137.0 88.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:143.50 stddev:8.29 (5.8%) stddev-sans-first:8.12 18:21:59 INFO - PROCESS | 5754 | Values: 148.0 130.0 144.0 134.0 144.0 130.0 129.0 143.0 152.0 135.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:2.64 (1.5%) stddev-sans-first:2.78 18:21:59 INFO - PROCESS | 5754 | Values: 173.0 168.0 170.0 172.0 170.0 172.0 173.0 178.0 173.0 172.0 18:21:59 INFO - PROCESS | 5754 | 18:21:59 INFO - PROCESS | 5754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:1.49 (2.2%) stddev-sans-first:1.56 18:21:59 INFO - PROCESS | 5754 | Values: 67.0 66.0 69.0 69.0 68.0 66.0 69.0 70.0 66.0 67.0 18:21:59 INFO - PROCESS | 5754 | -------- Summary: end -------- 18:21:59 INFO - PROCESS | 5754 | 18:22:00 INFO - TEST-INFO | 5754: exit 0 18:22:00 INFO - TEST-OK | kraken | took 64975ms 18:22:00 INFO - SUITE-END | took 1180s 18:22:00 INFO - Completed test suite (00:19:40) 18:22:00 INFO - javascript benchmark 18:22:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6494.20782316777, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.7323267673237, 2707.783377329814, 2719.2657982344754, 2722.9863850680745, 2737.3019879930625, 4692.741899195543, 4698.64760142989, 4727.929081063787, 4818.566329030386, 4876.512348765122, 4697.271922851964, 4721.693089949151, 4726.503717109697, 4739.763011849403, 4818.494058123891, 4356.0198955235055, 4398.714083584573, 4474.082813023322, 4474.194644963905, 4508.5491450854815, 4178.623923846853, 4451.755153466558, 4464.553544645542, 4534.659900507459, 4546.795394207269, 4325.178216138924, 4326.134773045404, 4377.474703035656, 4405.867823965286, 4455.46534415869, 4383.473983122014, 4389.626881715058, 4446.57757513039, 4449.7330160190495, 4462.085272519126, 4408.426904502427, 4410.184115938529, 4423.955760442386, 4461.754603496806, 4473.038296766211, 4643.8374656886845, 4725.267583524559, 4744.881377965544, 4757.738324392157, 4769.332293478916, 5157.8452646420665, 5163.948360516384, 5178.430372659004, 5182.611304152204, 5239.187925871496, 5061.924071138936, 5146.176611742141, 5206.609504287194, 5207.4792520748, 5216.2958000669805, 4854.101991131652, 4858.902821943612, 4882.2432522959, 4892.412910450768, 4930.77811498487, 5353.785848566014, 5365.597580181424, 5366.463353664681, 5374.462553744673, 5421.484958928895, 4945.975270123627, 5011.123053465629, 5048.899022019539, 5136.1525348317855, 5143.537081662668, 5048.848534543969, 5148.56237219833, 5150.48495150482, 5152.0726269271145, 5190.55880250183, 5042.117629414838, 5066.873328166826, 5112.6421150519855, 5130.538251557377, 5148.742562871917, 4962.8759281018265, 4969.254611808257, 5079.847604571869, 5090.541851233407, 5141.408737995103, 4279.507856596469, 4285.849995250152, 4295.8496452624, 4315.3095504719095, 4330.025744207528, 3753.3431649461236, 3770.6606405423645, 3777.8111094445167, 3793.279276937373, 3801.3157631626573, 4437.0460351024685, 4473.4408198975125, 4488.753118578509, 4536.8638940831825, 4551.112533056088, 5130.87172820675, 5142.897142057138, 5182.974085129626, 5203.843884683465, 5238.423773384925, 4494.4606647202545, 4513.390692256503, 4526.79629416677, 4543.636509079266, 4566.0, 4534.909301813946, 4601.907961840811, 4636.5131661175765, 4667.439907211088, 4672.322513235562, 4902.828401005948, 4911.852644420673, 4912.410510738591, 4916.459189489225, 4970.900581988412, 5078.21287700407, 5227.895442091213, 5228.3987341454695, 5243.449437808975, 5278.313819203479, 4802.327674125555, 4839.903201936012, 4846.684965477232, 4847.757612119451, 4848.515148485264, 5057.140286151437, 5075.87310317245, 5080.898382032265, 5087.186050231945, 5118.3090282811345, 4989.25161225819, 5067.746612669278, 5126.53861152498, 5137.537621614073, 5138.717370544656, 4828.806847726051, 4921.63087768426, 4942.5304596063315, 5005.349304590525, 5051.696898186121, 5010.298558201927, 5013.2981382607195, 5015.247712842956, 5024.824131155392, 5066.113430149635, 4837.830675926326, 4916.434610019751, 4940.456549779449, 4942.703437793743, 4972.0, 5003.524665156804, 5016.297718319511, 5051.1160546904875, 5057.064443078042, 5060.84817455477, 4914.115459217375, 4952.356193694796, 4965.0318187953, 4968.056069346812, 5009.699418034929], "value": 4724.97547755227, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.1268789719883, 590.6898878089, 597.880423915217, 611.0864257934386, 617.2592888533759, 40268.1946361073, 41326.793366033125, 41365.58634413655, 41643.79178104113, 45294.32058519116, 42981.35527967083, 43813.34279985803, 43836.34245486312, 43872.0, 43914.56085439145, 7878.172791856859, 7928.9603551982445, 8035.316998055172, 8044.6782128714785, 8047.718329858456, 7991.600419979007, 8041.597920104001, 8096.352291816641, 8105.432619716622, 8111.513309201438, 8129.430939834214, 8148.959255203716, 8150.184981501832, 8176.059753128407, 8197.05733840607, 8049.798755031113, 8107.148749381289, 8118.512889226666, 8135.186481351877, 8135.511869287861, 7939.483933544301, 8009.038915330198, 8033.598320084031, 8037.0, 8084.636191371403, 39920.80039599812, 40189.0, 40191.397129043085, 40200.39699404511, 40242.79878600618, 2963.866626001835, 2987.7543732609715, 3049.7560195184333, 3087.768417368684, 3304.2235074757414, 29877.40245195084, 30422.0, 30563.541546876815, 30845.0, 31291.843540782378, 3423.3495635829113, 3433.725301975836, 3467.8959631211105, 3481.619012253992, 3516.542849429558, 278220.0, 279427.0, 279903.0, 281186.0, 282396.0, 51362.0, 57581.424185757605, 57741.0, 57879.0, 58262.0, 34948.65051349505, 35725.64274357275, 61766.38233617696, 62393.0, 62635.0, 15499.690006199813, 15532.611684707746, 15565.0, 15658.0, 15685.686286274438, 11899.286042837457, 11911.344876031728, 11941.462634181482, 12005.219660722025, 12019.87980120205, 19769.209231630863, 19775.0, 19890.204391824165, 19955.800441995394, 20012.799872001386, 7161.319674630901, 7254.202037775841, 7270.0, 7417.703291868373, 7447.5531468111, 842.9030661474009, 935.209747763139, 948.2887834124407, 980.4362491567377, 1042.6976176908763, 29240.0, 29435.411291774046, 29464.852675736915, 29823.701762982528, 29923.850380748394, 915.6154415145655, 1042.9530671119817, 1056.144522936424, 1063.2875973098044, 1125.1111621818673, 14703.41186352534, 14885.70228595422, 15144.697106057818, 15389.230538473255, 15423.383064677511, 398714.0, 399668.0, 400644.0, 401991.0, 403797.0, 51292.48707512952, 51379.22931156035, 51658.48341516537, 51867.48132518702, 51978.0, 1251.5306759965013, 1280.6926337679076, 1288.8002359634272, 1315.2174456198547, 1315.3226088564397, 26801.329966750207, 28004.85997569999, 28014.719852801212, 28047.71952280451, 28545.857270713514, 43765.0, 44132.33801492916, 44231.33652995143, 44427.77786111049, 44501.777491112334, 356426.0, 359498.81002380326, 360016.0, 361129.0, 361509.0, 26237.34406639773, 26487.07295244657, 26755.598666019636, 26818.865905670347, 27219.31951701144, 44450.77774611106, 44660.33009504925, 45344.31983520316, 45429.0, 45703.77148114238, 38082.2383552333, 38097.23805523929, 38183.0, 38415.807920960215, 38505.807470963584, 37338.81330593438, 37486.812565937, 37713.0, 37734.62265377311, 38068.42897356597, 32621.673783261864, 36892.446613300286, 37058.629413705516, 38005.23989520139, 38215.0, 29506.409871802873, 33800.66199337975, 33883.3223335527, 33963.0, 34194.82902585471, 26164.60753088743, 26370.20889373322, 26498.735012649628, 26545.203643890713, 26717.732822671525], "value": 18361.066554710113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.64595280436373, 380.89525380520354, 388.39022734307133, 394.2391185012924, 402.19360182833435, 15411.768823467657, 16392.75410868838, 17072.743908841363, 17129.229184686686, 17140.82859171408, 16130.435434759785, 16741.665166696657, 17083.231254593542, 17366.913165434155, 17428.3028678853, 5112.821051263198, 5240.895182096356, 5270.49930256625, 5299.5230429261355, 5304.257403963448, 3678.5401824771902, 5715.2855893013375, 5973.432523910222, 5980.31226408962, 6106.0, 4961.702297862122, 6069.059295809135, 6073.51411887048, 6078.331383547807, 6085.330613632497, 5165.457626949173, 5260.079486089919, 5272.866333738265, 5282.445343238962, 5296.735163241842, 4960.0, 5247.291615631879, 5267.868303292448, 5271.841844744664, 5277.973610131925, 11809.23239989398, 12095.697607559794, 12127.39363031845, 14992.550223493312, 20049.398518044483, 1949.1618604000273, 1965.665836807732, 2038.3986723916332, 2043.4176259765895, 2050.487378155461, 9272.258219342504, 9675.419474831462, 10097.394156350643, 12131.73999420969, 13138.014648901275, 1805.8013618501955, 1860.4697661166504, 1862.962740745191, 1963.2441510018602, 1991.4025792262264, 70323.0, 72831.63584182045, 72880.99999999948, 73084.0, 73166.0, 10086.697399078039, 10167.135793457492, 10255.7436064099, 10260.486975651187, 10276.280660353854, 14037.71924561503, 14046.735793778405, 14101.576952691436, 14148.434062637585, 14191.290435478184, 7071.646417679199, 7377.852442951111, 7405.481616286808, 7476.3271305581675, 7544.471886967969, 6913.3777959983845, 6957.130358705162, 7132.643367831588, 7163.283671632795, 7164.856702866018, 4318.827246910088, 4365.716228445141, 4473.329000649928, 4508.571685689854, 4524.072565124142, 1651.7852679151633, 1697.3210715713567, 1775.7336399540172, 1866.449397427762, 1899.2497963304418, 869.2003356911656, 912.3567884641312, 957.7844984878346, 965.1988849255101, 969.9960540840196, 16296.940698854536, 16390.098544580163, 16746.0, 16776.496705098867, 16899.408520701716, 883.4875772052194, 899.0919171636695, 938.3853575907791, 939.7039932421266, 954.2270760683869, 9188.95405522968, 9341.953290233505, 9519.666811661558, 9523.476208808583, 9564.04359564052, 364739.0, 380416.0, 382148.0, 382685.0, 385345.0, 73469.0, 74578.0, 75228.0, 75503.62248188833, 76674.61662691651, 964.2189826240767, 970.2674480767117, 974.1914211204684, 983.5131609853169, 985.6303886042734, 14836.925815370854, 14852.554423367315, 14901.776473353126, 15157.32119869478, 15190.924045379703, 34179.0, 34855.82572087225, 34891.4766278501, 35702.642973569935, 35971.82014089913, 44758.55241447544, 46994.53005469902, 48701.512984869696, 48987.0, 49042.75478622584, 7247.311505406978, 7362.815929601803, 7476.700931962878, 7780.727674531364, 7820.061592608923, 9747.3664211826, 11315.717107072389, 11475.655730328104, 11785.351805650429, 11895.464704088165, 9899.0, 10036.849447258151, 10204.285700001226, 10261.486925653837, 10490.05589496949, 9811.754706132404, 10073.748156296151, 10096.141827944706, 10312.432816195182, 10315.896841031494, 10096.495175241062, 10117.898821011695, 10286.485675716334, 10602.522886469973, 10645.680629581126, 6746.8650626988165, 7175.605341706257, 7417.740379086706, 7526.172121066787, 7769.572673503011, 10367.274290799873, 10433.686989390331, 10570.894291057299, 10617.575296988343, 10786.730331741455], "value": 8215.598436304312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.6668066344741, 1503.5339044896084, 1658.3781082094208, 1808.9095545222751, 1813.8186181381864, 6945.0, 7724.922750772497, 7826.5695386753705, 8176.427650064498, 8203.548804815733, 7911.129775724666, 8053.838923221532, 8067.556284404355, 8166.754997350089, 8178.263956243937, 2267.0931627349028, 2320.153144102399, 2322.8606283622953, 2324.7094113235844, 2330.33585428153, 2245.0, 2284.680144779732, 2286.199830059474, 2296.2881506732965, 2296.873671948042, 2276.9658455123185, 2289.599320118981, 2293.415179129328, 2295.357299956015, 2296.2307626944994, 2227.409736419842, 2245.3376254004943, 2274.351809734226, 2276.6698828669914, 2282.2240438251074, 2227.042371780134, 2247.4830788918475, 2253.4141123307895, 2274.056266649355, 2274.8976296066553, 8027.438079334449, 8067.556284404355, 8072.636731347104, 8080.070791858952, 8080.797980050487, 4557.817687292504, 4617.746023968681, 4714.504976977437, 4722.126406614787, 4730.101280756645, 2950.734433900938, 3069.6009518762417, 3115.79747316426, 3127.1400364899605, 3153.984230078835, 967.6758285974137, 974.2303580171656, 984.0651381187901, 1000.2548101664233, 1004.9899501004969, 10832.512536935857, 10928.836067458995, 10980.890191098066, 11083.72290692731, 11093.889061109367, 4257.850975215914, 4336.089421221515, 4365.2797288447055, 4385.846495372647, 4394.604485596312, 8758.2993360531, 8779.29765618749, 8789.780255493664, 8790.824183516293, 8811.20699137068, 4691.7888695008805, 4761.6904901181315, 4763.73799441034, 4766.0, 4778.283257511401, 3685.207680348738, 4280.07978284664, 4391.824327026947, 4425.114977004612, 4428.269335559661, 3594.155373487228, 3611.2416392557334, 3718.8698395556025, 3732.4774531565604, 3765.002274397287, 1093.6718984304837, 1094.3215206571977, 1134.5802053240354, 1140.6007897235902, 1146.4668928947913, 901.2159421303508, 912.4069354919355, 924.4129977464224, 927.7912469694264, 942.0344147248987, 5489.890202195934, 5627.268455100811, 5662.065759149777, 5757.5030492072365, 5876.44173803488, 930.223263574909, 943.306669597845, 957.2820384711466, 958.2334132693957, 982.5529384130203, 3705.7035437164964, 3801.4297855321925, 4111.97944010284, 4151.647109995684, 4172.102997855475, 9819.950900245596, 10099.293049486465, 10114.696559103239, 10200.23498237635, 10207.438590877573, 10067.69796906094, 10145.94927025375, 10167.847482287623, 10200.540975656113, 10206.081452669147, 7584.4311676624475, 7733.41999350051, 7752.186020467882, 7755.72854950074, 7771.339436147878, 5506.146547285177, 5600.915986260128, 5621.8594535136945, 5642.407547207484, 5717.628354157133, 9290.814183716422, 9378.859317110386, 9441.575129119068, 9451.243900487807, 9490.620375184915, 9356.4386136832, 9445.716628501155, 9581.664641737505, 9607.90392096098, 9697.078777516124, 5924.437178468039, 6478.352164783672, 6498.350164983463, 6637.933620663925, 6690.431313338421, 7836.216378362118, 7861.410394220342, 7865.646045927832, 7883.84232315339, 7970.4819186752675, 6786.321367863372, 7026.262242464672, 7049.365557099885, 7071.646417679199, 7139.0, 6983.057287266154, 7097.574145551283, 7159.642017899188, 7200.459965502713, 7218.3503484686635, 5995.760169593167, 6182.381761823782, 6234.127222188988, 6342.080398342307, 6425.036244563166, 4575.702579332333, 4693.483716791082, 4780.139574876555, 4900.093482705711, 5011.373578302712, 4927.260910863399, 4982.078315511642, 5021.44764075944, 5021.623378246573, 5055.064813009605], "value": 4322.999220937222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.8023664854492, 312.546807129662, 316.14009893090787, 328.31054784951607, 332.1712327742283, 4926.605871530269, 5023.271625614293, 5049.091163590552, 5145.922811157836, 5157.277981082647, 4837.758112094399, 4929.4824043475455, 4968.2547617857335, 4969.453360130383, 4981.203007518798, 3914.8042597870135, 3930.113545498148, 3931.2727145478034, 3958.1885713428824, 3963.0290578808163, 3645.5989841117457, 3947.664448521879, 3951.6245956634075, 3952.861649842256, 3955.9802200988956, 3800.847966081353, 3814.0, 3822.3502004659135, 3824.2351529694033, 3827.4832897558754, 3809.2191100824266, 3810.0093975566274, 3831.482749828793, 3834.8082595870096, 3839.3281175794123, 3345.7992520448606, 3370.3090866372336, 3371.106656735967, 3372.4098282800655, 3372.7470439716876, 4650.7442090685, 4805.711657300573, 4807.134715751164, 4811.061842940593, 4853.975730121362, 4331.631811296043, 4365.650747940157, 4394.143142087294, 4399.450068741407, 4405.779711014468, 5223.503767142153, 5227.151202594595, 5233.398159211702, 5259.947400525984, 5267.604929630293, 3597.7661452005536, 3669.9633003669887, 3687.557493100818, 3697.4268988306853, 3704.370257056307, 5454.972725136388, 5464.4262352452815, 5476.288082549283, 5506.356948664664, 5530.419305972895, 3808.9809550952623, 3822.0827001519433, 3838.808059597009, 3857.8263978121054, 3859.459675645412, 3863.7102217333813, 3881.243157584244, 3882.514685664292, 3894.3768996960353, 3917.5886531914307, 4255.1915136124035, 4400.867973960786, 4415.933760993587, 4425.424694789656, 4453.55464453552, 5230.973845130826, 5231.3199284092825, 5233.764480598382, 5235.659682120726, 5273.945210957747, 1257.1577043380958, 1299.9025073119553, 1340.5856821053687, 1341.8322709661293, 1347.4946894914408, 812.29736278119, 842.5281842168405, 845.2519520224646, 848.7396216618317, 850.4387104510993, 4176.895577610584, 4193.916121677549, 4202.327627579633, 4210.831566737296, 4212.620864122183, 4735.0, 4794.328793968847, 4800.423949126058, 4809.398825146856, 4828.903421931542, 4180.205760905418, 4229.7250678706405, 4239.491261048694, 4265.210935976854, 4265.291539872203, 2601.0766178006916, 2695.9460810783676, 2899.7825163112852, 2914.635670541182, 2916.5916771651987, 5078.542931136141, 5130.153524668388, 5136.767175877837, 5155.484451554815, 5169.896602067937, 5356.544693701001, 5577.9442205577425, 5588.86027849307, 5593.105103183471, 5613.775448982076, 5111.821086261963, 5119.1553393690365, 5144.562712169508, 5148.17629179337, 5159.148740457783, 5431.782728690808, 5445.918311225414, 5451.127819548853, 5474.589405794661, 5485.0949593318255, 5020.924686129638, 5321.574274057989, 5333.839984800462, 5350.277712508761, 5366.892662146657, 5100.26046223303, 5106.974465127651, 5119.74401279927, 5144.845654630367, 5164.251183578285, 3828.4448754930936, 3860.652541271299, 3865.8840234793, 3867.941980870233, 3877.495925529663, 5153.613478989166, 5184.922226166686, 5505.779768809202, 5506.174073888948, 5540.390557038642, 5139.640225184201, 5248.0, 5264.131418315935, 5284.762185701576, 5296.788128474818, 5249.160134378634, 5250.238715386324, 5267.868303292448, 5269.736513174403, 5281.788728450819, 4909.5090490950615, 5126.256692779601, 5166.354205724285, 5176.4305926348825, 5183.792648294026, 5272.78908843642, 5311.787528498817, 5314.654547454403, 5340.973295133499, 5344.599155063308, 5213.6350455467755, 5216.582673386044, 5217.0, 5226.510444523293, 5236.633435659467], "value": 3912.7240445839016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.2797027106673, 746.3879618712656, 767.3132546370998, 771.4676872957659, 820.5692011693857, 12040.51837926483, 12079.396030198499, 12270.509179632827, 12319.753604927897, 12541.435635396407, 12657.683557911058, 12737.172083814545, 12829.42267597958, 12841.165324253918, 12844.229346239232, 851.7317045130795, 869.4565896314804, 870.5995242188601, 873.9388242823005, 875.7591662292889, 683.6889215407002, 846.4667259626458, 865.9480431174118, 868.917452841979, 872.5506364222431, 906.1210625693067, 913.4017218721748, 914.2366124286195, 916.2303664921465, 919.4942781470164, 892.2415946445534, 906.1436942089728, 906.302147346546, 908.2098574240387, 910.1080940678106, 656.957297775643, 659.1332397896798, 666.9466442684574, 668.8996650502415, 670.108755355381, 13032.86967130326, 13040.934795325962, 13082.215067096005, 13083.869161308361, 13090.14914030585, 13071.346432678329, 13085.149465284727, 13265.933670331684, 13394.531191408352, 13405.46378144873, 10193.847092293621, 10415.79168416635, 10428.739281518023, 10537.947310263477, 10633.46832658364, 3353.144948038259, 3399.0, 3408.7784294020807, 3421.4183588789965, 3524.4537096750046, 46123.53876461226, 46425.303620445724, 46813.53186468126, 47204.0, 47580.7620961893, 9960.601575936882, 10009.599616015277, 10268.537915793659, 10382.117520010883, 10415.791684166274, 18177.0, 18287.908560457112, 18345.357912473, 18356.0, 18366.632667346577, 6456.451201647818, 6463.870722585522, 6882.0, 6940.201876784134, 7096.219415864251, 3860.2279544091293, 3881.223755248905, 3891.630295121959, 3894.3963685628773, 3989.062570296036, 2743.2593199835933, 2848.0, 2874.8131371460786, 2875.993402309217, 2886.6536015678253, 503.92944987701753, 515.6210185513645, 527.053938180966, 527.5439786190143, 538.3163382504276, 498.85283841266914, 581.6539159200269, 589.1722130406786, 597.7220592424543, 605.6275390634728, 7981.800454988672, 8058.556779377191, 8247.93627228748, 8380.514184132251, 8523.829523409497, 500.87728506515407, 519.3274709251529, 590.3270271890049, 622.7260005597523, 626.614632001316, 3976.9602303977167, 4167.187398457332, 4192.601702838226, 4241.7879106044575, 4335.176316499855, 55357.12500125033, 55618.0, 57170.42829571651, 57319.71340143356, 57407.425925741045, 50926.74536627293, 52012.0, 52054.47945520572, 52129.2180617291, 52805.47194528082, 47083.764581176874, 47696.7615161922, 47858.0, 48310.0, 49120.26319605209, 8831.955840220759, 8918.509481978293, 8999.055099214489, 9108.453492790453, 9291.767705807139, 31641.683583164795, 31743.36513269768, 31921.840390797897, 32891.50662740013, 33580.664193357756, 37995.62004379921, 40787.79606101951, 41660.0, 41923.37114943339, 42849.35725964051, 11219.341974077766, 11255.549778009115, 11358.148138889452, 11378.203525753117, 11429.485673144894, 11430.428478576205, 12084.158243029855, 12161.148719589544, 12406.193597416139, 12564.434600442819, 11309.773804523698, 11504.482298296429, 11530.250533715282, 11568.190226684052, 11571.779403926495, 11293.830592540955, 11673.474693638636, 11834.46744896499, 11854.11094167958, 11925.165238433226, 11273.210875238654, 11334.886651133384, 11486.712832178928, 11616.94191529037, 11691.766164676488, 9330.906690933276, 10005.899941000787, 10012.849807253042, 10245.795084098425, 10513.632022879163, 8934.821303573763, 9224.492652903886, 9326.440413575207, 9339.533023348942, 9489.145976862115], "value": 6221.679281275664, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 106.0, 113.0, 114.0, 113.0, 109.0, 113.0, 114.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 158.0, 209.0, 129.0, 157.0, 157.0, 132.0, 212.0, 129.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 165.0, 169.0, 163.0, 163.0, 162.0, 162.0, 161.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 86.0, 76.0, 163.0, 75.0, 77.0, 75.0, 76.0, 172.0, 76.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 178.0, 95.0, 93.0, 94.0, 142.0, 94.0, 94.0, 148.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 66.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 85.0, 85.0, 82.0, 84.0, 85.0, 83.0, 137.0, 88.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 130.0, 144.0, 134.0, 144.0, 130.0, 129.0, 143.0, 152.0, 135.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 170.0, 172.0, 170.0, 172.0, 173.0, 178.0, 173.0, 172.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 69.0, 68.0, 66.0, 69.0, 70.0, 66.0, 67.0], "value": 67.7, "unit": "score"}]}]} 18:22:00 INFO - Return code: 0 18:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:22:01 ERROR - # TBPL SUCCESS # 18:22:01 INFO - Running post-action listener: _resource_record_post_action 18:22:01 INFO - ##### 18:22:01 INFO - ##### Finished run-tests step (success) 18:22:01 INFO - ##### 18:22:01 INFO - Running post-run listener: _resource_record_post_run 18:22:01 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533032960; Read time: 8; Write time: 515840 18:22:01 INFO - TinderboxPrint: CPU usage
13.4% 18:22:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:22:01 INFO - TinderboxPrint: I/O write bytes / time
533,032,960 / 515,840 18:22:01 INFO - TinderboxPrint: CPU idle
8,273.0 (86.5%) 18:22:01 INFO - TinderboxPrint: CPU user
1,229.8 (12.9%) 18:22:01 INFO - TinderboxPrint: Swap in / out
0 / 0 18:22:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236744704; Read time: 0; Write time: 319488 18:22:01 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296288256; Read time: 8; Write time: 196352 18:22:01 INFO - Running post-run listener: _upload_blobber_files 18:22:01 INFO - Blob upload gear active. 18:22:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:22:01 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 18:22:01 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'] 18:22:01 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 18:22:02 INFO - (blobuploader) - INFO - Open directory for files ... 18:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:07 INFO - (blobuploader) - INFO - Done attempting. 18:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:08 INFO - (blobuploader) - INFO - Done attempting. 18:22:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:22:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:08 INFO - (blobuploader) - INFO - Done attempting. 18:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 18:22:09 INFO - Return code: 0 18:22:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:22:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:22:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37ce69ce393f43b45423fcd398d307c78975878c1e18fed73675c8ac955ca2520cdcb015213ce5b7c7e537cb94c84625ffa5edab92b422aa4eebaaa3f2895005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60619b8b451049c90287527fd46f6f96b70014ffd71e72b7c86df30a55c4ade92d92d21ed2c0aebaf955bb8c64c90cf22cba15036c71e1c468a376ca50edb3d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9c7f8d59c9b910d8c67c77f158ddaea913f38e371c1439a1fdf6f36a59af728f2e330539eb3018d65b5bad56b925ef7ad7e03dd27af1419509c70a4555fcdb4"} 18:22:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:22:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:22:09 INFO - Contents: 18:22:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37ce69ce393f43b45423fcd398d307c78975878c1e18fed73675c8ac955ca2520cdcb015213ce5b7c7e537cb94c84625ffa5edab92b422aa4eebaaa3f2895005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60619b8b451049c90287527fd46f6f96b70014ffd71e72b7c86df30a55c4ade92d92d21ed2c0aebaf955bb8c64c90cf22cba15036c71e1c468a376ca50edb3d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9c7f8d59c9b910d8c67c77f158ddaea913f38e371c1439a1fdf6f36a59af728f2e330539eb3018d65b5bad56b925ef7ad7e03dd27af1419509c70a4555fcdb4"} 18:22:09 INFO - Running post-run listener: copy_logs_to_upload_dir 18:22:09 INFO - Copying logs to upload dir... 18:22:09 INFO - mkdir: /builds/slave/test/build/upload/logs 18:22:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.972963 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-18 18:22:08.569134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 18:22:08.573013) ========= 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=232498196343f89f466a4a9a000001c8-1463618524.165518-826718291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37ce69ce393f43b45423fcd398d307c78975878c1e18fed73675c8ac955ca2520cdcb015213ce5b7c7e537cb94c84625ffa5edab92b422aa4eebaaa3f2895005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60619b8b451049c90287527fd46f6f96b70014ffd71e72b7c86df30a55c4ade92d92d21ed2c0aebaf955bb8c64c90cf22cba15036c71e1c468a376ca50edb3d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9c7f8d59c9b910d8c67c77f158ddaea913f38e371c1439a1fdf6f36a59af728f2e330539eb3018d65b5bad56b925ef7ad7e03dd27af1419509c70a4555fcdb4"} build_url:https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/HiiA656fSiGxNVZOsrKubw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37ce69ce393f43b45423fcd398d307c78975878c1e18fed73675c8ac955ca2520cdcb015213ce5b7c7e537cb94c84625ffa5edab92b422aa4eebaaa3f2895005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60619b8b451049c90287527fd46f6f96b70014ffd71e72b7c86df30a55c4ade92d92d21ed2c0aebaf955bb8c64c90cf22cba15036c71e1c468a376ca50edb3d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9c7f8d59c9b910d8c67c77f158ddaea913f38e371c1439a1fdf6f36a59af728f2e330539eb3018d65b5bad56b925ef7ad7e03dd27af1419509c70a4555fcdb4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 18:22:08.597527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:22:08.597882) ========= 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=232498196343f89f466a4a9a000001c8-1463618524.165518-826718291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:22:08.682371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 18:22:08.682700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 18:22:08.682990) ========= ========= Total master_lag: 0.16 =========